builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1448074116.11 results: success (0) buildid: 20151120163003 builduid: 5a4cf3a942564e1f8d5138d4fbefba04 revision: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.115002) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.115456) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.115742) ========= 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=3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006487 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.139432) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.139732) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.175405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.175669) ========= 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=3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.227221) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.227488) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.227822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.228107) ========= 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=3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 18:48:36-- 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% 219M=0s 2015-11-20 18:48:36 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.199621 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.441456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.441757) ========= 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=3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018046 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.490784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:36.491202) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f --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=3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 18:48:36,878 truncating revision to first 12 chars 2015-11-20 18:48:36,879 Setting DEBUG logging. 2015-11-20 18:48:36,879 attempt 1/10 2015-11-20 18:48:36,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3f5afaf4e6b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 18:48:37,137 unpacking tar archive at: mozilla-central-3f5afaf4e6b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540717 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:37.044225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:37.044518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:37.054241) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:37.054515) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:37.054912) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-20 18:48:37.055216) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:48:37 INFO - MultiFileLogger online at 20151120 18:48:37 in /builds/slave/test-pgo 18:48:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:48:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:48:37 INFO - {'append_to_log': False, 18:48:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:48:37 INFO - 'blob_upload_branch': 'Firefox', 18:48:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:48:37 INFO - 'branch': 'Firefox', 18:48:37 INFO - 'buildbot_json_path': 'buildprops.json', 18:48:37 INFO - 'config_files': ('talos/linux_config.py',), 18:48:37 INFO - 'default_actions': ('clobber', 18:48:37 INFO - 'read-buildbot-config', 18:48:37 INFO - 'download-and-extract', 18:48:37 INFO - 'populate-webroot', 18:48:37 INFO - 'create-virtualenv', 18:48:37 INFO - 'install', 18:48:37 INFO - 'run-tests'), 18:48:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:48:37 INFO - 'download_minidump_stackwalk': True, 18:48:37 INFO - 'download_symbols': 'ondemand', 18:48:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:48:37 INFO - 'tooltool.py': '/tools/tooltool.py', 18:48:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:48:37 INFO - '/tools/misc-python/virtualenv.py')}, 18:48:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:48:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:48:37 INFO - 'installer_path': 'installer.exe', 18:48:37 INFO - 'log_level': 'info', 18:48:37 INFO - 'log_name': 'talos', 18:48:37 INFO - 'log_to_console': True, 18:48:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:48:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:48:37 INFO - 'opt_config_files': (), 18:48:37 INFO - 'pip_index': False, 18:48:37 INFO - 'sps_profile': False, 18:48:37 INFO - 'sps_profile_interval': 0, 18:48:37 INFO - 'suite': 'dromaeojs-e10s', 18:48:37 INFO - 'system_bits': '64', 18:48:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:48:37 INFO - 'title': 'talos-linux64-ix-067', 18:48:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:48:37 INFO - 'use_talos_json': True, 18:48:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:48:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:48:37 INFO - 'work_dir': 'build'} 18:48:37 INFO - ##### 18:48:37 INFO - ##### Running clobber step. 18:48:37 INFO - ##### 18:48:37 INFO - Running pre-action listener: _resource_record_pre_action 18:48:37 INFO - Running main action method: clobber 18:48:37 INFO - rmtree: /builds/slave/test-pgo/build 18:48:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:48:37 INFO - Running post-action listener: _resource_record_post_action 18:48:37 INFO - ##### 18:48:37 INFO - ##### Running read-buildbot-config step. 18:48:37 INFO - ##### 18:48:37 INFO - Running pre-action listener: _resource_record_pre_action 18:48:37 INFO - Running main action method: read_buildbot_config 18:48:37 INFO - Using buildbot properties: 18:48:37 INFO - { 18:48:37 INFO - "properties": { 18:48:37 INFO - "buildnumber": 554, 18:48:37 INFO - "product": "firefox", 18:48:37 INFO - "script_repo_revision": "production", 18:48:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:48:37 INFO - "repository": "", 18:48:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:48:37 INFO - "buildid": "20151120163003", 18:48:37 INFO - "slavename": "talos-linux64-ix-067", 18:48:37 INFO - "pgo_build": "True", 18:48:37 INFO - "basedir": "/builds/slave/test-pgo", 18:48:37 INFO - "project": "", 18:48:37 INFO - "platform": "ubuntu64_hw", 18:48:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:48:37 INFO - "slavebuilddir": "test", 18:48:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:48:37 INFO - "branch": "mozilla-central", 18:48:37 INFO - "repo_path": "mozilla-central", 18:48:37 INFO - "stage_platform": "linux64-pgo", 18:48:37 INFO - "builduid": "5a4cf3a942564e1f8d5138d4fbefba04", 18:48:37 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 18:48:37 INFO - }, 18:48:37 INFO - "sourcestamp": { 18:48:37 INFO - "repository": "", 18:48:37 INFO - "hasPatch": false, 18:48:37 INFO - "project": "", 18:48:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 18:48:37 INFO - "changes": [ 18:48:37 INFO - { 18:48:37 INFO - "category": null, 18:48:37 INFO - "files": [ 18:48:37 INFO - { 18:48:37 INFO - "url": null, 18:48:37 INFO - "name": "https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:48:37 INFO - } 18:48:37 INFO - ], 18:48:37 INFO - "repository": "", 18:48:37 INFO - "rev": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f", 18:48:37 INFO - "who": "sendchange", 18:48:37 INFO - "when": 1448074080, 18:48:37 INFO - "number": 6691745, 18:48:37 INFO - "comments": "", 18:48:37 INFO - "project": "", 18:48:37 INFO - "at": "Fri 20 Nov 2015 18:48:00", 18:48:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 18:48:37 INFO - "revlink": "", 18:48:37 INFO - "properties": [ 18:48:37 INFO - [ 18:48:37 INFO - "buildid", 18:48:37 INFO - "20151120163003", 18:48:37 INFO - "Change" 18:48:37 INFO - ], 18:48:37 INFO - [ 18:48:37 INFO - "builduid", 18:48:37 INFO - "5a4cf3a942564e1f8d5138d4fbefba04", 18:48:37 INFO - "Change" 18:48:37 INFO - ], 18:48:37 INFO - [ 18:48:37 INFO - "pgo_build", 18:48:37 INFO - "True", 18:48:37 INFO - "Change" 18:48:37 INFO - ] 18:48:37 INFO - ], 18:48:37 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 18:48:37 INFO - } 18:48:37 INFO - ], 18:48:37 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 18:48:37 INFO - } 18:48:37 INFO - } 18:48:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:48:37 INFO - Running post-action listener: _resource_record_post_action 18:48:37 INFO - ##### 18:48:37 INFO - ##### Running download-and-extract step. 18:48:37 INFO - ##### 18:48:37 INFO - Running pre-action listener: _resource_record_pre_action 18:48:37 INFO - Running main action method: download_and_extract 18:48:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:48: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')]} 18:48:37 INFO - https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:48:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/test_packages.json 18:48:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/test_packages.json 18:48:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:48:40 INFO - Downloaded 1302 bytes. 18:48:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:48:40 INFO - Using the following test package requirements: 18:48:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:48:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:48:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:40 INFO - u'jsshell-linux-x86_64.zip'], 18:48:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:48:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:48:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:48:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:48:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:48:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:48:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:48:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:40 INFO - https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:42 INFO - Downloaded 22523661 bytes. 18:48:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:48:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:48:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:48:44 INFO - Return code: 0 18:48:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:48: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')]} 18:48:44 INFO - https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:48:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:48:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:48:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:50 INFO - Downloaded 22523661 bytes. 18:48:50 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 18:48:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:48:50 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 18:48:51 INFO - Return code: 0 18:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:51 INFO - https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:48:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:48:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:48:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:52 INFO - Downloaded 11130997 bytes. 18:48:52 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 18:48:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:48:52 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 18:48:52 INFO - Return code: 0 18:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:52 INFO - https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:48:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:48:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:48:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:54 INFO - Downloaded 57430356 bytes. 18:48:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:48:54 INFO - mkdir: /builds/slave/test-pgo/properties 18:48:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:48:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:48:54 INFO - Contents: 18:48:54 INFO - build_url:https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:48:54 INFO - Running post-action listener: _resource_record_post_action 18:48:54 INFO - Running post-action listener: set_extra_try_arguments 18:48:54 INFO - ##### 18:48:54 INFO - ##### Running populate-webroot step. 18:48:54 INFO - ##### 18:48:54 INFO - Running pre-action listener: _resource_record_pre_action 18:48:54 INFO - Running main action method: populate_webroot 18:48:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:48:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:48:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:48:54 INFO - '../fennec_ids.txt'], 18:48:54 INFO - 'tests': ['tcheck2']}, 18:48:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:48:54 INFO - '--tppagecycles', 18:48:54 INFO - '7'], 18:48:54 INFO - 'tests': ['tsvgm']}}, 18:48:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:48:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:48:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:48:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:48:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:48:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:48:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:48:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:54 INFO - 'talos_options': ['--e10s'], 18:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:48:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:54 INFO - 'tests': ['damp', 'tps']}, 18:48:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:54 INFO - 'talos_options': ['--e10s'], 18:48:54 INFO - 'tests': ['damp', 'tps']}, 18:48:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:48:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:48:54 INFO - 'other': {'tests': ['a11yr', 18:48:54 INFO - 'ts_paint', 18:48:54 INFO - 'tpaint', 18:48:54 INFO - 'sessionrestore', 18:48:54 INFO - 'sessionrestore_no_auto_restore']}, 18:48:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:48:54 INFO - 'tests': ['a11yr', 18:48:54 INFO - 'ts_paint', 18:48:54 INFO - 'tpaint', 18:48:54 INFO - 'sessionrestore', 18:48:54 INFO - 'sessionrestore_no_auto_restore']}, 18:48:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:48:54 INFO - 'tests': ['a11yr', 18:48:54 INFO - 'ts_paint', 18:48:54 INFO - 'tpaint', 18:48:54 INFO - 'sessionrestore', 18:48:54 INFO - 'sessionrestore_no_auto_restore']}, 18:48:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:48:54 INFO - 'tests': ['a11yr', 18:48:54 INFO - 'ts_paint', 18:48:54 INFO - 'tpaint', 18:48:54 INFO - 'sessionrestore', 18:48:54 INFO - 'sessionrestore_no_auto_restore']}, 18:48:54 INFO - 'other_l64': {'tests': ['a11yr', 18:48:54 INFO - 'ts_paint', 18:48:54 INFO - 'tpaint', 18:48:54 INFO - 'sessionrestore', 18:48:54 INFO - 'sessionrestore_no_auto_restore']}, 18:48:54 INFO - 'other_nol64': {'tests': ['a11yr', 18:48:54 INFO - 'ts_paint', 18:48:54 INFO - 'tpaint', 18:48:54 INFO - 'sessionrestore', 18:48:54 INFO - 'sessionrestore_no_auto_restore']}, 18:48:54 INFO - 'svgr': {'tests': ['tsvgx', 18:48:54 INFO - 'tsvgr_opacity', 18:48:54 INFO - 'tart', 18:48:54 INFO - 'tscrollx', 18:48:54 INFO - 'cart']}, 18:48:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:48:54 INFO - 'tests': ['tsvgx', 18:48:54 INFO - 'tsvgr_opacity', 18:48:54 INFO - 'tart', 18:48:54 INFO - 'tscrollx', 18:48:54 INFO - 'cart']}, 18:48:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:54 INFO - 'tests': ['tp5o']}, 18:48:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:54 INFO - 'talos_options': ['--e10s'], 18:48:54 INFO - 'tests': ['tp5o']}, 18:48:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:54 INFO - 'talos_options': ['--xperf_path', 18:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:48:54 INFO - 'tests': ['tp5n']}, 18:48:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:54 INFO - 'talos_options': ['--e10s', 18:48:54 INFO - '--xperf_path', 18:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:48:54 INFO - 'tests': ['tp5n']}}, 18:48:54 INFO - 'talos.zip': {'path': '', 18:48:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:48:54 INFO - Running post-action listener: _resource_record_post_action 18:48:54 INFO - ##### 18:48:54 INFO - ##### Running create-virtualenv step. 18:48:54 INFO - ##### 18:48:54 INFO - Running pre-action listener: _resource_record_pre_action 18:48:54 INFO - Running main action method: create_virtualenv 18:48:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:48:54 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 18:48:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:48:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:48:54 INFO - Using real prefix '/usr' 18:48:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:48:54 INFO - Installing distribute.............................................................................................................................................................................................done. 18:48:56 INFO - Installing pip.................done. 18:48:56 INFO - Return code: 0 18:48:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:48: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')]} 18:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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')]} 18:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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', '--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 0x7f51d8534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191ed70>, '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 0x191fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191ffb0>, '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': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', '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 18:48:56 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 18:48:56 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 18:48:56 INFO - Using env: {'DISPLAY': ':0', 18:48:56 INFO - 'HOME': '/home/cltbld', 18:48:56 INFO - 'LANG': 'en_US.UTF-8', 18:48:56 INFO - 'LANGUAGE': 'en_US:en', 18:48:56 INFO - 'LOGNAME': 'cltbld', 18:48:56 INFO - 'MAIL': '/var/mail/cltbld', 18:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:56 INFO - 'MOZ_NO_REMOTE': '1', 18:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:56 INFO - 'NO_EM_RESTART': '1', 18:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:56 INFO - 'SHELL': '/bin/bash', 18:48:56 INFO - 'SHLVL': '1', 18:48:56 INFO - 'TERM': 'linux', 18:48:56 INFO - 'TMOUT': '86400', 18:48:56 INFO - 'USER': 'cltbld', 18:48:56 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', 18:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:56 INFO - '_': '/tools/buildbot/bin/python'} 18:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:57 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 18:48:57 INFO - Cleaning up... 18:48:57 INFO - Return code: 0 18:48:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f51d8534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191ed70>, '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 0x191fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191ffb0>, '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': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', '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 18:48:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:48:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:48:57 INFO - Using env: {'DISPLAY': ':0', 18:48:57 INFO - 'HOME': '/home/cltbld', 18:48:57 INFO - 'LANG': 'en_US.UTF-8', 18:48:57 INFO - 'LANGUAGE': 'en_US:en', 18:48:57 INFO - 'LOGNAME': 'cltbld', 18:48:57 INFO - 'MAIL': '/var/mail/cltbld', 18:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:57 INFO - 'MOZ_NO_REMOTE': '1', 18:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:57 INFO - 'NO_EM_RESTART': '1', 18:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:57 INFO - 'SHELL': '/bin/bash', 18:48:57 INFO - 'SHLVL': '1', 18:48:57 INFO - 'TERM': 'linux', 18:48:57 INFO - 'TMOUT': '86400', 18:48:57 INFO - 'USER': 'cltbld', 18:48:57 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', 18:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:57 INFO - '_': '/tools/buildbot/bin/python'} 18:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:57 INFO - Downloading/unpacking psutil>=0.7.1 18:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:48:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:48:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:48:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:59 INFO - Installing collected packages: psutil 18:48:59 INFO - Running setup.py install for psutil 18:48:59 INFO - building 'psutil._psutil_linux' extension 18:48:59 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 18:48:59 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 18:48:59 INFO - building 'psutil._psutil_posix' extension 18:48:59 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 18:48:59 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 18:48:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:59 INFO - Successfully installed psutil 18:48:59 INFO - Cleaning up... 18:48:59 INFO - Return code: 0 18:48:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:59 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 0x7f51d8534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191ed70>, '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 0x191fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191ffb0>, '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': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', '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 18:48:59 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 18:48:59 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 18:48:59 INFO - Using env: {'DISPLAY': ':0', 18:48:59 INFO - 'HOME': '/home/cltbld', 18:48:59 INFO - 'LANG': 'en_US.UTF-8', 18:48:59 INFO - 'LANGUAGE': 'en_US:en', 18:48:59 INFO - 'LOGNAME': 'cltbld', 18:48:59 INFO - 'MAIL': '/var/mail/cltbld', 18:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:59 INFO - 'MOZ_NO_REMOTE': '1', 18:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:59 INFO - 'NO_EM_RESTART': '1', 18:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:59 INFO - 'SHELL': '/bin/bash', 18:48:59 INFO - 'SHLVL': '1', 18:48:59 INFO - 'TERM': 'linux', 18:48:59 INFO - 'TMOUT': '86400', 18:48:59 INFO - 'USER': 'cltbld', 18:48:59 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', 18:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:59 INFO - '_': '/tools/buildbot/bin/python'} 18:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:49:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:49:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:49:01 INFO - Installing collected packages: mozsystemmonitor 18:49:01 INFO - Running setup.py install for mozsystemmonitor 18:49:01 INFO - Successfully installed mozsystemmonitor 18:49:01 INFO - Cleaning up... 18:49:01 INFO - Return code: 0 18:49:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:01 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 0x7f51d8534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191ed70>, '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 0x191fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191ffb0>, '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': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', '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 18:49:01 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 18:49:01 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 18:49:01 INFO - Using env: {'DISPLAY': ':0', 18:49:01 INFO - 'HOME': '/home/cltbld', 18:49:01 INFO - 'LANG': 'en_US.UTF-8', 18:49:01 INFO - 'LANGUAGE': 'en_US:en', 18:49:01 INFO - 'LOGNAME': 'cltbld', 18:49:01 INFO - 'MAIL': '/var/mail/cltbld', 18:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:01 INFO - 'MOZ_NO_REMOTE': '1', 18:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:01 INFO - 'NO_EM_RESTART': '1', 18:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 18:49:01 INFO - 'SHELL': '/bin/bash', 18:49:01 INFO - 'SHLVL': '1', 18:49:01 INFO - 'TERM': 'linux', 18:49:01 INFO - 'TMOUT': '86400', 18:49:01 INFO - 'USER': 'cltbld', 18:49:01 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', 18:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:01 INFO - '_': '/tools/buildbot/bin/python'} 18:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:01 INFO - Downloading/unpacking blobuploader==1.2.4 18:49:01 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 18:49:01 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 18:49:01 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 18:49:01 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 18:49:01 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 18:49:01 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 18:49:03 INFO - Downloading blobuploader-1.2.4.tar.gz 18:49:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:49:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:03 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 18:49:03 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 18:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:49:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:04 INFO - Downloading docopt-0.6.1.tar.gz 18:49:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:49:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:49:04 INFO - Installing collected packages: blobuploader, requests, docopt 18:49:04 INFO - Running setup.py install for blobuploader 18:49:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:49:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:49:04 INFO - Running setup.py install for requests 18:49:04 INFO - Running setup.py install for docopt 18:49:04 INFO - Successfully installed blobuploader requests docopt 18:49:04 INFO - Cleaning up... 18:49:04 INFO - Return code: 0 18:49:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:04 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 0x7f51d8534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191ed70>, '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 0x191fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191ffb0>, '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': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', '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 18:49:04 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 18:49:04 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 18:49:04 INFO - Using env: {'DISPLAY': ':0', 18:49:04 INFO - 'HOME': '/home/cltbld', 18:49:04 INFO - 'LANG': 'en_US.UTF-8', 18:49:04 INFO - 'LANGUAGE': 'en_US:en', 18:49:04 INFO - 'LOGNAME': 'cltbld', 18:49:04 INFO - 'MAIL': '/var/mail/cltbld', 18:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:04 INFO - 'MOZ_NO_REMOTE': '1', 18:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:04 INFO - 'NO_EM_RESTART': '1', 18:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 18:49:04 INFO - 'SHELL': '/bin/bash', 18:49:04 INFO - 'SHLVL': '1', 18:49:04 INFO - 'TERM': 'linux', 18:49:04 INFO - 'TMOUT': '86400', 18:49:04 INFO - 'USER': 'cltbld', 18:49:04 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', 18:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:04 INFO - '_': '/tools/buildbot/bin/python'} 18:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:49:05 INFO - Running setup.py (path:/tmp/pip-AUzL3J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:49:05 INFO - Running setup.py (path:/tmp/pip-eIkY0F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:49:05 INFO - Running setup.py (path:/tmp/pip-RKhgn9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:49:05 INFO - Running setup.py (path:/tmp/pip-xMujQq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:49:05 INFO - Running setup.py (path:/tmp/pip-H9arf9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:49:05 INFO - Running setup.py (path:/tmp/pip-IpMYcb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:49:05 INFO - Running setup.py (path:/tmp/pip-VTQjK2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:49:05 INFO - Running setup.py (path:/tmp/pip-emzpBm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:49:05 INFO - Running setup.py (path:/tmp/pip-lnynQC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:49:05 INFO - Running setup.py (path:/tmp/pip-O4MoMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:49:05 INFO - Running setup.py (path:/tmp/pip-7RNZWT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:49:05 INFO - Running setup.py (path:/tmp/pip-1voEbV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:49:06 INFO - Running setup.py (path:/tmp/pip-eqv3ON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:49:06 INFO - Running setup.py (path:/tmp/pip-EIuu8v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:49:06 INFO - Running setup.py (path:/tmp/pip-EHVIRZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:49:06 INFO - Running setup.py (path:/tmp/pip-JnvdGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:49:06 INFO - Running setup.py (path:/tmp/pip-wh8kup-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:49:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:49:06 INFO - Running setup.py install for manifestparser 18:49:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:49:06 INFO - Running setup.py install for mozcrash 18:49:06 INFO - Running setup.py install for mozdebug 18:49:06 INFO - Running setup.py install for mozdevice 18:49:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:49:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:49:06 INFO - Running setup.py install for mozfile 18:49:06 INFO - Running setup.py install for mozhttpd 18:49:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:49:06 INFO - Running setup.py install for mozinfo 18:49:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:49:07 INFO - Running setup.py install for mozInstall 18:49:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:49:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:49:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:49:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:49:07 INFO - Running setup.py install for mozleak 18:49:07 INFO - Running setup.py install for mozlog 18:49:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:49:07 INFO - Running setup.py install for moznetwork 18:49:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:49:07 INFO - Running setup.py install for mozprocess 18:49:07 INFO - Running setup.py install for mozprofile 18:49:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:49:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:49:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:49:07 INFO - Running setup.py install for mozrunner 18:49:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:49:07 INFO - Running setup.py install for mozscreenshot 18:49:07 INFO - Running setup.py install for moztest 18:49:08 INFO - Running setup.py install for mozversion 18:49:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:49:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:49:08 INFO - Cleaning up... 18:49:08 INFO - Return code: 0 18:49:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f51d8534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191ed70>, '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 0x191fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191ffb0>, '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': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', '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 18:49:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 18:49:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 18:49:08 INFO - Using env: {'DISPLAY': ':0', 18:49:08 INFO - 'HOME': '/home/cltbld', 18:49:08 INFO - 'LANG': 'en_US.UTF-8', 18:49:08 INFO - 'LANGUAGE': 'en_US:en', 18:49:08 INFO - 'LOGNAME': 'cltbld', 18:49:08 INFO - 'MAIL': '/var/mail/cltbld', 18:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:08 INFO - 'MOZ_NO_REMOTE': '1', 18:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:08 INFO - 'NO_EM_RESTART': '1', 18:49:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:49:08 INFO - 'PWD': '/builds/slave/test-pgo', 18:49:08 INFO - 'SHELL': '/bin/bash', 18:49:08 INFO - 'SHLVL': '1', 18:49:08 INFO - 'TERM': 'linux', 18:49:08 INFO - 'TMOUT': '86400', 18:49:08 INFO - 'USER': 'cltbld', 18:49:08 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', 18:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:08 INFO - '_': '/tools/buildbot/bin/python'} 18:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:49:08 INFO - Running setup.py (path:/tmp/pip-vdvXS_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:49:08 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)) 18:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:49:08 INFO - Running setup.py (path:/tmp/pip-gW1RLf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:49:08 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)) 18:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:49:08 INFO - Running setup.py (path:/tmp/pip-J9KoQH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:49:08 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)) 18:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:49:08 INFO - Running setup.py (path:/tmp/pip-Y5ww1h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:49:08 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)) 18:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:49:08 INFO - Running setup.py (path:/tmp/pip-1jUNEE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:49:08 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)) 18:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:49:08 INFO - Running setup.py (path:/tmp/pip-lb7OJd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:49:08 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)) 18:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:49:08 INFO - Running setup.py (path:/tmp/pip-uEzILU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:49:08 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)) 18:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:49:08 INFO - Running setup.py (path:/tmp/pip-jU1g23-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:49:08 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)) 18:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:49:08 INFO - Running setup.py (path:/tmp/pip-Ek1LiU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:49:09 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)) 18:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:49:09 INFO - Running setup.py (path:/tmp/pip-IFr4D_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 18:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:49:09 INFO - Running setup.py (path:/tmp/pip-R6gRSU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:49:09 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)) 18:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:49:09 INFO - Running setup.py (path:/tmp/pip-Tq82yS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:49:09 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)) 18:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:49:09 INFO - Running setup.py (path:/tmp/pip-3udDgw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:49:09 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)) 18:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:49:09 INFO - Running setup.py (path:/tmp/pip-ATgODm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:49:09 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)) 18:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:49:09 INFO - Running setup.py (path:/tmp/pip-c2fJoY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:49:09 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)) 18:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:49:09 INFO - Running setup.py (path:/tmp/pip-4Q8QP_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:49:09 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)) 18:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:49:09 INFO - Running setup.py (path:/tmp/pip-R7WPTZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:49:09 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)) 18:49:09 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)) 18:49:09 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)) 18:49:09 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)) 18:49:09 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)) 18:49:09 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)) 18:49:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:11 INFO - Downloading blessings-1.5.1.tar.gz 18:49:11 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 18:49:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:49:11 INFO - Installing collected packages: blessings 18:49:11 INFO - Running setup.py install for blessings 18:49:11 INFO - Successfully installed blessings 18:49:11 INFO - Cleaning up... 18:49:11 INFO - Return code: 0 18:49:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:49:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:49:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:49:11 INFO - Reading from file tmpfile_stdout 18:49:11 INFO - Current package versions: 18:49:11 INFO - argparse == 1.2.1 18:49:11 INFO - blessings == 1.5.1 18:49:11 INFO - blobuploader == 1.2.4 18:49:11 INFO - docopt == 0.6.1 18:49:11 INFO - manifestparser == 1.1 18:49:11 INFO - mozInstall == 1.12 18:49:11 INFO - mozcrash == 0.16 18:49:11 INFO - mozdebug == 0.1 18:49:11 INFO - mozdevice == 0.47 18:49:11 INFO - mozfile == 1.2 18:49:11 INFO - mozhttpd == 0.7 18:49:11 INFO - mozinfo == 0.9 18:49:11 INFO - mozleak == 0.1 18:49:11 INFO - mozlog == 3.0 18:49:11 INFO - moznetwork == 0.27 18:49:11 INFO - mozprocess == 0.22 18:49:11 INFO - mozprofile == 0.27 18:49:11 INFO - mozrunner == 6.11 18:49:11 INFO - mozscreenshot == 0.1 18:49:11 INFO - mozsystemmonitor == 0.0 18:49:11 INFO - moztest == 0.7 18:49:11 INFO - mozversion == 1.4 18:49:11 INFO - psutil == 3.1.1 18:49:11 INFO - requests == 1.2.3 18:49:11 INFO - wsgiref == 0.1.2 18:49:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:11 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 0x7f51d8534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191ed70>, '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 0x191fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191ffb0>, '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': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', '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 18:49:11 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 18:49:11 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 18:49:11 INFO - Using env: {'DISPLAY': ':0', 18:49:11 INFO - 'HOME': '/home/cltbld', 18:49:11 INFO - 'LANG': 'en_US.UTF-8', 18:49:11 INFO - 'LANGUAGE': 'en_US:en', 18:49:11 INFO - 'LOGNAME': 'cltbld', 18:49:11 INFO - 'MAIL': '/var/mail/cltbld', 18:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:11 INFO - 'MOZ_NO_REMOTE': '1', 18:49:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:11 INFO - 'NO_EM_RESTART': '1', 18:49:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:49:11 INFO - 'PWD': '/builds/slave/test-pgo', 18:49:11 INFO - 'SHELL': '/bin/bash', 18:49:11 INFO - 'SHLVL': '1', 18:49:11 INFO - 'TERM': 'linux', 18:49:11 INFO - 'TMOUT': '86400', 18:49:11 INFO - 'USER': 'cltbld', 18:49:11 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', 18:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:11 INFO - '_': '/tools/buildbot/bin/python'} 18:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:11 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)) 18:49:11 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)) 18:49:11 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)) 18:49:11 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)) 18:49:11 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)) 18:49:11 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)) 18:49:11 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)) 18:49:11 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)) 18:49:11 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)) 18:49:11 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)) 18:49:11 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)) 18:49:11 INFO - Cleaning up... 18:49:11 INFO - Return code: 0 18:49:11 INFO - Running post-action listener: _resource_record_post_action 18:49:11 INFO - Running post-action listener: _start_resource_monitoring 18:49:11 INFO - Starting resource monitoring. 18:49:11 INFO - ##### 18:49:11 INFO - ##### Running install step. 18:49:11 INFO - ##### 18:49:11 INFO - Running pre-action listener: _resource_record_pre_action 18:49:11 INFO - Running main action method: install 18:49:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:49:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:49:12 INFO - Reading from file tmpfile_stdout 18:49:12 INFO - Detecting whether we're running mozinstall >=1.0... 18:49:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:49:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:49:12 INFO - Reading from file tmpfile_stdout 18:49:12 INFO - Output received: 18:49:12 INFO - Usage: mozinstall [options] installer 18:49:12 INFO - Options: 18:49:12 INFO - -h, --help show this help message and exit 18:49:12 INFO - -d DEST, --destination=DEST 18:49:12 INFO - Directory to install application into. [default: 18:49:12 INFO - "/builds/slave/test-pgo"] 18:49:12 INFO - --app=APP Application being installed. [default: firefox] 18:49:12 INFO - mkdir: /builds/slave/test-pgo/build/application 18:49:12 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'] 18:49:12 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 18:49:26 INFO - Reading from file tmpfile_stdout 18:49:26 INFO - Output received: 18:49:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:49:26 INFO - Running post-action listener: _resource_record_post_action 18:49:26 INFO - ##### 18:49:26 INFO - ##### Running run-tests step. 18:49:26 INFO - ##### 18:49:26 INFO - Running pre-action listener: _resource_record_pre_action 18:49:26 INFO - Running main action method: run_tests 18:49:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:49:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:49:26 INFO - Python 2.7.3 18:49:26 INFO - Return code: 0 18:49:26 INFO - grabbing minidump binary from tooltool 18:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:26 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 0x191ed70>, '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 0x191fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191ffb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:49:26 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 18:49:26 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 18:49:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:49:26 INFO - Return code: 0 18:49:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:49:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:49:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:49:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:49:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:49:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:49:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost 18:49:26 INFO - Using env: {'DISPLAY': ':0', 18:49:26 INFO - 'HOME': '/home/cltbld', 18:49:26 INFO - 'LANG': 'en_US.UTF-8', 18:49:26 INFO - 'LANGUAGE': 'en_US:en', 18:49:26 INFO - 'LOGNAME': 'cltbld', 18:49:26 INFO - 'MAIL': '/var/mail/cltbld', 18:49:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:49:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:26 INFO - 'MOZ_NO_REMOTE': '1', 18:49:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:26 INFO - 'NO_EM_RESTART': '1', 18:49:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:49:26 INFO - 'PWD': '/builds/slave/test-pgo', 18:49:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:49:26 INFO - 'SHELL': '/bin/bash', 18:49:26 INFO - 'SHLVL': '1', 18:49:26 INFO - 'TERM': 'linux', 18:49:26 INFO - 'TMOUT': '86400', 18:49:26 INFO - 'USER': 'cltbld', 18:49:26 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990', 18:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:26 INFO - '_': '/tools/buildbot/bin/python'} 18:49:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] with output_timeout 3600 18:49:27 INFO - mozversion INFO | application_buildid: 20151120163003 18:49:27 INFO - mozversion INFO | application_changeset: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f 18:49:27 INFO - mozversion INFO | application_display_name: Nightly 18:49:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:49:27 INFO - mozversion INFO | application_name: Firefox 18:49:27 INFO - mozversion INFO | application_remotingname: firefox 18:49:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:49:27 INFO - mozversion INFO | application_vendor: Mozilla 18:49:27 INFO - mozversion INFO | application_version: 45.0a1 18:49:27 INFO - mozversion INFO | platform_buildid: 20151120163003 18:49:27 INFO - mozversion INFO | platform_changeset: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f 18:49:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:49:27 INFO - mozversion INFO | platform_version: 45.0a1 18:49:27 INFO - 2015-11-20 18:49:27,015 DEBUG : using testdate: 1448074167 18:49:27 INFO - 2015-11-20 18:49:27,015 DEBUG : actual date: 1448074167 18:49:27 INFO - 2015-11-20 18:49:27,023 INFO : starting webserver on 'localhost:36733' 18:49:27 INFO - 2015-11-20 18:49:27,024 INFO : Starting test suite talos-linux64-ix-067.e 18:49:27 INFO - 2015-11-20 18:49:27,025 INFO : Starting test dromaeo_css 18:49:27 INFO - 2015-11-20 18:49:27,025 DEBUG : operating with platform_type : linux_ 18:49:27 INFO - 2015-11-20 18:49:27,025 INFO : Initialising browser for dromaeo_css test... 18:49:27 INFO - 2015-11-20 18:49:27,040 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJCAiLA/profile http://localhost:36733/getInfo.html 18:49:32 INFO - 2015-11-20 18:49:32,248 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:49:32 INFO - 2015-11-20 18:49:32,248 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:49:32 INFO - 2015-11-20 18:49:32,248 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:49:32 INFO - 2015-11-20 18:49:32,248 DEBUG : BROWSER_OUTPUT: __metrics 18:49:33 INFO - 2015-11-20 18:49:33,255 INFO : Browser initialized. 18:49:33 INFO - 2015-11-20 18:49:33,255 INFO : Running cycle 1/1 for dromaeo_css test... 18:49:33 INFO - 2015-11-20 18:49:33,256 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJCAiLA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:49:45 INFO - 2015-11-20 18:49:45,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 141922304 18:49:45 INFO - 2015-11-20 18:49:45,093 DEBUG : BROWSER_OUTPUT: 18:50:34 INFO - 2015-11-20 18:50:34,722 DEBUG : BROWSER_OUTPUT: 1448074234718 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] 18:52:43 INFO - 2015-11-20 18:52:43,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36733/tests/dromaeo/cssquery-ext.html) 18:52:44 INFO - 2015-11-20 18:52:44,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 144855040 18:52:44 INFO - 2015-11-20 18:52:44,870 DEBUG : BROWSER_OUTPUT: 18:55:46 INFO - 2015-11-20 18:55:46,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/dromaeo/cssquery-ext.html (next: http://localhost:36733/tests/dromaeo/cssquery-jquery.html) 18:55:47 INFO - 2015-11-20 18:55:47,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 141164544 18:55:47 INFO - 2015-11-20 18:55:47,361 DEBUG : BROWSER_OUTPUT: 18:58:49 INFO - 2015-11-20 18:58:49,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36733/tests/dromaeo/cssquery-mootools.html) 18:58:49 INFO - 2015-11-20 18:58:49,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 141668352 18:58:49 INFO - 2015-11-20 18:58:49,651 DEBUG : BROWSER_OUTPUT: 19:01:51 INFO - 2015-11-20 19:01:51,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36733/tests/dromaeo/cssquery-prototype.html) 19:01:51 INFO - 2015-11-20 19:01:51,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 140963840 19:01:51 INFO - 2015-11-20 19:01:51,913 DEBUG : BROWSER_OUTPUT: 19:04:54 INFO - 2015-11-20 19:04:54,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36733/tests/dromaeo/cssquery-yui.html) 19:04:54 INFO - 2015-11-20 19:04:54,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 141430784 19:04:54 INFO - 2015-11-20 19:04:54,808 DEBUG : BROWSER_OUTPUT: 19:07:57 INFO - 2015-11-20 19:07:57,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/dromaeo/cssquery-yui.html (next: http://localhost:36733/tests/dromaeo/cssquery-dojo.html) 19:07:57 INFO - 2015-11-20 19:07:57,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 143941632 19:07:57 INFO - 2015-11-20 19:07:57,504 DEBUG : BROWSER_OUTPUT: 19:07:57 INFO - 2015-11-20 19:07:57,505 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:07:57 INFO - 2015-11-20 19:07:57,506 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:07:57 INFO - 2015-11-20 19:07:57,506 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:07:57 INFO - 2015-11-20 19:07:57,506 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:07:57 INFO - 2015-11-20 19:07:57,507 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3195.328980914008;3287.3425314937003;3304.8347582620863;3314.005798260522;3332.8333583320828;5250;5440.863978400537;5460.6177567570285;5463.125899856024;5491.258680078188;5427.701476418795;5434.375046869611;5454;5538.280023596927;5551.3893471718075;5001.624878134136;5094.7197904115255;5139.563137133348;5178.896422071556;5179.04187725272;4951.777170027357;5009.373828271466;5047.823326183584;5057.721825299607;5083.262926875601;4808.543188397097;4884.267359896008;4933.210686290176;4981.775820088086;5007.098722229997;4953.777080031371;4965.379327584052;4969.726665033421;4994.775235114393;5015.0722116408215;4911;4944.159492886218;4964.60283177345;4966.279889416014;4995.250712393134;5058.848234552969;5122.129238029544;5234.450382709837;5237.869053273661;5320.361556613231;5790.478856902899;5842.773017666295;5850.824475265749;5862.443067908542;5869.4717475427415;5867.794627188028;5909.793157239476;5910.438508341701;5912.852178695524;5926.851828704317;5326.786928522854;5419.674819510842;5452.672839629635;5484.396716361197;5547.833564993057;5859.560532959959;5867.970660146757;5900.616459930091;5906.3207731110615;5913.438223368773;5584.944150558443;5700.686462244616;5701.173329867146;5709.600327977085;5718.285214348207;5784.1034639630925;5831.883362332815;5846.181534585162;5849.766009359578;5880.970595146997;5732.140178973187;5778.94221057784;5784.2769653793275;5795.913061304083;5810;5702.7433765480655;5732.168835518826;5779.797707080232;5795.739191736382;5847.824565262964;4412.646988240933;4419.845305414295;4421.823127074946;4457.576530229623;4493.236149854532;3960.683145348365;4031.052702614883;4061.7156799023783;4066.471358723347;4089.5910408958866;5404.405515393382;5457.263269458652;5546.195801608744;5643.407442218508;5655.886882262332;5799.8550036249435;5827.79602713903;5832.24180856486;5838;5881.147233651097;5535.114381698909;5563.109902415594;5564.276644036249;5569.108942569251;5576.804811831566;4873.512648735169;4903.779329930162;4962.404511458648;4974.825881094217;5076.340075790124;5947.434993675507;5962.314333851576;5988.101784732238;5993.730282137314;6005.699715014319;5852.648841069549;5868.823935281948;5877.382874798084;5896.616719913192;5901.852453688693;5796.536277097738;5821.27234095738;5891.764329426775;5905.970470147622;5925.140854575976;5812.651240925558;5836.824895253149;5839.941600583939;5843;5868.94131058701;5665.546756259407;5814.244148260699;5848;5876.471117599436;5895.94104058954;5653.830385088454;5684.914726279027;5709.25779648643;5761.078227483583;5810.5061069809535;5732.3121225453215;5752.424757524214;5753.769849206153;5768.451997060272;5784.971075144597;5404.945950540601;5507.697076660822;5586.944130558642;5600.103983362643;5628.8874222514505;5534.833954981357;5648.322201335866;5653.745581448927;5661.320641523043;5677.5457963362005;5609.354924183771;5632.183333416713;5683.3748287687495;5699.629524080921;5729.427057294404 19:07:57 INFO - 2015-11-20 19:07:57,507 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.7031367904492;598.4733434577571;604.6644112517554;607.7113371148705;610.0330975403986;29418.117456476313;39158.804205979;39209;39410.80294598526;39458.80270598643;41965.37051944224;41980;42376;42554.148917021645;42698.573014269845;8599.269062129726;8751.081136480674;8840.646374145026;8870.911290887074;8899.24356429701;8614.612342444574;8696;8699.652013919436;8741.825163496726;8742.86885696715;8728.607212675413;8808.603612837405;8852.601632926502;8884.644614215424;8898.955505222464;8767.868481972775;8829.690960816373;8830.381873268874;8835.381523293372;8836.204741573225;8695.043545210021;8867.689630862953;8878;8884.511351875644;8894.199522043047;39408.60591394078;39804;39824;39857.80071099655;39924.800375998224;3304.9008529744146;3480.738944579167;3527.417976033951;3546.7517273790845;3706.314331848617;28910.132696019155;29607.555886661718;29628;29736.55395169074;29970.400591988255;3799.4870692456443;3816.599257078022;3861.4593956846065;3951.4270430787374;3988.561258261589;262776;263320;265064;265459;266281;41568.88233382448;41769.79115104466;58024.419755802744;58026.7098664504;58074.12888806671;41461.37807932883;41586.792066039474;41725.37411938823;41896;42056.57943420588;14368.13791172533;14526.709465810836;14533;14583.854161458461;14688.55934321972;11542.711432214093;11550.653480395433;11576;11609.30344179335;11626.53493860236;14119.740841465316;14261.358238879067;14261.85738142626;14273.64315892111;14292.499762508261;5813.244278243801;5882.794102206402;5908.9818923131825;5933.465988061095;5982.790602328898;911.4440191483322;923.4874644572327;973.5229737428609;990.1633120013577;1137.6530158301798;27779;31779.682203177672;32814.17964550858;32893.67106328954;33182.83408582942;1036.5750042482546;1038.1746511523206;1079.4602698650674;1102.5755084292605;1114.147677027075;14765.214527709846;14882.851171488146;14900.254987250812;15031;15118.09291442517;355606;360014;361671;362122;362887;51670.483295167316;52563;52579;52709.209361859605;52796.20805687918;1324.8079028541001;1337.779266421049;1350.3315858649835;1355.769519181761;1358.3887250737207;27571.86214068917;28664;28845.567316490688;28873.278168045967;28873.422531548833;45856.541434585226;46148;46169.30746038745;46187;46331;284772;287741;287954;288547;288764;27512;28014.159575212776;30998.535021975138;31288.21779455532;31590.526142108345;37708.43437348497;37958.62041379551;37961.4305785419;38973.610263897;39111;32491.675083248865;33274;34513.30973380468;35679.64320356763;40488.79755601203;36253.45619815652;36587.63412365842;37190;37261.62738372581;37577.43633845549;38893.416598750475;39115.413268800425;39269.803650981565;39386;39817;31073.533896992016;31395;33629;33725.15687107842;33762;24610.630840537047;25130.74869251357;25430.237092887244;25564;25651 19:07:57 INFO - 2015-11-20 19:07:57,509 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.2452215475651;353.6657858323885;361.11346643989003;363.1792149741583;369.5823719197307;13902.165870047804;13989.370478328474;16535.007899526023;16963.66072678547;17563.824361756393;16103.919480402581;16324.510264692048;17279.827201727978;17613.91193044036;17685.646287074283;5275.393329767068;5402.6758394496255;5404.83785486434;5438.864028399302;5445.9727701361435;5095.79616815327;5208.531232189102;5220.4779522047875;5234.92147617786;5325.387580428262;5114.693118412889;5162.045021670984;5198.220266959948;5200.817971371002;5973.1040343948325;5865.501432378253;5881.3530511643685;5885.8822823543505;5908.32054313753;5916.585838991272;4844.055409195208;4922.729249891255;5236.895262094737;5255.553277971377;5261.316028916254;12143.332116733576;12360;12384.442700078518;15987.760183597255;20361.796382036286;2038.714579958807;2105.5473073289163;2126.2451829600577;2139.9893000535053;2251.9324420267417;9694.70915872518;10808.081313088318;11374.943125284404;13064.346782660828;13454.93272533631;1782.3494424535081;1784.4914199453224;1793.9641207175914;1826.881252718569;1858.990705046466;62543;64248;64431.35568644301;64582;64928.675356622916;9964.601415943282;10058.497075146213;10068.647597334204;10158.542865571068;10215.233857460571;13136.474541018251;13298.135621184592;13300.201987880759;13353.59939201806;13363.599092027254;7266.564006159648;7393.630318484162;7415.8146046349275;7420.5547667140145;7639.815828546584;7060.258672839278;7081.575105493687;7084.681189346492;7138.857222855514;7166.247544007909;4016.9397459038137;4332.696711230184;4366.410534577792;4368.36658684489;4438.7114837535455;1788.2578729827237;1799.388208009283;1824;1831.8809277397193;1841.6777064013745;928.9907100929039;936.5364144748257;946.7491114854569;1007.7833265847878;1045.2474218562622;16469.58826029335;16549.6690066198;16943.406980755863;17350.65298694019;17606.559836003948;896.345667662597;936.7751739582587;952.2667545989549;1005.3465247589126;1008.1581879130861;9113.270938324918;9222.86165707515;9343.90656093444;9416.670416535388;9424.90575094254;501595;502815;528264;534398;535622;71206;71567;72545;75741.62129189319;77876.61061694655;1091.579741799413;1092.6558134187705;1104.282216559243;1130.3895896216115;1131.0668698323752;15764.211789410712;15807.36770529166;15929.522114336589;15973.440929567409;16322.183890805174;33771.15572110717;33992;34372.48441273333;34757.826210868785;35545.466817997236;46818.29772553482;48622;49444.50555494399;49729.75135124446;50917.23624145567;9118.133777291147;9630.662926797528;9732.902670973483;9758.268129890144;9820.901790982285;16355.34578616842;16808.495745127664;17099;17130.14349282556;17303.134843257536;14250.786238206229;14267.714645707236;14825.777613336024;15094.773578396112;15138.470153545013;2740.1231605885923;13404.396802143732;13885;13997.160170389809;14704.456032116901;14104.506342277971;14126.646833828825;14132.929335353669;14139.575812725634;14202;9152.771180720536;9252.306077044113;9323.766905827408;9333.533323333942;9341;13368.465261389825;13479.730405392034;13496.392662330023;14508.927455362656;14737.631559210677 19:07:57 INFO - 2015-11-20 19:07:57,510 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1476.188096546899;1721.388906938037;1763.4885883093903;1778.688729472342;1807.3132209760292;6149.046897730853;6216.7202475888635;6257.71840267188;7406.740764073258;7566.772996810091;7763.06843178818;7814.648340824662;7832.608369581527;7853.253940875607;7866.803329916755;2212.9889350553226;2225.9888700556558;2244.517428752818;2248.2243625949104;2250.414892128042;2238.7089678341795;2273.3975496493445;2279.760625134362;2282.9200977965775;2284.7486776454575;2164.1127137873477;2184.2355175688463;2198.1976578548793;2199.813015893651;2250.8199344052437;2265.818734501236;2288.519410923708;2290.9312720618323;2291.667708182321;2294.9426264343356;2196.7254093238344;2290.278562252885;2297.092648403871;2297.471581536256;2297.655351697242;7750.418718596072;7756.146823849372;7790.182030886732;7797.649105790197;7834.921650783476;4561.726296422192;4652.534746525354;4656.790444429975;4660.906781864378;4672.859814205545;2976.122043997026;3048.6798886116862;3091.3044564972924;3107.3629905869243;3124.5000799872137;946.2571881073393;952.4904176265734;970.631160159135;977.359829311802;989.3371441134457;10563.683089507327;10641.78716425675;10647.414392208426;10651.627193048205;10715;4027.577104404054;4060.451839001756;4078.5513593505284;4081.8571350002608;4133.648639865645;8642.611082501302;8648.610812513452;8648.870266946002;8660.826783464296;8677.6528938843;4589.655775816827;4630.6758526902795;4635.049814787961;4635.536446355405;4653.60444362233;4205.705600607989;4242.681798865097;4257.914231870853;4260.8508702195895;4264.33902745075;3375.746818988586;3397.8301084945656;3415.6072051713872;3425.811580363104;3445.13871532117;1039.8076355874186;1047.450088703437;1050.8633877596017;1057.3338796558119;1071.8606581144556;995.1491474789096;996.1234113979797;1062.0972173652333;1138.4706111657954;1280.1678908709414;6743.52795304324;6768.627725475048;6778.254392016875;6788.660566971632;6815.795526134125;1099.571167244775;1120.2158489057692;1139.658102569226;1145.2098052343856;1153.9596114136132;5577.470140336662;5600.943990560042;5633.295838020247;5634.4928956393305;5637.943620563742;8786.736397908073;8804.163604457566;9230.58462369195;9238.67664631748;9245.399049061789;9063.229625481908;9070;9078.954605227063;9081.228095611816;9130.31522635805;7042.507024508235;7129.89305160423;7147.857042859114;7171.462140339496;7213.675384607705;6597.3072827352435;6610.3720146586;6634.502412318999;6635.236947750877;6643.734250629921;7744.225577442211;8063.959680201561;8072.152423995396;8176.141505141874;8220.095789463036;8180.263776260165;8352.498850069016;8356.080831108451;8391.412601117863;8500.787480313042;6296.087067375113;6435.356464353527;6494.155759751202;6513.316101809241;6532.346765323429;6903.792886213421;7075.575465472089;7097.219305876246;7098.609576473344;7098.787036388917;6589.670516474253;6637.6349300788925;6694.397504224643;6718.7312507499155;6887.449004079562;6617.536772425884;6682.131322927989;6776.93223067763;6839.350261725128;6949.270326615632;7202.819929501595;7227.638618069181;7261.346478816932;7268.345848873415;7269.41844652416;6333.20834895638;6347.809565713036;6372.490200784019;6405.071264666504;6421.197350331208;6494.707738151889;6520.543561950618;6523.510736694861;6531.379518945692;6539.378759017885 19:07:57 INFO - 2015-11-20 19:07:57,511 DEBUG : BROWSER_OUTPUT: |4;prototype.html;310.46134955851596;320.03668956441106;322.1414929213646;324.33025801719435;326.1080943619203;6350.206224221973;6375.744970201192;6426.807195784122;6461.095446637469;6496.220453545575;6146.81559553213;6298.7165577549;6305.873882522358;6333.524985626073;6338.366163383659;4769.856904292877;4779.522047795227;4780.760961951906;4794.345950647021;4800.807967681289;4773.904521909577;4775.785089670973;4780.593649539794;4785.875319299962;4821.734804585746;4665.83669571565;4750.5724484796365;4754.429468463789;4756.7859446325;4763.642726795487;4728.40894888139;4744.0511897620445;4749.216379297429;4760.809567617292;4767.880802979918;3915.334393153171;4008.699347548916;4107.856225032109;4123.9175216495505;4128.793560321972;5997.040473524259;5997.370276121032;5997.970010149965;6023.518118550505;6032.5173986081445;5425.728713564306;5439.782408703647;5463.344398672145;5464.398916119224;5467.562594992431;6568.343165683441;6629.171353580802;6644.534882558223;6673.5662181958505;6678.866422671568;4489;4491.348754430622;4501.7974191161475;4502.57225563571;4502.6397888169195;6956.478264130211;6968.850139726888;6969.686364113576;7026.332498412643;7033.4724895633035;4483.19302525542;4490.416245888014;4491.371208030879;4491.46102467706;4512;4500.639948804088;4571.634269258451;4586.610138138229;4591.885202869955;4657.580817726421;5418.566514678816;5429.294191755047;5432.51107400328;5433.456654334614;5444.074507333763;6723.159605049369;6726.764563240361;6733.797986060426;6738.629375384401;6821.4542836572955;1629.5274370432678;1642.808963501452;1647.5057482755365;1653.7354023356206;1654.1729135432283;1053.5048527192362;1068.188176985481;1068.2468859454066;1075.5536452372335;1088.6842815583393;6508.251551071593;6541.28045914949;6553.475721942234;6570.441512471493;6572.835679107965;6929.41100006495;6970.581765094111;6997.335253150943;7007.684654190573;7017.473689473208;6419.454346380517;6513.088167656532;6513.446357059608;6548.934510654928;6550.541462097607;3792.8482860685262;3802.296575133609;3802.5817160112365;3804.6575808177395;3823.4456003879836;7099.751508697171;7182.569045857265;7186.640667966581;7189.317014883578;7208.783736487913;7153.248908864598;7160.283971602798;7214.494985350975;7215.170255420589;7221.711131554784;7076.858462830714;7203.207647158808;7234.276572342724;7279;7283.380912622486;7032;7038.859222815413;7039.612821294673;7055.964720176366;7058.505904586629;6999.160100787734;7002.2297547268745;7007.194172670208;7014.228434872262;7016.824579385556;7094.148702155568;7228.819279517844;7231.2768723127265;7314.4148468123485;7324.377427918474;4599.988002639414;4643.883902902455;4651;4654.837080702159;4669.813207471663;6902.551334163263;6939.653017349214;6958.686859091455;6970.128733908262;6974.442044636316;6725.4283385910785;6851.554648947803;6864.450843932574;6870.31296870309;6878.793636190922;6708.765193218214;6779.288174741581;6784.59292442455;6790.524663273523;6796.422304104207;6625.006249062679;6638.83402914931;6647.102641143384;6653.367930046637;6659.633720145439;6628.436582890508;6833.077534532775;6835.965820170867;6843;6876.518643694893;6638.17022872141;6644.60132392058;6670.566413183127;6682.2649508555;6707.530472867048 19:07:57 INFO - 2015-11-20 19:07:57,511 DEBUG : BROWSER_OUTPUT: |5;yui.html;706.5619316024063;707.6284950401035;760.9581473018983;765.7779244019234;782.4366456151571;13537.187768733871;13727;15398.30707618157;15623;15640.139792311418;14900.776488352683;14945.775813362809;15033.173175475344;15088.47190348338;15126.243687815593;813.2111851504061;814.9755507334775;828.7348048624442;829.0134739659816;838.5555655502593;802.1336956087412;828.6726742936537;834.4284165346727;842.5113434208145;842.5323945210406;836.7029704454923;869.1742844297911;871.3464901324007;878.3324673248313;878.7363790862747;837.4054421360842;863.8272345530919;866.4151697604156;866.6663334616155;867.9869801952975;635.034747184282;635.7806556737918;635.9491240700733;636.7675798333621;638.2373064188297;13606.931965340209;13821.170729756146;13833.239171845544;13866.237356945365;13938.93030534841;12295.200811947196;12337;12516;12556.623301300975;12968.478282596072;10079.244056695778;10318.58725650973;10439.164866810637;10552.630657926935;10903.400312982783;3543.3090547343277;3578.982105089458;3615.132368231632;3646.8541258349633;3649.7445178837493;49348.753256233846;49925.25112123321;50010.49989500095;50130.24804627933;50161;9981.351212171186;10069.848952265722;10098.899011009797;10126.898731012743;10283.228757843191;17915.37296194627;17930;17967.910160449115;17988.820111798977;18077.09614519295;6990.370866622028;7231.3130252625915;7232.240614735482;7262.17496913946;7498;4464.642828573771;4538.841140560065;4540.523245059288;4549.948568404015;4562.61217796491;3144.261098641817;3173.1591128351006;3179.6820317968018;3187.2509960159346;3209.326041531258;562.6624025584698;576.0610205365311;584.5119325363369;591.5918016568554;592.3454582686156;649.1625802714445;691.1360799001249;708.5819366573746;709.6877373955443;722.609790713009;8633.525156116348;8740.519271440131;8811.559422028873;8908.599113039929;9137.223336016514;513.1737901977813;599.6312267955263;600.8527910661916;663.1478550063146;704.17259719829;4016.377461493473;4394.36281739146;4539.72761634303;4588.908221835544;4601.378813860086;53733;56941.14588281179;57685.134722979186;58266;58287.70856145692;47227.76386118047;47241.291380629315;47575.762121189175;47890;48175.5182448178;43769;43792;45805.54194458079;46010.30984535235;47092.7645361771;8729.781755456164;8792.736217913473;8948.463092214488;8948.955255223682;9024.684136055206;35403.29193416169;35707.642923570435;36066.27867442689;36237.63762362448;36441.27117457583;46386.53613463822;46907.76546117248;47204;47441;47446.76276618595;10885.290390812652;10910.672679819618;11287.927646873533;11307.886921131012;11315.490802914053;11942.880571194177;11990.700232493908;12036.578719744766;12043.81934270969;12529.874701252871;11618.94190529042;11932.403379831147;11997.880021199677;12315.261084334968;12425.565105221274;11395.430228488709;11631.59289424866;11704.70738231551;11921.165518413627;11921.642350729491;11246.381449020382;11736.178467507192;11754.823677644672;11843.28940263587;12073.879261207276;9815.754606134904;10023.097921187129;10055.095041446304;10230.437325947145;10359.58133815824;8804.251638610789;9065.546722663708;9133.45199288045;9960.870151871646;10023.799524009624 19:07:57 INFO - 2015-11-20 19:07:57,511 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:07:57 INFO - 2015-11-20 19:07:57,511 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:07:57 INFO - 2015-11-20 19:07:57,511 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,306 19:07:57 INFO - 2015-11-20 19:07:57,512 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:07:57 INFO - 2015-11-20 19:07:57,512 DEBUG : BROWSER_OUTPUT: __startTimestamp1448075277504__endTimestamp 19:07:57 INFO - 2015-11-20 19:07:57,512 DEBUG : BROWSER_OUTPUT: 19:07:57 INFO - 2015-11-20 19:07:57,513 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:07:57 INFO - 2015-11-20 19:07:57,513 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:07:57 INFO - 2015-11-20 19:07:57,513 DEBUG : BROWSER_OUTPUT: 19:07:57 INFO - 2015-11-20 19:07:57,513 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5413.67 Median:5643.41 stddev:589.52 (10.4%) stddev-sans-first:565.06 19:07:57 INFO - 2015-11-20 19:07:57,514 DEBUG : BROWSER_OUTPUT: Values: 3195.3 3287.3 3304.8 3314.0 3332.8 5250.0 5440.9 5460.6 5463.1 5491.3 5427.7 5434.4 5454.0 5538.3 5551.4 5001.6 5094.7 5139.6 5178.9 5179.0 4951.8 5009.4 5047.8 5057.7 5083.3 4808.5 4884.3 4933.2 4981.8 5007.1 4953.8 4965.4 4969.7 4994.8 5015.1 4911.0 4944.2 4964.6 4966.3 4995.3 5058.8 5122.1 5234.5 5237.9 5320.4 5790.5 5842.8 5850.8 5862.4 5869.5 5867.8 5909.8 5910.4 5912.9 5926.9 5326.8 5419.7 5452.7 5484.4 5547.8 5859.6 5868.0 5900.6 5906.3 5913.4 5584.9 5700.7 5701.2 5709.6 5718.3 5784.1 5831.9 5846.2 5849.8 5881.0 5732.1 5778.9 5784.3 5795.9 5810.0 5702.7 5732.2 5779.8 5795.7 5847.8 4412.6 4419.8 4421.8 4457.6 4493.2 3960.7 4031.1 4061.7 4066.5 4089.6 5404.4 5457.3 5546.2 5643.4 5655.9 5799.9 5827.8 5832.2 5838.0 5881.1 5535.1 5563.1 5564.3 5569.1 5576.8 4873.5 4903.8 4962.4 4974.8 5076.3 5947.4 5962.3 5988.1 5993.7 6005.7 5852.6 5868.8 5877.4 5896.6 5901.9 5796.5 5821.3 5891.8 5906.0 5925.1 5812.7 5836.8 5839.9 5843.0 5868.9 5665.5 5814.2 5848.0 5876.5 5895.9 5653.8 5684.9 5709.3 5761.1 5810.5 5732.3 5752.4 5753.8 5768.5 5785.0 5404.9 5507.7 5586.9 5600.1 5628.9 5534.8 5648.3 5653.7 5661.3 5677.5 5609.4 5632.2 5683.4 5699.6 5729.4 19:07:57 INFO - 2015-11-20 19:07:57,514 DEBUG : BROWSER_OUTPUT: 19:07:57 INFO - 2015-11-20 19:07:57,514 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46334.49 Median:37642.94 stddev:80437.45 (213.7%) stddev-sans-first:80589.62 19:07:57 INFO - 2015-11-20 19:07:57,514 DEBUG : BROWSER_OUTPUT: Values: 544.7 598.5 604.7 607.7 610.0 29418.1 39158.8 39209.0 39410.8 39458.8 41965.4 41980.0 42376.0 42554.1 42698.6 8599.3 8751.1 8840.6 8870.9 8899.2 8614.6 8696.0 8699.7 8741.8 8742.9 8728.6 8808.6 8852.6 8884.6 8899.0 8767.9 8829.7 8830.4 8835.4 8836.2 8695.0 8867.7 8878.0 8884.5 8894.2 39408.6 39804.0 39824.0 39857.8 39924.8 3304.9 3480.7 3527.4 3546.8 3706.3 28910.1 29607.6 29628.0 29736.6 29970.4 3799.5 3816.6 3861.5 3951.4 3988.6 262776.0 263320.0 265064.0 265459.0 266281.0 41568.9 41769.8 58024.4 58026.7 58074.1 41461.4 41586.8 41725.4 41896.0 42056.6 14368.1 14526.7 14533.0 14583.9 14688.6 11542.7 11550.7 11576.0 11609.3 11626.5 14119.7 14261.4 14261.9 14273.6 14292.5 5813.2 5882.8 5909.0 5933.5 5982.8 911.4 923.5 973.5 990.2 1137.7 27779.0 31779.7 32814.2 32893.7 33182.8 1036.6 1038.2 1079.5 1102.6 1114.1 14765.2 14882.9 14900.3 15031.0 15118.1 355606.0 360014.0 361671.0 362122.0 362887.0 51670.5 52563.0 52579.0 52709.2 52796.2 1324.8 1337.8 1350.3 1355.8 1358.4 27571.9 28664.0 28845.6 28873.3 28873.4 45856.5 46148.0 46169.3 46187.0 46331.0 284772.0 287741.0 287954.0 288547.0 288764.0 27512.0 28014.2 30998.5 31288.2 31590.5 37708.4 37958.6 37961.4 38973.6 39111.0 32491.7 33274.0 34513.3 35679.6 40488.8 36253.5 36587.6 37190.0 37261.6 37577.4 38893.4 39115.4 39269.8 39386.0 39817.0 31073.5 31395.0 33629.0 33725.2 33762.0 24610.6 25130.7 25430.2 25564.0 25651.0 19:07:57 INFO - 2015-11-20 19:07:57,514 DEBUG : BROWSER_OUTPUT: 19:07:57 INFO - 2015-11-20 19:07:57,514 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28114.05 Median:17554.04 stddev:85095.81 (484.8%) stddev-sans-first:85308.99 19:07:57 INFO - 2015-11-20 19:07:57,514 DEBUG : BROWSER_OUTPUT: Values: 350.2 353.7 361.1 363.2 369.6 13902.2 13989.4 16535.0 16963.7 17563.8 16103.9 16324.5 17279.8 17613.9 17685.6 5275.4 5402.7 5404.8 5438.9 5446.0 5095.8 5208.5 5220.5 5234.9 5325.4 5114.7 5162.0 5198.2 5200.8 5973.1 5865.5 5881.4 5885.9 5908.3 5916.6 4844.1 4922.7 5236.9 5255.6 5261.3 12143.3 12360.0 12384.4 15987.8 20361.8 2038.7 2105.5 2126.2 2140.0 2251.9 9694.7 10808.1 11374.9 13064.3 13454.9 1782.3 1784.5 1794.0 1826.9 1859.0 62543.0 64248.0 64431.4 64582.0 64928.7 9964.6 10058.5 10068.6 10158.5 10215.2 13136.5 13298.1 13300.2 13353.6 13363.6 7266.6 7393.6 7415.8 7420.6 7639.8 7060.3 7081.6 7084.7 7138.9 7166.2 4016.9 4332.7 4366.4 4368.4 4438.7 1788.3 1799.4 1824.0 1831.9 1841.7 929.0 936.5 946.7 1007.8 1045.2 16469.6 16549.7 16943.4 17350.7 17606.6 896.3 936.8 952.3 1005.3 1008.2 9113.3 9222.9 9343.9 9416.7 9424.9 501595.0 502815.0 528264.0 534398.0 535622.0 71206.0 71567.0 72545.0 75741.6 77876.6 1091.6 1092.7 1104.3 1130.4 1131.1 15764.2 15807.4 15929.5 15973.4 16322.2 33771.2 33992.0 34372.5 34757.8 35545.5 46818.3 48622.0 49444.5 49729.8 50917.2 9118.1 9630.7 9732.9 9758.3 9820.9 16355.3 16808.5 17099.0 17130.1 17303.1 14250.8 14267.7 14825.8 15094.8 15138.5 2740.1 13404.4 13885.0 13997.2 14704.5 14104.5 14126.6 14132.9 14139.6 14202.0 9152.8 9252.3 9323.8 9333.5 9341.0 13368.5 13479.7 13496.4 14508.9 14737.6 19:07:57 INFO - 2015-11-20 19:07:57,515 DEBUG : BROWSER_OUTPUT: 19:07:57 INFO - 2015-11-20 19:07:57,515 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5299.48 Median:6413.13 stddev:2725.71 (42.5%) stddev-sans-first:2718.21 19:07:57 INFO - 2015-11-20 19:07:57,516 DEBUG : BROWSER_OUTPUT: Values: 1476.2 1721.4 1763.5 1778.7 1807.3 6149.0 6216.7 6257.7 7406.7 7566.8 7763.1 7814.6 7832.6 7853.3 7866.8 2213.0 2226.0 2244.5 2248.2 2250.4 2238.7 2273.4 2279.8 2282.9 2284.7 2164.1 2184.2 2198.2 2199.8 2250.8 2265.8 2288.5 2290.9 2291.7 2294.9 2196.7 2290.3 2297.1 2297.5 2297.7 7750.4 7756.1 7790.2 7797.6 7834.9 4561.7 4652.5 4656.8 4660.9 4672.9 2976.1 3048.7 3091.3 3107.4 3124.5 946.3 952.5 970.6 977.4 989.3 10563.7 10641.8 10647.4 10651.6 10715.0 4027.6 4060.5 4078.6 4081.9 4133.6 8642.6 8648.6 8648.9 8660.8 8677.7 4589.7 4630.7 4635.0 4635.5 4653.6 4205.7 4242.7 4257.9 4260.9 4264.3 3375.7 3397.8 3415.6 3425.8 3445.1 1039.8 1047.5 1050.9 1057.3 1071.9 995.1 996.1 1062.1 1138.5 1280.2 6743.5 6768.6 6778.3 6788.7 6815.8 1099.6 1120.2 1139.7 1145.2 1154.0 5577.5 5600.9 5633.3 5634.5 5637.9 8786.7 8804.2 9230.6 9238.7 9245.4 9063.2 9070.0 9079.0 9081.2 9130.3 7042.5 7129.9 7147.9 7171.5 7213.7 6597.3 6610.4 6634.5 6635.2 6643.7 7744.2 8064.0 8072.2 8176.1 8220.1 8180.3 8352.5 8356.1 8391.4 8500.8 6296.1 6435.4 6494.2 6513.3 6532.3 6903.8 7075.6 7097.2 7098.6 7098.8 6589.7 6637.6 6694.4 6718.7 6887.4 6617.5 6682.1 6776.9 6839.4 6949.3 7202.8 7227.6 7261.3 7268.3 7269.4 6333.2 6347.8 6372.5 6405.1 6421.2 6494.7 6520.5 6523.5 6531.4 6539.4 19:07:57 INFO - 2015-11-20 19:07:57,516 DEBUG : BROWSER_OUTPUT: 19:07:57 INFO - 2015-11-20 19:07:57,516 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5604.10 Median:6502.24 stddev:1744.81 (26.8%) stddev-sans-first:1703.87 19:07:57 INFO - 2015-11-20 19:07:57,516 DEBUG : BROWSER_OUTPUT: Values: 310.5 320.0 322.1 324.3 326.1 6350.2 6375.7 6426.8 6461.1 6496.2 6146.8 6298.7 6305.9 6333.5 6338.4 4769.9 4779.5 4780.8 4794.3 4800.8 4773.9 4775.8 4780.6 4785.9 4821.7 4665.8 4750.6 4754.4 4756.8 4763.6 4728.4 4744.1 4749.2 4760.8 4767.9 3915.3 4008.7 4107.9 4123.9 4128.8 5997.0 5997.4 5998.0 6023.5 6032.5 5425.7 5439.8 5463.3 5464.4 5467.6 6568.3 6629.2 6644.5 6673.6 6678.9 4489.0 4491.3 4501.8 4502.6 4502.6 6956.5 6968.9 6969.7 7026.3 7033.5 4483.2 4490.4 4491.4 4491.5 4512.0 4500.6 4571.6 4586.6 4591.9 4657.6 5418.6 5429.3 5432.5 5433.5 5444.1 6723.2 6726.8 6733.8 6738.6 6821.5 1629.5 1642.8 1647.5 1653.7 1654.2 1053.5 1068.2 1068.2 1075.6 1088.7 6508.3 6541.3 6553.5 6570.4 6572.8 6929.4 6970.6 6997.3 7007.7 7017.5 6419.5 6513.1 6513.4 6548.9 6550.5 3792.8 3802.3 3802.6 3804.7 3823.4 7099.8 7182.6 7186.6 7189.3 7208.8 7153.2 7160.3 7214.5 7215.2 7221.7 7076.9 7203.2 7234.3 7279.0 7283.4 7032.0 7038.9 7039.6 7056.0 7058.5 6999.2 7002.2 7007.2 7014.2 7016.8 7094.1 7228.8 7231.3 7314.4 7324.4 4600.0 4643.9 4651.0 4654.8 4669.8 6902.6 6939.7 6958.7 6970.1 6974.4 6725.4 6851.6 6864.5 6870.3 6878.8 6708.8 6779.3 6784.6 6790.5 6796.4 6625.0 6638.8 6647.1 6653.4 6659.6 6628.4 6833.1 6836.0 6843.0 6876.5 6638.2 6644.6 6670.6 6682.3 6707.5 19:07:57 INFO - 2015-11-20 19:07:57,516 DEBUG : BROWSER_OUTPUT: 19:07:57 INFO - 2015-11-20 19:07:57,517 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13977.48 Median:4595.14 stddev:15879.97 (345.6%) stddev-sans-first:15893.25 19:07:57 INFO - 2015-11-20 19:07:57,517 DEBUG : BROWSER_OUTPUT: Values: 706.6 707.6 761.0 765.8 782.4 13537.2 13727.0 15398.3 15623.0 15640.1 14900.8 14945.8 15033.2 15088.5 15126.2 813.2 815.0 828.7 829.0 838.6 802.1 828.7 834.4 842.5 842.5 836.7 869.2 871.3 878.3 878.7 837.4 863.8 866.4 866.7 868.0 635.0 635.8 635.9 636.8 638.2 13606.9 13821.2 13833.2 13866.2 13938.9 12295.2 12337.0 12516.0 12556.6 12968.5 10079.2 10318.6 10439.2 10552.6 10903.4 3543.3 3579.0 3615.1 3646.9 3649.7 49348.8 49925.3 50010.5 50130.2 50161.0 9981.4 10069.8 10098.9 10126.9 10283.2 17915.4 17930.0 17967.9 17988.8 18077.1 6990.4 7231.3 7232.2 7262.2 7498.0 4464.6 4538.8 4540.5 4549.9 4562.6 3144.3 3173.2 3179.7 3187.3 3209.3 562.7 576.1 584.5 591.6 592.3 649.2 691.1 708.6 709.7 722.6 8633.5 8740.5 8811.6 8908.6 9137.2 513.2 599.6 600.9 663.1 704.2 4016.4 4394.4 4539.7 4588.9 4601.4 53733.0 56941.1 57685.1 58266.0 58287.7 47227.8 47241.3 47575.8 47890.0 48175.5 43769.0 43792.0 45805.5 46010.3 47092.8 8729.8 8792.7 8948.5 8949.0 9024.7 35403.3 35707.6 36066.3 36237.6 36441.3 46386.5 46907.8 47204.0 47441.0 47446.8 10885.3 10910.7 11287.9 11307.9 11315.5 11942.9 11990.7 12036.6 12043.8 12529.9 11618.9 11932.4 11997.9 12315.3 12425.6 11395.4 11631.6 11704.7 11921.2 11921.6 11246.4 11736.2 11754.8 11843.3 12073.9 9815.8 10023.1 10055.1 10230.4 10359.6 8804.3 9065.5 9133.5 9960.9 10023.8 19:07:57 INFO - 2015-11-20 19:07:57,517 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:07:57 INFO - 2015-11-20 19:07:57,517 DEBUG : BROWSER_OUTPUT: 19:07:58 INFO - 2015-11-20 19:07:58,131 INFO : Browser exited with error code: 0 19:07:58 INFO - 2015-11-20 19:07:58,150 INFO : Completed test dromaeo_css (00:18:31) 19:07:58 INFO - 2015-11-20 19:07:58,150 INFO : Starting test kraken 19:07:58 INFO - 2015-11-20 19:07:58,150 DEBUG : operating with platform_type : linux_ 19:07:58 INFO - 2015-11-20 19:07:58,150 INFO : Initialising browser for kraken test... 19:07:58 INFO - 2015-11-20 19:07:58,156 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpln1Y62/profile http://localhost:36733/getInfo.html 19:08:02 INFO - 2015-11-20 19:08:02,696 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:08:02 INFO - 2015-11-20 19:08:02,696 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:08:02 INFO - 2015-11-20 19:08:02,697 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:08:02 INFO - 2015-11-20 19:08:02,697 DEBUG : BROWSER_OUTPUT: __metrics 19:08:03 INFO - 2015-11-20 19:08:03,707 INFO : Browser initialized. 19:08:03 INFO - 2015-11-20 19:08:03,707 INFO : Running cycle 1/1 for kraken test... 19:08:03 INFO - 2015-11-20 19:08:03,708 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpln1Y62/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:08:15 INFO - 2015-11-20 19:08:15,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 141135872 19:08:15 INFO - 2015-11-20 19:08:15,473 DEBUG : BROWSER_OUTPUT: 19:08:17 INFO - 2015-11-20 19:08:17,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36733/tests/kraken/driver.html?testName=audio-beat-detection) 19:08:18 INFO - 2015-11-20 19:08:18,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 142114816 19:08:18 INFO - 2015-11-20 19:08:18,587 DEBUG : BROWSER_OUTPUT: 19:08:21 INFO - 2015-11-20 19:08:21,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36733/tests/kraken/driver.html?testName=audio-dft) 19:08:21 INFO - 2015-11-20 19:08:21,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 142163968 19:08:21 INFO - 2015-11-20 19:08:21,835 DEBUG : BROWSER_OUTPUT: 19:08:24 INFO - 2015-11-20 19:08:24,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36733/tests/kraken/driver.html?testName=audio-fft) 19:08:25 INFO - 2015-11-20 19:08:25,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 137830400 19:08:25 INFO - 2015-11-20 19:08:25,268 DEBUG : BROWSER_OUTPUT: 19:08:27 INFO - 2015-11-20 19:08:27,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36733/tests/kraken/driver.html?testName=audio-oscillator) 19:08:27 INFO - 2015-11-20 19:08:27,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 137519104 19:08:27 INFO - 2015-11-20 19:08:27,847 DEBUG : BROWSER_OUTPUT: 19:08:30 INFO - 2015-11-20 19:08:30,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36733/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:08:30 INFO - 2015-11-20 19:08:30,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 137936896 19:08:30 INFO - 2015-11-20 19:08:30,603 DEBUG : BROWSER_OUTPUT: 19:08:33 INFO - 2015-11-20 19:08:33,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36733/tests/kraken/driver.html?testName=imaging-darkroom) 19:08:34 INFO - 2015-11-20 19:08:34,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 137670656 19:08:34 INFO - 2015-11-20 19:08:34,169 DEBUG : BROWSER_OUTPUT: 19:08:37 INFO - 2015-11-20 19:08:37,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36733/tests/kraken/driver.html?testName=imaging-desaturate) 19:08:38 INFO - 2015-11-20 19:08:38,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 139059200 19:08:38 INFO - 2015-11-20 19:08:38,163 DEBUG : BROWSER_OUTPUT: 19:08:41 INFO - 2015-11-20 19:08:41,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36733/tests/kraken/driver.html?testName=json-parse-financial) 19:08:41 INFO - 2015-11-20 19:08:41,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 139145216 19:08:41 INFO - 2015-11-20 19:08:41,616 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-20 19:08:43,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36733/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:08:43 INFO - 2015-11-20 19:08:43,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 139837440 19:08:43 INFO - 2015-11-20 19:08:43,795 DEBUG : BROWSER_OUTPUT: 19:08:45 INFO - 2015-11-20 19:08:45,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36733/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:08:46 INFO - 2015-11-20 19:08:46,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 139583488 19:08:46 INFO - 2015-11-20 19:08:46,254 DEBUG : BROWSER_OUTPUT: 19:08:48 INFO - 2015-11-20 19:08:48,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36733/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:08:48 INFO - 2015-11-20 19:08:48,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 139980800 19:08:48 INFO - 2015-11-20 19:08:48,920 DEBUG : BROWSER_OUTPUT: 19:08:51 INFO - 2015-11-20 19:08:51,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:08:52 INFO - 2015-11-20 19:08:52,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 140165120 19:08:52 INFO - 2015-11-20 19:08:52,009 DEBUG : BROWSER_OUTPUT: 19:08:54 INFO - 2015-11-20 19:08:54,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:08:55 INFO - 2015-11-20 19:08:55,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 140132352 19:08:55 INFO - 2015-11-20 19:08:55,170 DEBUG : BROWSER_OUTPUT: 19:08:56 INFO - 2015-11-20 19:08:56,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36733/tests/kraken/driver.html?testName=ai-astar) 19:08:57 INFO - 2015-11-20 19:08:57,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 140718080 19:08:57 INFO - 2015-11-20 19:08:57,086 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,087 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:08:57 INFO - 2015-11-20 19:08:57,088 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:08:57 INFO - 2015-11-20 19:08:57,088 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:08:57 INFO - 2015-11-20 19:08:57,088 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:08:57 INFO - 2015-11-20 19:08:57,088 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;105;113;111;112;122;111;111;111;112 19:08:57 INFO - 2015-11-20 19:08:57,088 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;129;155;165;126;149;158;127;177;126 19:08:57 INFO - 2015-11-20 19:08:57,089 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;163;160;163;164;164;163;166;170;162 19:08:57 INFO - 2015-11-20 19:08:57,089 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;72;73;154;73;72;73;72 19:08:57 INFO - 2015-11-20 19:08:57,089 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;132;89;91;90;132;90;91;137 19:08:57 INFO - 2015-11-20 19:08:57,089 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;110;110;110;110;109;111 19:08:57 INFO - 2015-11-20 19:08:57,090 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;148;147;148;147;148;147;146;146 19:08:57 INFO - 2015-11-20 19:08:57,090 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;97;97;96;96;96;97 19:08:57 INFO - 2015-11-20 19:08:57,090 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;64;63;63;64;63;67;63;60;61 19:08:57 INFO - 2015-11-20 19:08:57,090 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;70;70;69;68;69;74 19:08:57 INFO - 2015-11-20 19:08:57,091 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;93;86;85;84;85;86;93;85;84 19:08:57 INFO - 2015-11-20 19:08:57,091 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;138;116;121;132;127;126;115;126;120 19:08:57 INFO - 2015-11-20 19:08:57,091 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;149;150;149;147;155;148;159;153;139 19:08:57 INFO - 2015-11-20 19:08:57,091 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;71;69;70;65;65;69;69;66;68 19:08:57 INFO - 2015-11-20 19:08:57,092 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:08:57 INFO - 2015-11-20 19:08:57,092 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:08:57 INFO - 2015-11-20 19:08:57,092 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,695 19:08:57 INFO - 2015-11-20 19:08:57,092 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:08:57 INFO - 2015-11-20 19:08:57,093 DEBUG : BROWSER_OUTPUT: __startTimestamp1448075337087__endTimestamp 19:08:57 INFO - 2015-11-20 19:08:57,093 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,094 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:08:57 INFO - 2015-11-20 19:08:57,094 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:08:57 INFO - 2015-11-20 19:08:57,095 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,095 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:4.14 (3.7%) stddev-sans-first:4.39 19:08:57 INFO - 2015-11-20 19:08:57,095 DEBUG : BROWSER_OUTPUT: Values: 112.0 105.0 113.0 111.0 112.0 122.0 111.0 111.0 111.0 112.0 19:08:57 INFO - 2015-11-20 19:08:57,095 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,096 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.50 Median:154.00 stddev:18.42 (12.0%) stddev-sans-first:19.38 19:08:57 INFO - 2015-11-20 19:08:57,096 DEBUG : BROWSER_OUTPUT: Values: 153.0 129.0 155.0 165.0 126.0 149.0 158.0 127.0 177.0 126.0 19:08:57 INFO - 2015-11-20 19:08:57,096 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,096 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.80 (1.7%) stddev-sans-first:2.80 19:08:57 INFO - 2015-11-20 19:08:57,097 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 160.0 163.0 164.0 164.0 163.0 166.0 170.0 162.0 19:08:57 INFO - 2015-11-20 19:08:57,097 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,097 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:72.50 stddev:25.79 (35.6%) stddev-sans-first:27.17 19:08:57 INFO - 2015-11-20 19:08:57,097 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 72.0 73.0 154.0 73.0 72.0 73.0 72.0 19:08:57 INFO - 2015-11-20 19:08:57,097 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,098 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.40 Median:90.50 stddev:20.94 (23.1%) stddev-sans-first:21.72 19:08:57 INFO - 2015-11-20 19:08:57,098 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 132.0 89.0 91.0 90.0 132.0 90.0 91.0 137.0 19:08:57 INFO - 2015-11-20 19:08:57,098 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,100 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 19:08:57 INFO - 2015-11-20 19:08:57,100 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 111.0 19:08:57 INFO - 2015-11-20 19:08:57,100 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,100 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 19:08:57 INFO - 2015-11-20 19:08:57,101 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 148.0 147.0 148.0 147.0 148.0 147.0 146.0 146.0 19:08:57 INFO - 2015-11-20 19:08:57,101 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,101 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:08:57 INFO - 2015-11-20 19:08:57,101 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 97.0 97.0 96.0 96.0 96.0 97.0 19:08:57 INFO - 2015-11-20 19:08:57,102 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,102 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:1.85 (2.9%) stddev-sans-first:1.96 19:08:57 INFO - 2015-11-20 19:08:57,102 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 64.0 63.0 67.0 63.0 60.0 61.0 19:08:57 INFO - 2015-11-20 19:08:57,102 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,103 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.00 stddev:1.65 (2.4%) stddev-sans-first:1.73 19:08:57 INFO - 2015-11-20 19:08:57,103 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 70.0 70.0 69.0 68.0 69.0 74.0 19:08:57 INFO - 2015-11-20 19:08:57,103 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,103 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:85.50 stddev:3.44 (4.0%) stddev-sans-first:3.60 19:08:57 INFO - 2015-11-20 19:08:57,103 DEBUG : BROWSER_OUTPUT: Values: 85.0 93.0 86.0 85.0 84.0 85.0 86.0 93.0 85.0 84.0 19:08:57 INFO - 2015-11-20 19:08:57,103 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,103 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:126.00 stddev:7.78 (6.2%) stddev-sans-first:7.45 19:08:57 INFO - 2015-11-20 19:08:57,104 DEBUG : BROWSER_OUTPUT: Values: 114.0 138.0 116.0 121.0 132.0 127.0 126.0 115.0 126.0 120.0 19:08:57 INFO - 2015-11-20 19:08:57,104 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,104 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:149.50 stddev:5.29 (3.5%) stddev-sans-first:5.60 19:08:57 INFO - 2015-11-20 19:08:57,104 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 150.0 149.0 147.0 155.0 148.0 159.0 153.0 139.0 19:08:57 INFO - 2015-11-20 19:08:57,104 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,104 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:69.00 stddev:2.15 (3.1%) stddev-sans-first:2.18 19:08:57 INFO - 2015-11-20 19:08:57,104 DEBUG : BROWSER_OUTPUT: Values: 66.0 71.0 69.0 70.0 65.0 65.0 69.0 69.0 66.0 68.0 19:08:57 INFO - 2015-11-20 19:08:57,104 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:08:57 INFO - 2015-11-20 19:08:57,104 DEBUG : BROWSER_OUTPUT: 19:08:58 INFO - 2015-11-20 19:08:58,131 INFO : Browser exited with error code: 0 19:08:58 INFO - 2015-11-20 19:08:58,181 INFO : Completed test kraken (00:01:00) 19:08:58 INFO - 2015-11-20 19:08:58,181 INFO : Starting test v8_7 19:08:58 INFO - 2015-11-20 19:08:58,181 DEBUG : operating with platform_type : linux_ 19:08:58 INFO - 2015-11-20 19:08:58,181 INFO : Initialising browser for v8_7 test... 19:08:58 INFO - 2015-11-20 19:08:58,187 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY4bRNx/profile http://localhost:36733/getInfo.html 19:09:02 INFO - 2015-11-20 19:09:02,711 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:09:02 INFO - 2015-11-20 19:09:02,711 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:09:02 INFO - 2015-11-20 19:09:02,711 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:09:02 INFO - 2015-11-20 19:09:02,711 DEBUG : BROWSER_OUTPUT: __metrics 19:09:03 INFO - 2015-11-20 19:09:03,743 INFO : Browser initialized. 19:09:03 INFO - 2015-11-20 19:09:03,743 INFO : Running cycle 1/1 for v8_7 test... 19:09:03 INFO - 2015-11-20 19:09:03,743 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY4bRNx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:09:15 INFO - 2015-11-20 19:09:15,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 141332480 19:09:15 INFO - 2015-11-20 19:09:15,571 DEBUG : BROWSER_OUTPUT: 19:09:36 INFO - 2015-11-20 19:09:36,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36733/tests/v8_7/run.html (next: http://localhost:36733/tests/v8_7/run.html) 19:09:37 INFO - 2015-11-20 19:09:37,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 138842112 19:09:37 INFO - 2015-11-20 19:09:37,251 DEBUG : BROWSER_OUTPUT: 19:09:37 INFO - 2015-11-20 19:09:37,251 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:09:37 INFO - 2015-11-20 19:09:37,251 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:09:37 INFO - 2015-11-20 19:09:37,252 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:09:37 INFO - 2015-11-20 19:09:37,252 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:09:37 INFO - 2015-11-20 19:09:37,252 DEBUG : BROWSER_OUTPUT: |0;Richards;165.92002654720426 19:09:37 INFO - 2015-11-20 19:09:37,252 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.64833462432222 19:09:37 INFO - 2015-11-20 19:09:37,252 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.8191398461977 19:09:37 INFO - 2015-11-20 19:09:37,252 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 19:09:37 INFO - 2015-11-20 19:09:37,252 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1054.8523206751054 19:09:37 INFO - 2015-11-20 19:09:37,253 DEBUG : BROWSER_OUTPUT: |5;Earley;740.1924500370096 19:09:37 INFO - 2015-11-20 19:09:37,253 DEBUG : BROWSER_OUTPUT: |6;Boyer;12292.682926829268 19:09:37 INFO - 2015-11-20 19:09:37,253 DEBUG : BROWSER_OUTPUT: |7;RegExp;24926.829268292684 19:09:37 INFO - 2015-11-20 19:09:37,253 DEBUG : BROWSER_OUTPUT: |8;Splay;634.0075853350189 19:09:37 INFO - 2015-11-20 19:09:37,253 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 19:09:37 INFO - 2015-11-20 19:09:37,253 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:09:37 INFO - 2015-11-20 19:09:37,253 DEBUG : BROWSER_OUTPUT: __startTimestamp1448075377244__endTimestamp 19:09:37 INFO - 2015-11-20 19:09:37,254 DEBUG : BROWSER_OUTPUT: 19:09:37 INFO - 2015-11-20 19:09:37,254 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:09:37 INFO - 2015-11-20 19:09:37,254 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:09:37 INFO - 2015-11-20 19:09:37,254 DEBUG : BROWSER_OUTPUT: 19:09:37 INFO - 2015-11-20 19:09:37,254 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.92 Median:165.92 stddev:0.00 (0.0%) 19:09:37 INFO - 2015-11-20 19:09:37,254 DEBUG : BROWSER_OUTPUT: Values: 165.9 19:09:37 INFO - 2015-11-20 19:09:37,254 DEBUG : BROWSER_OUTPUT: 19:09:37 INFO - 2015-11-20 19:09:37,255 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.65 Median:193.65 stddev:0.00 (0.0%) 19:09:37 INFO - 2015-11-20 19:09:37,255 DEBUG : BROWSER_OUTPUT: Values: 193.6 19:09:37 INFO - 2015-11-20 19:09:37,255 DEBUG : BROWSER_OUTPUT: 19:09:37 INFO - 2015-11-20 19:09:37,255 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.82 Median:284.82 stddev:0.00 (0.0%) 19:09:37 INFO - 2015-11-20 19:09:37,255 DEBUG : BROWSER_OUTPUT: Values: 284.8 19:09:37 INFO - 2015-11-20 19:09:37,255 DEBUG : BROWSER_OUTPUT: 19:09:37 INFO - 2015-11-20 19:09:37,255 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 19:09:37 INFO - 2015-11-20 19:09:37,256 DEBUG : BROWSER_OUTPUT: Values: 5040.2 19:09:37 INFO - 2015-11-20 19:09:37,256 DEBUG : BROWSER_OUTPUT: 19:09:37 INFO - 2015-11-20 19:09:37,256 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1054.85 Median:1054.85 stddev:0.00 (0.0%) 19:09:37 INFO - 2015-11-20 19:09:37,256 DEBUG : BROWSER_OUTPUT: Values: 1054.9 19:09:37 INFO - 2015-11-20 19:09:37,256 DEBUG : BROWSER_OUTPUT: 19:09:37 INFO - 2015-11-20 19:09:37,256 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:740.19 Median:740.19 stddev:0.00 (0.0%) 19:09:37 INFO - 2015-11-20 19:09:37,257 DEBUG : BROWSER_OUTPUT: Values: 740.2 19:09:37 INFO - 2015-11-20 19:09:37,257 DEBUG : BROWSER_OUTPUT: 19:09:37 INFO - 2015-11-20 19:09:37,257 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 19:09:37 INFO - 2015-11-20 19:09:37,257 DEBUG : BROWSER_OUTPUT: Values: 12292.7 19:09:37 INFO - 2015-11-20 19:09:37,257 DEBUG : BROWSER_OUTPUT: 19:09:37 INFO - 2015-11-20 19:09:37,257 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24926.83 Median:24926.83 stddev:0.00 (0.0%) 19:09:37 INFO - 2015-11-20 19:09:37,257 DEBUG : BROWSER_OUTPUT: Values: 24926.8 19:09:37 INFO - 2015-11-20 19:09:37,258 DEBUG : BROWSER_OUTPUT: 19:09:37 INFO - 2015-11-20 19:09:37,258 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:634.01 Median:634.01 stddev:0.00 (0.0%) 19:09:37 INFO - 2015-11-20 19:09:37,258 DEBUG : BROWSER_OUTPUT: Values: 634.0 19:09:37 INFO - 2015-11-20 19:09:37,258 DEBUG : BROWSER_OUTPUT: 19:09:37 INFO - 2015-11-20 19:09:37,258 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 19:09:37 INFO - 2015-11-20 19:09:37,258 DEBUG : BROWSER_OUTPUT: Values: 4840.6 19:09:37 INFO - 2015-11-20 19:09:37,258 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:09:37 INFO - 2015-11-20 19:09:37,259 DEBUG : BROWSER_OUTPUT: 19:09:38 INFO - 2015-11-20 19:09:38,059 INFO : Browser exited with error code: 0 19:09:38 INFO - 2015-11-20 19:09:38,077 INFO : Completed test v8_7 (00:00:39) 19:09:38 INFO - 2015-11-20 19:09:38,293 INFO : Completed test suite (00:20:11) 19:09:38 INFO - 2015-11-20 19:09:38,293 DEBUG : Working with test: dromaeo_css 19:09:38 INFO - 2015-11-20 19:09:38,293 DEBUG : Generating results file: dromaeo_css 19:09:38 INFO - 2015-11-20 19:09:38,294 DEBUG : Working with test: kraken 19:09:38 INFO - 2015-11-20 19:09:38,294 DEBUG : Generating results file: kraken 19:09:38 INFO - 2015-11-20 19:09:38,295 INFO : javascript benchmark 19:09:38 INFO - 2015-11-20 19:09:38,295 DEBUG : Working with test: v8_7 19:09:38 INFO - 2015-11-20 19:09:38,295 DEBUG : Generating results file: v8_7 19:09:38 INFO - 2015-11-20 19:09:38,295 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:09:38 INFO - 2015-11-20 19:09:38,364 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 19:09:38 INFO - 2015-11-20 19:09:38,364 DEBUG : process_Request line: dromaeo_css 7021.13 graph.html#tests=[[72,1,43]] 19:09:38 INFO - 2015-11-20 19:09:38,364 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:09:38 INFO - 2015-11-20 19:09:38,401 DEBUG : process_Request line: kraken 1519.70 graph.html#tests=[[232,1,43]] 19:09:38 INFO - 2015-11-20 19:09:38,401 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:09:38 INFO - 2015-11-20 19:09:38,440 DEBUG : process_Request line: v8_7 21205.87 graph.html#tests=[[230,1,43]] 19:09:38 INFO - 2015-11-20 19:09:38,441 INFO : javascript benchmark 19:09:38 INFO - 2015-11-20 19:09:38,445 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3195.328980914008, 3287.3425314937003, 3304.8347582620863, 3314.005798260522, 3332.8333583320828, 5250.0, 5440.863978400537, 5460.6177567570285, 5463.125899856024, 5491.258680078188, 5427.701476418795, 5434.375046869611, 5454.0, 5538.280023596927, 5551.3893471718075, 5001.624878134136, 5094.7197904115255, 5139.563137133348, 5178.896422071556, 5179.04187725272, 4951.777170027357, 5009.373828271466, 5047.823326183584, 5057.721825299607, 5083.262926875601, 4808.543188397097, 4884.267359896008, 4933.210686290176, 4981.775820088086, 5007.098722229997, 4953.777080031371, 4965.379327584052, 4969.726665033421, 4994.775235114393, 5015.0722116408215, 4911.0, 4944.159492886218, 4964.60283177345, 4966.279889416014, 4995.250712393134, 5058.848234552969, 5122.129238029544, 5234.450382709837, 5237.869053273661, 5320.361556613231, 5790.478856902899, 5842.773017666295, 5850.824475265749, 5862.443067908542, 5869.4717475427415, 5867.794627188028, 5909.793157239476, 5910.438508341701, 5912.852178695524, 5926.851828704317, 5326.786928522854, 5419.674819510842, 5452.672839629635, 5484.396716361197, 5547.833564993057, 5859.560532959959, 5867.970660146757, 5900.616459930091, 5906.3207731110615, 5913.438223368773, 5584.944150558443, 5700.686462244616, 5701.173329867146, 5709.600327977085, 5718.285214348207, 5784.1034639630925, 5831.883362332815, 5846.181534585162, 5849.766009359578, 5880.970595146997, 5732.140178973187, 5778.94221057784, 5784.2769653793275, 5795.913061304083, 5810.0, 5702.7433765480655, 5732.168835518826, 5779.797707080232, 5795.739191736382, 5847.824565262964, 4412.646988240933, 4419.845305414295, 4421.823127074946, 4457.576530229623, 4493.236149854532, 3960.683145348365, 4031.052702614883, 4061.7156799023783, 4066.471358723347, 4089.5910408958866, 5404.405515393382, 5457.263269458652, 5546.195801608744, 5643.407442218508, 5655.886882262332, 5799.8550036249435, 5827.79602713903, 5832.24180856486, 5838.0, 5881.147233651097, 5535.114381698909, 5563.109902415594, 5564.276644036249, 5569.108942569251, 5576.804811831566, 4873.512648735169, 4903.779329930162, 4962.404511458648, 4974.825881094217, 5076.340075790124, 5947.434993675507, 5962.314333851576, 5988.101784732238, 5993.730282137314, 6005.699715014319, 5852.648841069549, 5868.823935281948, 5877.382874798084, 5896.616719913192, 5901.852453688693, 5796.536277097738, 5821.27234095738, 5891.764329426775, 5905.970470147622, 5925.140854575976, 5812.651240925558, 5836.824895253149, 5839.941600583939, 5843.0, 5868.94131058701, 5665.546756259407, 5814.244148260699, 5848.0, 5876.471117599436, 5895.94104058954, 5653.830385088454, 5684.914726279027, 5709.25779648643, 5761.078227483583, 5810.5061069809535, 5732.3121225453215, 5752.424757524214, 5753.769849206153, 5768.451997060272, 5784.971075144597, 5404.945950540601, 5507.697076660822, 5586.944130558642, 5600.103983362643, 5628.8874222514505, 5534.833954981357, 5648.322201335866, 5653.745581448927, 5661.320641523043, 5677.5457963362005, 5609.354924183771, 5632.183333416713, 5683.3748287687495, 5699.629524080921, 5729.427057294404], "unit": "ms", "name": "dojo.html", "value": 5376.150619462555}, {"lowerIsBetter": false, "replicates": [544.7031367904492, 598.4733434577571, 604.6644112517554, 607.7113371148705, 610.0330975403986, 29418.117456476313, 39158.804205979, 39209.0, 39410.80294598526, 39458.80270598643, 41965.37051944224, 41980.0, 42376.0, 42554.148917021645, 42698.573014269845, 8599.269062129726, 8751.081136480674, 8840.646374145026, 8870.911290887074, 8899.24356429701, 8614.612342444574, 8696.0, 8699.652013919436, 8741.825163496726, 8742.86885696715, 8728.607212675413, 8808.603612837405, 8852.601632926502, 8884.644614215424, 8898.955505222464, 8767.868481972775, 8829.690960816373, 8830.381873268874, 8835.381523293372, 8836.204741573225, 8695.043545210021, 8867.689630862953, 8878.0, 8884.511351875644, 8894.199522043047, 39408.60591394078, 39804.0, 39824.0, 39857.80071099655, 39924.800375998224, 3304.9008529744146, 3480.738944579167, 3527.417976033951, 3546.7517273790845, 3706.314331848617, 28910.132696019155, 29607.555886661718, 29628.0, 29736.55395169074, 29970.400591988255, 3799.4870692456443, 3816.599257078022, 3861.4593956846065, 3951.4270430787374, 3988.561258261589, 262776.0, 263320.0, 265064.0, 265459.0, 266281.0, 41568.88233382448, 41769.79115104466, 58024.419755802744, 58026.7098664504, 58074.12888806671, 41461.37807932883, 41586.792066039474, 41725.37411938823, 41896.0, 42056.57943420588, 14368.13791172533, 14526.709465810836, 14533.0, 14583.854161458461, 14688.55934321972, 11542.711432214093, 11550.653480395433, 11576.0, 11609.30344179335, 11626.53493860236, 14119.740841465316, 14261.358238879067, 14261.85738142626, 14273.64315892111, 14292.499762508261, 5813.244278243801, 5882.794102206402, 5908.9818923131825, 5933.465988061095, 5982.790602328898, 911.4440191483322, 923.4874644572327, 973.5229737428609, 990.1633120013577, 1137.6530158301798, 27779.0, 31779.682203177672, 32814.17964550858, 32893.67106328954, 33182.83408582942, 1036.5750042482546, 1038.1746511523206, 1079.4602698650674, 1102.5755084292605, 1114.147677027075, 14765.214527709846, 14882.851171488146, 14900.254987250812, 15031.0, 15118.09291442517, 355606.0, 360014.0, 361671.0, 362122.0, 362887.0, 51670.483295167316, 52563.0, 52579.0, 52709.209361859605, 52796.20805687918, 1324.8079028541001, 1337.779266421049, 1350.3315858649835, 1355.769519181761, 1358.3887250737207, 27571.86214068917, 28664.0, 28845.567316490688, 28873.278168045967, 28873.422531548833, 45856.541434585226, 46148.0, 46169.30746038745, 46187.0, 46331.0, 284772.0, 287741.0, 287954.0, 288547.0, 288764.0, 27512.0, 28014.159575212776, 30998.535021975138, 31288.21779455532, 31590.526142108345, 37708.43437348497, 37958.62041379551, 37961.4305785419, 38973.610263897, 39111.0, 32491.675083248865, 33274.0, 34513.30973380468, 35679.64320356763, 40488.79755601203, 36253.45619815652, 36587.63412365842, 37190.0, 37261.62738372581, 37577.43633845549, 38893.416598750475, 39115.413268800425, 39269.803650981565, 39386.0, 39817.0, 31073.533896992016, 31395.0, 33629.0, 33725.15687107842, 33762.0, 24610.630840537047, 25130.74869251357, 25430.237092887244, 25564.0, 25651.0], "unit": "ms", "name": "ext.html", "value": 17986.587785847172}, {"lowerIsBetter": false, "replicates": [350.2452215475651, 353.6657858323885, 361.11346643989003, 363.1792149741583, 369.5823719197307, 13902.165870047804, 13989.370478328474, 16535.007899526023, 16963.66072678547, 17563.824361756393, 16103.919480402581, 16324.510264692048, 17279.827201727978, 17613.91193044036, 17685.646287074283, 5275.393329767068, 5402.6758394496255, 5404.83785486434, 5438.864028399302, 5445.9727701361435, 5095.79616815327, 5208.531232189102, 5220.4779522047875, 5234.92147617786, 5325.387580428262, 5114.693118412889, 5162.045021670984, 5198.220266959948, 5200.817971371002, 5973.1040343948325, 5865.501432378253, 5881.3530511643685, 5885.8822823543505, 5908.32054313753, 5916.585838991272, 4844.055409195208, 4922.729249891255, 5236.895262094737, 5255.553277971377, 5261.316028916254, 12143.332116733576, 12360.0, 12384.442700078518, 15987.760183597255, 20361.796382036286, 2038.714579958807, 2105.5473073289163, 2126.2451829600577, 2139.9893000535053, 2251.9324420267417, 9694.70915872518, 10808.081313088318, 11374.943125284404, 13064.346782660828, 13454.93272533631, 1782.3494424535081, 1784.4914199453224, 1793.9641207175914, 1826.881252718569, 1858.990705046466, 62543.0, 64248.0, 64431.35568644301, 64582.0, 64928.675356622916, 9964.601415943282, 10058.497075146213, 10068.647597334204, 10158.542865571068, 10215.233857460571, 13136.474541018251, 13298.135621184592, 13300.201987880759, 13353.59939201806, 13363.599092027254, 7266.564006159648, 7393.630318484162, 7415.8146046349275, 7420.5547667140145, 7639.815828546584, 7060.258672839278, 7081.575105493687, 7084.681189346492, 7138.857222855514, 7166.247544007909, 4016.9397459038137, 4332.696711230184, 4366.410534577792, 4368.36658684489, 4438.7114837535455, 1788.2578729827237, 1799.388208009283, 1824.0, 1831.8809277397193, 1841.6777064013745, 928.9907100929039, 936.5364144748257, 946.7491114854569, 1007.7833265847878, 1045.2474218562622, 16469.58826029335, 16549.6690066198, 16943.406980755863, 17350.65298694019, 17606.559836003948, 896.345667662597, 936.7751739582587, 952.2667545989549, 1005.3465247589126, 1008.1581879130861, 9113.270938324918, 9222.86165707515, 9343.90656093444, 9416.670416535388, 9424.90575094254, 501595.0, 502815.0, 528264.0, 534398.0, 535622.0, 71206.0, 71567.0, 72545.0, 75741.62129189319, 77876.61061694655, 1091.579741799413, 1092.6558134187705, 1104.282216559243, 1130.3895896216115, 1131.0668698323752, 15764.211789410712, 15807.36770529166, 15929.522114336589, 15973.440929567409, 16322.183890805174, 33771.15572110717, 33992.0, 34372.48441273333, 34757.826210868785, 35545.466817997236, 46818.29772553482, 48622.0, 49444.50555494399, 49729.75135124446, 50917.23624145567, 9118.133777291147, 9630.662926797528, 9732.902670973483, 9758.268129890144, 9820.901790982285, 16355.34578616842, 16808.495745127664, 17099.0, 17130.14349282556, 17303.134843257536, 14250.786238206229, 14267.714645707236, 14825.777613336024, 15094.773578396112, 15138.470153545013, 2740.1231605885923, 13404.396802143732, 13885.0, 13997.160170389809, 14704.456032116901, 14104.506342277971, 14126.646833828825, 14132.929335353669, 14139.575812725634, 14202.0, 9152.771180720536, 9252.306077044113, 9323.766905827408, 9333.533323333942, 9341.0, 13368.465261389825, 13479.730405392034, 13496.392662330023, 14508.927455362656, 14737.631559210677], "unit": "ms", "name": "jquery.html", "value": 8772.901334400916}, {"lowerIsBetter": false, "replicates": [1476.188096546899, 1721.388906938037, 1763.4885883093903, 1778.688729472342, 1807.3132209760292, 6149.046897730853, 6216.7202475888635, 6257.71840267188, 7406.740764073258, 7566.772996810091, 7763.06843178818, 7814.648340824662, 7832.608369581527, 7853.253940875607, 7866.803329916755, 2212.9889350553226, 2225.9888700556558, 2244.517428752818, 2248.2243625949104, 2250.414892128042, 2238.7089678341795, 2273.3975496493445, 2279.760625134362, 2282.9200977965775, 2284.7486776454575, 2164.1127137873477, 2184.2355175688463, 2198.1976578548793, 2199.813015893651, 2250.8199344052437, 2265.818734501236, 2288.519410923708, 2290.9312720618323, 2291.667708182321, 2294.9426264343356, 2196.7254093238344, 2290.278562252885, 2297.092648403871, 2297.471581536256, 2297.655351697242, 7750.418718596072, 7756.146823849372, 7790.182030886732, 7797.649105790197, 7834.921650783476, 4561.726296422192, 4652.534746525354, 4656.790444429975, 4660.906781864378, 4672.859814205545, 2976.122043997026, 3048.6798886116862, 3091.3044564972924, 3107.3629905869243, 3124.5000799872137, 946.2571881073393, 952.4904176265734, 970.631160159135, 977.359829311802, 989.3371441134457, 10563.683089507327, 10641.78716425675, 10647.414392208426, 10651.627193048205, 10715.0, 4027.577104404054, 4060.451839001756, 4078.5513593505284, 4081.8571350002608, 4133.648639865645, 8642.611082501302, 8648.610812513452, 8648.870266946002, 8660.826783464296, 8677.6528938843, 4589.655775816827, 4630.6758526902795, 4635.049814787961, 4635.536446355405, 4653.60444362233, 4205.705600607989, 4242.681798865097, 4257.914231870853, 4260.8508702195895, 4264.33902745075, 3375.746818988586, 3397.8301084945656, 3415.6072051713872, 3425.811580363104, 3445.13871532117, 1039.8076355874186, 1047.450088703437, 1050.8633877596017, 1057.3338796558119, 1071.8606581144556, 995.1491474789096, 996.1234113979797, 1062.0972173652333, 1138.4706111657954, 1280.1678908709414, 6743.52795304324, 6768.627725475048, 6778.254392016875, 6788.660566971632, 6815.795526134125, 1099.571167244775, 1120.2158489057692, 1139.658102569226, 1145.2098052343856, 1153.9596114136132, 5577.470140336662, 5600.943990560042, 5633.295838020247, 5634.4928956393305, 5637.943620563742, 8786.736397908073, 8804.163604457566, 9230.58462369195, 9238.67664631748, 9245.399049061789, 9063.229625481908, 9070.0, 9078.954605227063, 9081.228095611816, 9130.31522635805, 7042.507024508235, 7129.89305160423, 7147.857042859114, 7171.462140339496, 7213.675384607705, 6597.3072827352435, 6610.3720146586, 6634.502412318999, 6635.236947750877, 6643.734250629921, 7744.225577442211, 8063.959680201561, 8072.152423995396, 8176.141505141874, 8220.095789463036, 8180.263776260165, 8352.498850069016, 8356.080831108451, 8391.412601117863, 8500.787480313042, 6296.087067375113, 6435.356464353527, 6494.155759751202, 6513.316101809241, 6532.346765323429, 6903.792886213421, 7075.575465472089, 7097.219305876246, 7098.609576473344, 7098.787036388917, 6589.670516474253, 6637.6349300788925, 6694.397504224643, 6718.7312507499155, 6887.449004079562, 6617.536772425884, 6682.131322927989, 6776.93223067763, 6839.350261725128, 6949.270326615632, 7202.819929501595, 7227.638618069181, 7261.346478816932, 7268.345848873415, 7269.41844652416, 6333.20834895638, 6347.809565713036, 6372.490200784019, 6405.071264666504, 6421.197350331208, 6494.707738151889, 6520.543561950618, 6523.510736694861, 6531.379518945692, 6539.378759017885], "unit": "ms", "name": "mootools.html", "value": 4370.842704880043}, {"lowerIsBetter": false, "replicates": [310.46134955851596, 320.03668956441106, 322.1414929213646, 324.33025801719435, 326.1080943619203, 6350.206224221973, 6375.744970201192, 6426.807195784122, 6461.095446637469, 6496.220453545575, 6146.81559553213, 6298.7165577549, 6305.873882522358, 6333.524985626073, 6338.366163383659, 4769.856904292877, 4779.522047795227, 4780.760961951906, 4794.345950647021, 4800.807967681289, 4773.904521909577, 4775.785089670973, 4780.593649539794, 4785.875319299962, 4821.734804585746, 4665.83669571565, 4750.5724484796365, 4754.429468463789, 4756.7859446325, 4763.642726795487, 4728.40894888139, 4744.0511897620445, 4749.216379297429, 4760.809567617292, 4767.880802979918, 3915.334393153171, 4008.699347548916, 4107.856225032109, 4123.9175216495505, 4128.793560321972, 5997.040473524259, 5997.370276121032, 5997.970010149965, 6023.518118550505, 6032.5173986081445, 5425.728713564306, 5439.782408703647, 5463.344398672145, 5464.398916119224, 5467.562594992431, 6568.343165683441, 6629.171353580802, 6644.534882558223, 6673.5662181958505, 6678.866422671568, 4489.0, 4491.348754430622, 4501.7974191161475, 4502.57225563571, 4502.6397888169195, 6956.478264130211, 6968.850139726888, 6969.686364113576, 7026.332498412643, 7033.4724895633035, 4483.19302525542, 4490.416245888014, 4491.371208030879, 4491.46102467706, 4512.0, 4500.639948804088, 4571.634269258451, 4586.610138138229, 4591.885202869955, 4657.580817726421, 5418.566514678816, 5429.294191755047, 5432.51107400328, 5433.456654334614, 5444.074507333763, 6723.159605049369, 6726.764563240361, 6733.797986060426, 6738.629375384401, 6821.4542836572955, 1629.5274370432678, 1642.808963501452, 1647.5057482755365, 1653.7354023356206, 1654.1729135432283, 1053.5048527192362, 1068.188176985481, 1068.2468859454066, 1075.5536452372335, 1088.6842815583393, 6508.251551071593, 6541.28045914949, 6553.475721942234, 6570.441512471493, 6572.835679107965, 6929.41100006495, 6970.581765094111, 6997.335253150943, 7007.684654190573, 7017.473689473208, 6419.454346380517, 6513.088167656532, 6513.446357059608, 6548.934510654928, 6550.541462097607, 3792.8482860685262, 3802.296575133609, 3802.5817160112365, 3804.6575808177395, 3823.4456003879836, 7099.751508697171, 7182.569045857265, 7186.640667966581, 7189.317014883578, 7208.783736487913, 7153.248908864598, 7160.283971602798, 7214.494985350975, 7215.170255420589, 7221.711131554784, 7076.858462830714, 7203.207647158808, 7234.276572342724, 7279.0, 7283.380912622486, 7032.0, 7038.859222815413, 7039.612821294673, 7055.964720176366, 7058.505904586629, 6999.160100787734, 7002.2297547268745, 7007.194172670208, 7014.228434872262, 7016.824579385556, 7094.148702155568, 7228.819279517844, 7231.2768723127265, 7314.4148468123485, 7324.377427918474, 4599.988002639414, 4643.883902902455, 4651.0, 4654.837080702159, 4669.813207471663, 6902.551334163263, 6939.653017349214, 6958.686859091455, 6970.128733908262, 6974.442044636316, 6725.4283385910785, 6851.554648947803, 6864.450843932574, 6870.31296870309, 6878.793636190922, 6708.765193218214, 6779.288174741581, 6784.59292442455, 6790.524663273523, 6796.422304104207, 6625.006249062679, 6638.83402914931, 6647.102641143384, 6653.367930046637, 6659.633720145439, 6628.436582890508, 6833.077534532775, 6835.965820170867, 6843.0, 6876.518643694893, 6638.17022872141, 6644.60132392058, 6670.566413183127, 6682.2649508555, 6707.530472867048], "unit": "ms", "name": "prototype.html", "value": 5019.767177759816}, {"lowerIsBetter": false, "replicates": [706.5619316024063, 707.6284950401035, 760.9581473018983, 765.7779244019234, 782.4366456151571, 13537.187768733871, 13727.0, 15398.30707618157, 15623.0, 15640.139792311418, 14900.776488352683, 14945.775813362809, 15033.173175475344, 15088.47190348338, 15126.243687815593, 813.2111851504061, 814.9755507334775, 828.7348048624442, 829.0134739659816, 838.5555655502593, 802.1336956087412, 828.6726742936537, 834.4284165346727, 842.5113434208145, 842.5323945210406, 836.7029704454923, 869.1742844297911, 871.3464901324007, 878.3324673248313, 878.7363790862747, 837.4054421360842, 863.8272345530919, 866.4151697604156, 866.6663334616155, 867.9869801952975, 635.034747184282, 635.7806556737918, 635.9491240700733, 636.7675798333621, 638.2373064188297, 13606.931965340209, 13821.170729756146, 13833.239171845544, 13866.237356945365, 13938.93030534841, 12295.200811947196, 12337.0, 12516.0, 12556.623301300975, 12968.478282596072, 10079.244056695778, 10318.58725650973, 10439.164866810637, 10552.630657926935, 10903.400312982783, 3543.3090547343277, 3578.982105089458, 3615.132368231632, 3646.8541258349633, 3649.7445178837493, 49348.753256233846, 49925.25112123321, 50010.49989500095, 50130.24804627933, 50161.0, 9981.351212171186, 10069.848952265722, 10098.899011009797, 10126.898731012743, 10283.228757843191, 17915.37296194627, 17930.0, 17967.910160449115, 17988.820111798977, 18077.09614519295, 6990.370866622028, 7231.3130252625915, 7232.240614735482, 7262.17496913946, 7498.0, 4464.642828573771, 4538.841140560065, 4540.523245059288, 4549.948568404015, 4562.61217796491, 3144.261098641817, 3173.1591128351006, 3179.6820317968018, 3187.2509960159346, 3209.326041531258, 562.6624025584698, 576.0610205365311, 584.5119325363369, 591.5918016568554, 592.3454582686156, 649.1625802714445, 691.1360799001249, 708.5819366573746, 709.6877373955443, 722.609790713009, 8633.525156116348, 8740.519271440131, 8811.559422028873, 8908.599113039929, 9137.223336016514, 513.1737901977813, 599.6312267955263, 600.8527910661916, 663.1478550063146, 704.17259719829, 4016.377461493473, 4394.36281739146, 4539.72761634303, 4588.908221835544, 4601.378813860086, 53733.0, 56941.14588281179, 57685.134722979186, 58266.0, 58287.70856145692, 47227.76386118047, 47241.291380629315, 47575.762121189175, 47890.0, 48175.5182448178, 43769.0, 43792.0, 45805.54194458079, 46010.30984535235, 47092.7645361771, 8729.781755456164, 8792.736217913473, 8948.463092214488, 8948.955255223682, 9024.684136055206, 35403.29193416169, 35707.642923570435, 36066.27867442689, 36237.63762362448, 36441.27117457583, 46386.53613463822, 46907.76546117248, 47204.0, 47441.0, 47446.76276618595, 10885.290390812652, 10910.672679819618, 11287.927646873533, 11307.886921131012, 11315.490802914053, 11942.880571194177, 11990.700232493908, 12036.578719744766, 12043.81934270969, 12529.874701252871, 11618.94190529042, 11932.403379831147, 11997.880021199677, 12315.261084334968, 12425.565105221274, 11395.430228488709, 11631.59289424866, 11704.70738231551, 11921.165518413627, 11921.642350729491, 11246.381449020382, 11736.178467507192, 11754.823677644672, 11843.28940263587, 12073.879261207276, 9815.754606134904, 10023.097921187129, 10055.095041446304, 10230.437325947145, 10359.58133815824, 8804.251638610789, 9065.546722663708, 9133.45199288045, 9960.870151871646, 10023.799524009624], "unit": "ms", "name": "yui.html", "value": 6435.661590308278}], "name": "dromaeo_css", "value": 7021.1299199248415}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 113.0, 111.0, 112.0, 122.0, 111.0, 111.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [153.0, 129.0, 155.0, 165.0, 126.0, 149.0, 158.0, 127.0, 177.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 160.0, 163.0, 164.0, 164.0, 163.0, 166.0, 170.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 72.0, 73.0, 154.0, 73.0, 72.0, 73.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 132.0, 89.0, 91.0, 90.0, 132.0, 90.0, 91.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 103.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 67.0, 63.0, 60.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 63.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 69.0, 68.0, 69.0, 74.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [85.0, 93.0, 86.0, 85.0, 84.0, 85.0, 86.0, 93.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [114.0, 138.0, 116.0, 121.0, 132.0, 127.0, 126.0, 115.0, 126.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 150.0, 149.0, 147.0, 155.0, 148.0, 159.0, 153.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 69.0, 70.0, 65.0, 65.0, 69.0, 69.0, 66.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1519.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.92002654720426], "unit": "score", "name": "Richards", "value": 212.765154}, {"lowerIsBetter": false, "replicates": [193.64833462432222], "unit": "score", "name": "DeltaBlue", "value": 341.433352}, {"lowerIsBetter": false, "replicates": [284.8191398461977], "unit": "score", "name": "Encrypt", "value": 934.5614910000002}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1054.8523206751054], "unit": "score", "name": "RayTrace", "value": 701.5095719999998}, {"lowerIsBetter": false, "replicates": [740.1924500370096], "unit": "score", "name": "Earley", "value": 900.3915129999997}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [24926.829268292684], "unit": "score", "name": "RegExp", "value": 36.54636497064577}, {"lowerIsBetter": false, "replicates": [634.0075853350189], "unit": "score", "name": "Splay", "value": 128.5331625124626}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21205.872717319697}]} 19:09:38 INFO - RETURN: dromaeo_css: 7021.13 19:09:38 INFO - RETURN: kraken: 1519.70 19:09:38 INFO - RETURN: v8_7: 21205.87 19:09:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21205.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1519.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7021.13"}}} 19:09:38 INFO - Return code: 0 19:09:38 INFO - # TBPL SUCCESS # 19:09:38 INFO - Running post-action listener: _resource_record_post_action 19:09:38 INFO - Running post-run listener: _resource_record_post_run 19:09:39 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 520441856; Read time: 0; Write time: 371580 19:09:39 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 148578304; Read time: 0; Write time: 119452 19:09:39 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 371863552; Read time: 0; Write time: 252128 19:09:39 INFO - Running post-run listener: _upload_blobber_files 19:09:39 INFO - Blob upload gear active. 19:09:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:09:39 INFO - Copying logs to upload dir... 19:09:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.231915 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-20 19:09:39.284751) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 19:09:39.288545) ========= 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=3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009976 build_url: 'https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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-20 19:09:39.340176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:09:39.340513) ========= 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=3e14eba40af1795cf0357910000001c3-1448073491.896055-1219893990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:09:39.390184) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 19:09:39.390494) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 19:09:39.390796) ========= ========= Total master_lag: 0.21 =========