builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1448031326.83 results: success (0) buildid: 20151120043002 builduid: 24682f083fc94014a6d1965e450e1312 revision: ec628289d8b4ed310463a0729c3e60a7798dfcac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:26.835304) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:26.835695) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:26.835995) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006397 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:26.864452) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:26.864735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:26.889389) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:26.889669) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.011415 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:26.936979) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:26.937313) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:26.937695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:26.938278) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 06:55:26-- 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 06:55:27 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110581 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.061113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.061484) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.050948 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.122649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.122958) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ec628289d8b4ed310463a0729c3e60a7798dfcac --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 ec628289d8b4ed310463a0729c3e60a7798dfcac --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=447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 06:55:27,148 truncating revision to first 12 chars 2015-11-20 06:55:27,148 Setting DEBUG logging. 2015-11-20 06:55:27,148 attempt 1/10 2015-11-20 06:55:27,148 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ec628289d8b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 06:55:27,473 unpacking tar archive at: mozilla-central-ec628289d8b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628418 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.766498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.767201) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.778464) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.778830) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.779305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2015-11-20 06:55:27.779591) ========= /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=447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:55:27 INFO - MultiFileLogger online at 20151120 06:55:27 in /builds/slave/test-pgo 06:55:27 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 06:55:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:55:27 INFO - {'append_to_log': False, 06:55:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:55:27 INFO - 'blob_upload_branch': 'Firefox', 06:55:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:55:27 INFO - 'branch': 'Firefox', 06:55:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:55:27 INFO - 'config_files': ('talos/linux_config.py',), 06:55:27 INFO - 'default_actions': ('clobber', 06:55:27 INFO - 'read-buildbot-config', 06:55:27 INFO - 'download-and-extract', 06:55:27 INFO - 'populate-webroot', 06:55:27 INFO - 'create-virtualenv', 06:55:27 INFO - 'install', 06:55:27 INFO - 'run-tests'), 06:55:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:55:27 INFO - 'download_minidump_stackwalk': True, 06:55:27 INFO - 'download_symbols': 'ondemand', 06:55:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:55:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:55:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:55:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:55:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:55:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:55:27 INFO - 'installer_path': 'installer.exe', 06:55:27 INFO - 'log_level': 'info', 06:55:27 INFO - 'log_name': 'talos', 06:55:27 INFO - 'log_to_console': True, 06:55:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:55:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:55:27 INFO - 'opt_config_files': (), 06:55:27 INFO - 'pip_index': False, 06:55:27 INFO - 'sps_profile': False, 06:55:27 INFO - 'sps_profile_interval': 0, 06:55:27 INFO - 'suite': 'dromaeojs-e10s', 06:55:27 INFO - 'system_bits': '64', 06:55:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:55:27 INFO - 'title': 'talos-linux64-ix-027', 06:55:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:55:27 INFO - 'use_talos_json': True, 06:55:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:55:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:55:27 INFO - 'work_dir': 'build'} 06:55:27 INFO - ##### 06:55:27 INFO - ##### Running clobber step. 06:55:27 INFO - ##### 06:55:27 INFO - Running pre-action listener: _resource_record_pre_action 06:55:27 INFO - Running main action method: clobber 06:55:27 INFO - rmtree: /builds/slave/test-pgo/build 06:55:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:55:33 INFO - Running post-action listener: _resource_record_post_action 06:55:33 INFO - ##### 06:55:33 INFO - ##### Running read-buildbot-config step. 06:55:33 INFO - ##### 06:55:33 INFO - Running pre-action listener: _resource_record_pre_action 06:55:33 INFO - Running main action method: read_buildbot_config 06:55:33 INFO - Using buildbot properties: 06:55:33 INFO - { 06:55:33 INFO - "properties": { 06:55:33 INFO - "buildnumber": 552, 06:55:33 INFO - "product": "firefox", 06:55:33 INFO - "script_repo_revision": "production", 06:55:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:55:33 INFO - "repository": "", 06:55:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:55:33 INFO - "buildid": "20151120043002", 06:55:33 INFO - "slavename": "talos-linux64-ix-027", 06:55:33 INFO - "pgo_build": "True", 06:55:33 INFO - "basedir": "/builds/slave/test-pgo", 06:55:33 INFO - "project": "", 06:55:33 INFO - "platform": "ubuntu64_hw", 06:55:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:55:33 INFO - "slavebuilddir": "test", 06:55:33 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:55:33 INFO - "branch": "mozilla-central", 06:55:33 INFO - "repo_path": "mozilla-central", 06:55:33 INFO - "stage_platform": "linux64-pgo", 06:55:33 INFO - "builduid": "24682f083fc94014a6d1965e450e1312", 06:55:33 INFO - "revision": "ec628289d8b4ed310463a0729c3e60a7798dfcac" 06:55:33 INFO - }, 06:55:33 INFO - "sourcestamp": { 06:55:33 INFO - "repository": "", 06:55:33 INFO - "hasPatch": false, 06:55:33 INFO - "project": "", 06:55:33 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:55:33 INFO - "changes": [ 06:55:33 INFO - { 06:55:33 INFO - "category": null, 06:55:33 INFO - "files": [ 06:55:33 INFO - { 06:55:33 INFO - "url": null, 06:55:33 INFO - "name": "https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:55:33 INFO - } 06:55:33 INFO - ], 06:55:33 INFO - "repository": "", 06:55:33 INFO - "rev": "ec628289d8b4ed310463a0729c3e60a7798dfcac", 06:55:33 INFO - "who": "sendchange", 06:55:33 INFO - "when": 1448031271, 06:55:33 INFO - "number": 6688676, 06:55:33 INFO - "comments": "", 06:55:33 INFO - "project": "", 06:55:33 INFO - "at": "Fri 20 Nov 2015 06:54:31", 06:55:33 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:55:33 INFO - "revlink": "", 06:55:33 INFO - "properties": [ 06:55:33 INFO - [ 06:55:33 INFO - "buildid", 06:55:33 INFO - "20151120043002", 06:55:33 INFO - "Change" 06:55:33 INFO - ], 06:55:33 INFO - [ 06:55:33 INFO - "builduid", 06:55:33 INFO - "24682f083fc94014a6d1965e450e1312", 06:55:33 INFO - "Change" 06:55:33 INFO - ], 06:55:33 INFO - [ 06:55:33 INFO - "pgo_build", 06:55:33 INFO - "True", 06:55:33 INFO - "Change" 06:55:33 INFO - ] 06:55:33 INFO - ], 06:55:33 INFO - "revision": "ec628289d8b4ed310463a0729c3e60a7798dfcac" 06:55:33 INFO - } 06:55:33 INFO - ], 06:55:33 INFO - "revision": "ec628289d8b4ed310463a0729c3e60a7798dfcac" 06:55:33 INFO - } 06:55:33 INFO - } 06:55:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:55:33 INFO - Running post-action listener: _resource_record_post_action 06:55:33 INFO - ##### 06:55:33 INFO - ##### Running download-and-extract step. 06:55:33 INFO - ##### 06:55:33 INFO - Running pre-action listener: _resource_record_pre_action 06:55:33 INFO - Running main action method: download_and_extract 06:55:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:55:33 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')]} 06:55:33 INFO - https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:55:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/test_packages.json 06:55:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/test_packages.json 06:55:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:55:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:55:34 INFO - Downloaded 1302 bytes. 06:55:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:55:34 INFO - Using the following test package requirements: 06:55:34 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:55:34 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:55:34 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:34 INFO - u'jsshell-linux-x86_64.zip'], 06:55:34 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:55:34 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:55:34 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:55:34 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:55:34 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:55:34 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:55:34 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:55:34 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:34 INFO - https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:55:53 INFO - Downloaded 22524710 bytes. 06:55:53 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 06:55:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:55:53 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 06:55:54 INFO - Return code: 0 06:55:54 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 06:55:54 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')]} 06:55:54 INFO - https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:55:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:55:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:55:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:55:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:56:06 INFO - Downloaded 22524710 bytes. 06:56:06 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 06:56:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:56:06 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 06:56:08 INFO - Return code: 0 06:56: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')]} 06:56:08 INFO - https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:56:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:56:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:56:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:56:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:56:09 INFO - Downloaded 11130997 bytes. 06:56:09 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 06:56:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:56:09 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 06:56:09 INFO - Return code: 0 06:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:09 INFO - https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:56:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:56:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:56:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:56:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:56:10 INFO - Downloaded 57353019 bytes. 06:56:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:56:10 INFO - mkdir: /builds/slave/test-pgo/properties 06:56:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:56:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:56:10 INFO - Contents: 06:56:10 INFO - build_url:https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:56:10 INFO - Running post-action listener: _resource_record_post_action 06:56:10 INFO - Running post-action listener: set_extra_try_arguments 06:56:10 INFO - ##### 06:56:10 INFO - ##### Running populate-webroot step. 06:56:10 INFO - ##### 06:56:10 INFO - Running pre-action listener: _resource_record_pre_action 06:56:10 INFO - Running main action method: populate_webroot 06:56:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:56:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:56:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:56:10 INFO - '../fennec_ids.txt'], 06:56:10 INFO - 'tests': ['tcheck2']}, 06:56:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:56:10 INFO - '--tppagecycles', 06:56:10 INFO - '7'], 06:56:10 INFO - 'tests': ['tsvgm']}}, 06:56:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:56:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:56:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:56:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:56:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:56:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:56:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:56:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:10 INFO - 'talos_options': ['--e10s'], 06:56:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:56:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:10 INFO - 'tests': ['damp', 'tps']}, 06:56:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:10 INFO - 'talos_options': ['--e10s'], 06:56:10 INFO - 'tests': ['damp', 'tps']}, 06:56:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:56:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:56:10 INFO - 'other': {'tests': ['a11yr', 06:56:10 INFO - 'ts_paint', 06:56:10 INFO - 'tpaint', 06:56:10 INFO - 'sessionrestore', 06:56:10 INFO - 'sessionrestore_no_auto_restore']}, 06:56:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:56:10 INFO - 'tests': ['a11yr', 06:56:10 INFO - 'ts_paint', 06:56:10 INFO - 'tpaint', 06:56:10 INFO - 'sessionrestore', 06:56:10 INFO - 'sessionrestore_no_auto_restore']}, 06:56:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:56:10 INFO - 'tests': ['a11yr', 06:56:10 INFO - 'ts_paint', 06:56:10 INFO - 'tpaint', 06:56:10 INFO - 'sessionrestore', 06:56:10 INFO - 'sessionrestore_no_auto_restore']}, 06:56:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:56:10 INFO - 'tests': ['a11yr', 06:56:10 INFO - 'ts_paint', 06:56:10 INFO - 'tpaint', 06:56:10 INFO - 'sessionrestore', 06:56:10 INFO - 'sessionrestore_no_auto_restore']}, 06:56:10 INFO - 'other_l64': {'tests': ['a11yr', 06:56:10 INFO - 'ts_paint', 06:56:10 INFO - 'tpaint', 06:56:10 INFO - 'sessionrestore', 06:56:10 INFO - 'sessionrestore_no_auto_restore']}, 06:56:10 INFO - 'other_nol64': {'tests': ['a11yr', 06:56:10 INFO - 'ts_paint', 06:56:10 INFO - 'tpaint', 06:56:10 INFO - 'sessionrestore', 06:56:10 INFO - 'sessionrestore_no_auto_restore']}, 06:56:10 INFO - 'svgr': {'tests': ['tsvgx', 06:56:10 INFO - 'tsvgr_opacity', 06:56:10 INFO - 'tart', 06:56:10 INFO - 'tscrollx', 06:56:10 INFO - 'cart']}, 06:56:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:56:10 INFO - 'tests': ['tsvgx', 06:56:10 INFO - 'tsvgr_opacity', 06:56:10 INFO - 'tart', 06:56:10 INFO - 'tscrollx', 06:56:10 INFO - 'cart']}, 06:56:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:10 INFO - 'tests': ['tp5o']}, 06:56:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:10 INFO - 'talos_options': ['--e10s'], 06:56:10 INFO - 'tests': ['tp5o']}, 06:56:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:10 INFO - 'talos_options': ['--xperf_path', 06:56:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:56:10 INFO - 'tests': ['tp5n']}, 06:56:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:10 INFO - 'talos_options': ['--e10s', 06:56:10 INFO - '--xperf_path', 06:56:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:56:10 INFO - 'tests': ['tp5n']}}, 06:56:10 INFO - 'talos.zip': {'path': '', 06:56:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:56:10 INFO - Running post-action listener: _resource_record_post_action 06:56:10 INFO - ##### 06:56:10 INFO - ##### Running create-virtualenv step. 06:56:10 INFO - ##### 06:56:10 INFO - Running pre-action listener: _resource_record_pre_action 06:56:10 INFO - Running main action method: create_virtualenv 06:56:10 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:56:10 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 06:56:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:56:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:56:10 INFO - Using real prefix '/usr' 06:56:10 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:56:11 INFO - Installing distribute.............................................................................................................................................................................................done. 06:56:13 INFO - Installing pip.................done. 06:56:13 INFO - Return code: 0 06:56:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:56:13 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')]} 06:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:13 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')]} 06:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:13 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 0x7fae03aa2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7a90>, '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 0x2af9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afa2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', '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 06:56:13 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 06:56:13 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 06:56:13 INFO - Using env: {'DISPLAY': ':0', 06:56:13 INFO - 'HOME': '/home/cltbld', 06:56:13 INFO - 'LANG': 'en_US.UTF-8', 06:56:13 INFO - 'LANGUAGE': 'en_US:en', 06:56:13 INFO - 'LOGNAME': 'cltbld', 06:56:13 INFO - 'MAIL': '/var/mail/cltbld', 06:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:13 INFO - 'MOZ_NO_REMOTE': '1', 06:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:13 INFO - 'NO_EM_RESTART': '1', 06:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:13 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:13 INFO - 'SHELL': '/bin/bash', 06:56:13 INFO - 'SHLVL': '1', 06:56:13 INFO - 'TERM': 'linux', 06:56:13 INFO - 'TMOUT': '86400', 06:56:13 INFO - 'USER': 'cltbld', 06:56:13 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', 06:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:13 INFO - '_': '/tools/buildbot/bin/python'} 06:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:13 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 06:56:13 INFO - Cleaning up... 06:56:13 INFO - Return code: 0 06:56:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:56:13 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')]} 06:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:13 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')]} 06:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:13 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 0x7fae03aa2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7a90>, '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 0x2af9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afa2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', '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 06:56:13 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 06:56:13 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 06:56:13 INFO - Using env: {'DISPLAY': ':0', 06:56:13 INFO - 'HOME': '/home/cltbld', 06:56:13 INFO - 'LANG': 'en_US.UTF-8', 06:56:13 INFO - 'LANGUAGE': 'en_US:en', 06:56:13 INFO - 'LOGNAME': 'cltbld', 06:56:13 INFO - 'MAIL': '/var/mail/cltbld', 06:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:13 INFO - 'MOZ_NO_REMOTE': '1', 06:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:13 INFO - 'NO_EM_RESTART': '1', 06:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:13 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:13 INFO - 'SHELL': '/bin/bash', 06:56:13 INFO - 'SHLVL': '1', 06:56:13 INFO - 'TERM': 'linux', 06:56:13 INFO - 'TMOUT': '86400', 06:56:13 INFO - 'USER': 'cltbld', 06:56:13 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', 06:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:13 INFO - '_': '/tools/buildbot/bin/python'} 06:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:13 INFO - Downloading/unpacking psutil>=0.7.1 06:56:13 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 06:56:13 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 06:56:13 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 06:56:13 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 06:56:13 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 06:56:13 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 06:56:15 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:56:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:56:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:56:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:56:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:56:15 INFO - Installing collected packages: psutil 06:56:15 INFO - Running setup.py install for psutil 06:56:15 INFO - building 'psutil._psutil_linux' extension 06:56:15 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 06:56:15 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 06:56:15 INFO - building 'psutil._psutil_posix' extension 06:56:15 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 06:56:16 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 06:56:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:56:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:56:16 INFO - Successfully installed psutil 06:56:16 INFO - Cleaning up... 06:56:16 INFO - Return code: 0 06:56:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:56:16 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')]} 06:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:16 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')]} 06:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:16 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 0x7fae03aa2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7a90>, '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 0x2af9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afa2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', '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 06:56:16 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 06:56:16 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 06:56:16 INFO - Using env: {'DISPLAY': ':0', 06:56:16 INFO - 'HOME': '/home/cltbld', 06:56:16 INFO - 'LANG': 'en_US.UTF-8', 06:56:16 INFO - 'LANGUAGE': 'en_US:en', 06:56:16 INFO - 'LOGNAME': 'cltbld', 06:56:16 INFO - 'MAIL': '/var/mail/cltbld', 06:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:16 INFO - 'MOZ_NO_REMOTE': '1', 06:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:16 INFO - 'NO_EM_RESTART': '1', 06:56:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:16 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:16 INFO - 'SHELL': '/bin/bash', 06:56:16 INFO - 'SHLVL': '1', 06:56:16 INFO - 'TERM': 'linux', 06:56:16 INFO - 'TMOUT': '86400', 06:56:16 INFO - 'USER': 'cltbld', 06:56:16 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', 06:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:16 INFO - '_': '/tools/buildbot/bin/python'} 06:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:56:16 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 06:56:16 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 06:56:16 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 06:56:16 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 06:56:16 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 06:56:16 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 06:56:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:56:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:56:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:56:18 INFO - Installing collected packages: mozsystemmonitor 06:56:18 INFO - Running setup.py install for mozsystemmonitor 06:56:18 INFO - Successfully installed mozsystemmonitor 06:56:18 INFO - Cleaning up... 06:56:18 INFO - Return code: 0 06:56:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:18 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 0x7fae03aa2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7a90>, '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 0x2af9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afa2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', '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 06:56:18 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 06:56:18 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 06:56:18 INFO - Using env: {'DISPLAY': ':0', 06:56:18 INFO - 'HOME': '/home/cltbld', 06:56:18 INFO - 'LANG': 'en_US.UTF-8', 06:56:18 INFO - 'LANGUAGE': 'en_US:en', 06:56:18 INFO - 'LOGNAME': 'cltbld', 06:56:18 INFO - 'MAIL': '/var/mail/cltbld', 06:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:18 INFO - 'MOZ_NO_REMOTE': '1', 06:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:18 INFO - 'NO_EM_RESTART': '1', 06:56:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:18 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:18 INFO - 'SHELL': '/bin/bash', 06:56:18 INFO - 'SHLVL': '1', 06:56:18 INFO - 'TERM': 'linux', 06:56:18 INFO - 'TMOUT': '86400', 06:56:18 INFO - 'USER': 'cltbld', 06:56:18 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', 06:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:18 INFO - '_': '/tools/buildbot/bin/python'} 06:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:19 INFO - Downloading/unpacking blobuploader==1.2.4 06:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:20 INFO - Downloading blobuploader-1.2.4.tar.gz 06:56:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:56:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:56:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:56:20 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 06:56:20 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 06:56:20 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 06:56:20 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 06:56:20 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 06:56:20 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 06:56:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:56:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:56:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:21 INFO - Downloading docopt-0.6.1.tar.gz 06:56:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:56:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:56:21 INFO - Installing collected packages: blobuploader, requests, docopt 06:56:21 INFO - Running setup.py install for blobuploader 06:56:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:56:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:56:21 INFO - Running setup.py install for requests 06:56:21 INFO - Running setup.py install for docopt 06:56:22 INFO - Successfully installed blobuploader requests docopt 06:56:22 INFO - Cleaning up... 06:56:22 INFO - Return code: 0 06:56:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:56:22 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')]} 06:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:22 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')]} 06:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:22 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 0x7fae03aa2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7a90>, '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 0x2af9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afa2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', '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 06:56:22 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 06:56:22 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 06:56:22 INFO - Using env: {'DISPLAY': ':0', 06:56:22 INFO - 'HOME': '/home/cltbld', 06:56:22 INFO - 'LANG': 'en_US.UTF-8', 06:56:22 INFO - 'LANGUAGE': 'en_US:en', 06:56:22 INFO - 'LOGNAME': 'cltbld', 06:56:22 INFO - 'MAIL': '/var/mail/cltbld', 06:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:22 INFO - 'MOZ_NO_REMOTE': '1', 06:56:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:22 INFO - 'NO_EM_RESTART': '1', 06:56:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:22 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:22 INFO - 'SHELL': '/bin/bash', 06:56:22 INFO - 'SHLVL': '1', 06:56:22 INFO - 'TERM': 'linux', 06:56:22 INFO - 'TMOUT': '86400', 06:56:22 INFO - 'USER': 'cltbld', 06:56:22 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', 06:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:22 INFO - '_': '/tools/buildbot/bin/python'} 06:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:56:22 INFO - Running setup.py (path:/tmp/pip-Qt2kzI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:56:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:56:22 INFO - Running setup.py (path:/tmp/pip-jCrlpW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:56:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:56:22 INFO - Running setup.py (path:/tmp/pip-Gz14SR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:56:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:56:22 INFO - Running setup.py (path:/tmp/pip-995ZKX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:56:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:56:22 INFO - Running setup.py (path:/tmp/pip-i6L1CD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:56:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:56:22 INFO - Running setup.py (path:/tmp/pip-RNcVCa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:56:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:56:22 INFO - Running setup.py (path:/tmp/pip-4aA8ID-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:56:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:56:22 INFO - Running setup.py (path:/tmp/pip-jS2jfP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:56:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:56:22 INFO - Running setup.py (path:/tmp/pip-1U4ywG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:56:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:56:22 INFO - Running setup.py (path:/tmp/pip-d6kAUK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:56:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:56:22 INFO - Running setup.py (path:/tmp/pip-rBxJIz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:56:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:56:23 INFO - Running setup.py (path:/tmp/pip-Gh1Nvs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:56:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:56:23 INFO - Running setup.py (path:/tmp/pip-WJtQcl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:56:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:56:23 INFO - Running setup.py (path:/tmp/pip-ETzNfB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:56:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:56:23 INFO - Running setup.py (path:/tmp/pip-nOlntc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:56:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:56:23 INFO - Running setup.py (path:/tmp/pip-9cFnuR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:56:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:56:23 INFO - Running setup.py (path:/tmp/pip-kyhkaX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:56:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:56:23 INFO - Running setup.py install for manifestparser 06:56:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:56:23 INFO - Running setup.py install for mozcrash 06:56:23 INFO - Running setup.py install for mozdebug 06:56:23 INFO - Running setup.py install for mozdevice 06:56:23 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:56:23 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:56:23 INFO - Running setup.py install for mozfile 06:56:24 INFO - Running setup.py install for mozhttpd 06:56:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:56:24 INFO - Running setup.py install for mozinfo 06:56:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:56:24 INFO - Running setup.py install for mozInstall 06:56:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:56:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:56:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:56:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:56:24 INFO - Running setup.py install for mozleak 06:56:24 INFO - Running setup.py install for mozlog 06:56:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:56:24 INFO - Running setup.py install for moznetwork 06:56:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:56:24 INFO - Running setup.py install for mozprocess 06:56:24 INFO - Running setup.py install for mozprofile 06:56:24 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:56:24 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:56:24 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:56:24 INFO - Running setup.py install for mozrunner 06:56:24 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:56:24 INFO - Running setup.py install for mozscreenshot 06:56:25 INFO - Running setup.py install for moztest 06:56:25 INFO - Running setup.py install for mozversion 06:56:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:56:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:56:25 INFO - Cleaning up... 06:56:25 INFO - Return code: 0 06:56:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:25 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 0x7fae03aa2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7a90>, '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 0x2af9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afa2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', '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 06:56:25 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 06:56:25 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 06:56:25 INFO - Using env: {'DISPLAY': ':0', 06:56:25 INFO - 'HOME': '/home/cltbld', 06:56:25 INFO - 'LANG': 'en_US.UTF-8', 06:56:25 INFO - 'LANGUAGE': 'en_US:en', 06:56:25 INFO - 'LOGNAME': 'cltbld', 06:56:25 INFO - 'MAIL': '/var/mail/cltbld', 06:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:25 INFO - 'MOZ_NO_REMOTE': '1', 06:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:25 INFO - 'NO_EM_RESTART': '1', 06:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:25 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:25 INFO - 'SHELL': '/bin/bash', 06:56:25 INFO - 'SHLVL': '1', 06:56:25 INFO - 'TERM': 'linux', 06:56:25 INFO - 'TMOUT': '86400', 06:56:25 INFO - 'USER': 'cltbld', 06:56:25 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', 06:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:25 INFO - '_': '/tools/buildbot/bin/python'} 06:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:56:25 INFO - Running setup.py (path:/tmp/pip-nFh0wv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:56:25 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)) 06:56:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:56:25 INFO - Running setup.py (path:/tmp/pip-bclcit-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:56:25 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)) 06:56:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:56:25 INFO - Running setup.py (path:/tmp/pip-OKxfvq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:56:25 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)) 06:56:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:56:25 INFO - Running setup.py (path:/tmp/pip-ocJSs4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:56:25 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)) 06:56:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:56:25 INFO - Running setup.py (path:/tmp/pip-nN2kvt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:56:25 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)) 06:56:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:56:25 INFO - Running setup.py (path:/tmp/pip-jIU7A5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:56:25 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)) 06:56:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:56:25 INFO - Running setup.py (path:/tmp/pip-CUy_X_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:56:26 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)) 06:56:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:56:26 INFO - Running setup.py (path:/tmp/pip-TeuMZ0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:56:26 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)) 06:56:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:56:26 INFO - Running setup.py (path:/tmp/pip-EYvf_w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:56:26 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)) 06:56:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:56:26 INFO - Running setup.py (path:/tmp/pip-gDqurQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:56:26 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)) 06:56:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:56:26 INFO - Running setup.py (path:/tmp/pip-23sOhV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:56:26 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)) 06:56:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:56:26 INFO - Running setup.py (path:/tmp/pip-a2a0KF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:56:26 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)) 06:56:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:56:26 INFO - Running setup.py (path:/tmp/pip-ZM9ClC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:56:26 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)) 06:56:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:56:26 INFO - Running setup.py (path:/tmp/pip-b75qoT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:56:26 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)) 06:56:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:56:26 INFO - Running setup.py (path:/tmp/pip-BRg6dh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:56:26 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)) 06:56:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:56:26 INFO - Running setup.py (path:/tmp/pip-V7mysi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:56:26 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)) 06:56:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:56:26 INFO - Running setup.py (path:/tmp/pip-14bk1_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:56:26 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)) 06:56:26 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)) 06:56:26 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)) 06:56:26 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)) 06:56:26 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)) 06:56:26 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)) 06:56:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:56:26 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 06:56:26 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 06:56:26 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 06:56:26 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 06:56:26 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 06:56:26 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 06:56:28 INFO - Downloading blessings-1.5.1.tar.gz 06:56:28 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 06:56:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:56:28 INFO - Installing collected packages: blessings 06:56:28 INFO - Running setup.py install for blessings 06:56:28 INFO - Successfully installed blessings 06:56:28 INFO - Cleaning up... 06:56:28 INFO - Return code: 0 06:56:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:56:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:56:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:56:28 INFO - Reading from file tmpfile_stdout 06:56:28 INFO - Current package versions: 06:56:28 INFO - argparse == 1.2.1 06:56:28 INFO - blessings == 1.5.1 06:56:28 INFO - blobuploader == 1.2.4 06:56:28 INFO - docopt == 0.6.1 06:56:28 INFO - manifestparser == 1.1 06:56:28 INFO - mozInstall == 1.12 06:56:28 INFO - mozcrash == 0.16 06:56:28 INFO - mozdebug == 0.1 06:56:28 INFO - mozdevice == 0.47 06:56:28 INFO - mozfile == 1.2 06:56:28 INFO - mozhttpd == 0.7 06:56:28 INFO - mozinfo == 0.9 06:56:28 INFO - mozleak == 0.1 06:56:28 INFO - mozlog == 3.0 06:56:28 INFO - moznetwork == 0.27 06:56:28 INFO - mozprocess == 0.22 06:56:28 INFO - mozprofile == 0.27 06:56:28 INFO - mozrunner == 6.11 06:56:28 INFO - mozscreenshot == 0.1 06:56:28 INFO - mozsystemmonitor == 0.0 06:56:28 INFO - moztest == 0.7 06:56:28 INFO - mozversion == 1.4 06:56:28 INFO - psutil == 3.1.1 06:56:28 INFO - requests == 1.2.3 06:56:28 INFO - wsgiref == 0.1.2 06:56:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:56:28 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')]} 06:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:28 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')]} 06:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:28 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 0x7fae03aa2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7a90>, '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 0x2af9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afa2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', '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 06:56:28 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 06:56:28 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 06:56:28 INFO - Using env: {'DISPLAY': ':0', 06:56:28 INFO - 'HOME': '/home/cltbld', 06:56:28 INFO - 'LANG': 'en_US.UTF-8', 06:56:28 INFO - 'LANGUAGE': 'en_US:en', 06:56:28 INFO - 'LOGNAME': 'cltbld', 06:56:28 INFO - 'MAIL': '/var/mail/cltbld', 06:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:28 INFO - 'MOZ_NO_REMOTE': '1', 06:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:28 INFO - 'NO_EM_RESTART': '1', 06:56:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:28 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:28 INFO - 'SHELL': '/bin/bash', 06:56:28 INFO - 'SHLVL': '1', 06:56:28 INFO - 'TERM': 'linux', 06:56:28 INFO - 'TMOUT': '86400', 06:56:28 INFO - 'USER': 'cltbld', 06:56:28 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', 06:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:28 INFO - '_': '/tools/buildbot/bin/python'} 06:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:29 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)) 06:56:29 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)) 06:56:29 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)) 06:56:29 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)) 06:56:29 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)) 06:56:29 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)) 06:56:29 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)) 06:56:29 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)) 06:56:29 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)) 06:56:29 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)) 06:56:29 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)) 06:56:29 INFO - Cleaning up... 06:56:29 INFO - Return code: 0 06:56:29 INFO - Running post-action listener: _resource_record_post_action 06:56:29 INFO - Running post-action listener: _start_resource_monitoring 06:56:29 INFO - Starting resource monitoring. 06:56:29 INFO - ##### 06:56:29 INFO - ##### Running install step. 06:56:29 INFO - ##### 06:56:29 INFO - Running pre-action listener: _resource_record_pre_action 06:56:29 INFO - Running main action method: install 06:56:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:56:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:56:29 INFO - Reading from file tmpfile_stdout 06:56:29 INFO - Detecting whether we're running mozinstall >=1.0... 06:56:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:56:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:56:29 INFO - Reading from file tmpfile_stdout 06:56:29 INFO - Output received: 06:56:29 INFO - Usage: mozinstall [options] installer 06:56:29 INFO - Options: 06:56:29 INFO - -h, --help show this help message and exit 06:56:29 INFO - -d DEST, --destination=DEST 06:56:29 INFO - Directory to install application into. [default: 06:56:29 INFO - "/builds/slave/test-pgo"] 06:56:29 INFO - --app=APP Application being installed. [default: firefox] 06:56:29 INFO - mkdir: /builds/slave/test-pgo/build/application 06:56:29 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'] 06:56:29 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 06:56:43 INFO - Reading from file tmpfile_stdout 06:56:43 INFO - Output received: 06:56:43 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:56:43 INFO - Running post-action listener: _resource_record_post_action 06:56:43 INFO - ##### 06:56:43 INFO - ##### Running run-tests step. 06:56:43 INFO - ##### 06:56:43 INFO - Running pre-action listener: _resource_record_pre_action 06:56:43 INFO - Running main action method: run_tests 06:56:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:56:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:56:43 INFO - Python 2.7.3 06:56:43 INFO - Return code: 0 06:56:43 INFO - grabbing minidump binary from tooltool 06:56:43 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')]} 06:56:43 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 0x2aa7a90>, '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 0x2af9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afa2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:56:43 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 06:56:43 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 06:56:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:56:43 INFO - Return code: 0 06:56:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:56:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:56:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:56:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:56:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:56:43 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/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:56:43 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/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 06:56:43 INFO - Using env: {'DISPLAY': ':0', 06:56:43 INFO - 'HOME': '/home/cltbld', 06:56:43 INFO - 'LANG': 'en_US.UTF-8', 06:56:43 INFO - 'LANGUAGE': 'en_US:en', 06:56:43 INFO - 'LOGNAME': 'cltbld', 06:56:43 INFO - 'MAIL': '/var/mail/cltbld', 06:56:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:56:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:43 INFO - 'MOZ_NO_REMOTE': '1', 06:56:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:56:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:43 INFO - 'NO_EM_RESTART': '1', 06:56:43 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:43 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:43 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:56:43 INFO - 'SHELL': '/bin/bash', 06:56:43 INFO - 'SHLVL': '1', 06:56:43 INFO - 'TERM': 'linux', 06:56:43 INFO - 'TMOUT': '86400', 06:56:43 INFO - 'USER': 'cltbld', 06:56:43 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906', 06:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:43 INFO - '_': '/tools/buildbot/bin/python'} 06:56:43 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/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 06:56:44 INFO - mozversion INFO | application_buildid: 20151120043002 06:56:44 INFO - mozversion INFO | application_changeset: ec628289d8b4ed310463a0729c3e60a7798dfcac 06:56:44 INFO - mozversion INFO | application_display_name: Nightly 06:56:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:56:44 INFO - mozversion INFO | application_name: Firefox 06:56:44 INFO - mozversion INFO | application_remotingname: firefox 06:56:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:56:44 INFO - mozversion INFO | application_vendor: Mozilla 06:56:44 INFO - mozversion INFO | application_version: 45.0a1 06:56:44 INFO - mozversion INFO | platform_buildid: 20151120043002 06:56:44 INFO - mozversion INFO | platform_changeset: ec628289d8b4ed310463a0729c3e60a7798dfcac 06:56:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:56:44 INFO - mozversion INFO | platform_version: 45.0a1 06:56:44 INFO - 2015-11-20 06:56:44,073 DEBUG : using testdate: 1448031404 06:56:44 INFO - 2015-11-20 06:56:44,073 DEBUG : actual date: 1448031404 06:56:44 INFO - 2015-11-20 06:56:44,128 INFO : starting webserver on 'localhost:54755' 06:56:44 INFO - 2015-11-20 06:56:44,129 INFO : Starting test suite talos-linux64-ix-027.e 06:56:44 INFO - 2015-11-20 06:56:44,129 INFO : Starting test dromaeo_css 06:56:44 INFO - 2015-11-20 06:56:44,129 DEBUG : operating with platform_type : linux_ 06:56:44 INFO - 2015-11-20 06:56:44,130 INFO : Initialising browser for dromaeo_css test... 06:56:44 INFO - 2015-11-20 06:56:44,143 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLT71we/profile http://localhost:54755/getInfo.html 06:56:49 INFO - 2015-11-20 06:56:49,013 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:56:49 INFO - 2015-11-20 06:56:49,013 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:56:49 INFO - 2015-11-20 06:56:49,013 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:56:49 INFO - 2015-11-20 06:56:49,013 DEBUG : BROWSER_OUTPUT: __metrics 06:56:50 INFO - 2015-11-20 06:56:50,069 INFO : Browser initialized. 06:56:50 INFO - 2015-11-20 06:56:50,070 INFO : Running cycle 1/1 for dromaeo_css test... 06:56:50 INFO - 2015-11-20 06:56:50,070 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLT71we/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:57:01 INFO - 2015-11-20 06:57:01,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 141705216 06:57:01 INFO - 2015-11-20 06:57:01,850 DEBUG : BROWSER_OUTPUT: 06:57:51 INFO - 2015-11-20 06:57:51,480 DEBUG : BROWSER_OUTPUT: 1448031471476 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:00:00 INFO - 2015-11-20 07:00:00,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54755/tests/dromaeo/cssquery-ext.html) 07:00:01 INFO - 2015-11-20 07:00:01,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 147386368 07:00:01 INFO - 2015-11-20 07:00:01,675 DEBUG : BROWSER_OUTPUT: 07:03:03 INFO - 2015-11-20 07:03:03,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/dromaeo/cssquery-ext.html (next: http://localhost:54755/tests/dromaeo/cssquery-jquery.html) 07:03:04 INFO - 2015-11-20 07:03:04,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 142159872 07:03:04 INFO - 2015-11-20 07:03:04,242 DEBUG : BROWSER_OUTPUT: 07:06:05 INFO - 2015-11-20 07:06:05,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54755/tests/dromaeo/cssquery-mootools.html) 07:06:06 INFO - 2015-11-20 07:06:06,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 143642624 07:06:06 INFO - 2015-11-20 07:06:06,492 DEBUG : BROWSER_OUTPUT: 07:09:08 INFO - 2015-11-20 07:09:08,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54755/tests/dromaeo/cssquery-prototype.html) 07:09:08 INFO - 2015-11-20 07:09:08,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 140959744 07:09:08 INFO - 2015-11-20 07:09:08,749 DEBUG : BROWSER_OUTPUT: 07:12:11 INFO - 2015-11-20 07:12:11,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54755/tests/dromaeo/cssquery-yui.html) 07:12:11 INFO - 2015-11-20 07:12:11,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 142671872 07:12:11 INFO - 2015-11-20 07:12:11,738 DEBUG : BROWSER_OUTPUT: 07:15:13 INFO - 2015-11-20 07:15:13,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/dromaeo/cssquery-yui.html (next: http://localhost:54755/tests/dromaeo/cssquery-dojo.html) 07:15:14 INFO - 2015-11-20 07:15:14,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 144781312 07:15:14 INFO - 2015-11-20 07:15:14,121 DEBUG : BROWSER_OUTPUT: 07:15:14 INFO - 2015-11-20 07:15:14,121 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:15:14 INFO - 2015-11-20 07:15:14,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:15:14 INFO - 2015-11-20 07:15:14,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:15:14 INFO - 2015-11-20 07:15:14,121 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:15:14 INFO - 2015-11-20 07:15:14,121 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3227.7417806575468;3288.2601414681685;3298.422776014197;3329.716974057206;3337.5828021497314;5327.866803329909;5446.9106178764205;5559;5565.053940830058;5582.86042848929;5413.296271484702;5463.2078348639425;5527.474889885464;5641.971790141054;5642.802501912434;4942.357493525837;5015.398152221738;5053.797848086072;5075.061113693979;5100.770465329069;5093.465186155438;5155.587552995751;5193.506616871391;5208.817691380802;5212.192110222922;4872.415310162768;4966.726830024347;5133.8203162889495;5144.305518754976;5272.762725677335;4979.278004689336;5091.872703182413;5103.8213662522;5105;5105.2086926526445;5060.418051924039;5123.129068058439;5124.718140502271;5134.537891589737;5174.3790745110455;5105.055564720501;5201.245819356172;5254.65844720092;5385.246065550826;5449.700266485342;6072.939270607281;6073.969630151821;6077.270727512727;6080.118382834508;6137.41694539018;6083.239595050619;6120.081987701836;6123.265208175003;6159.87680246397;6167.87664246717;5451.100568406208;5528.5024347808485;5569.10894256921;5693.060644993612;5714.828555143353;6015.39846015395;6104.236970378703;6153.507719382439;6158.784442544489;6173.536984726164;5938.287405511366;5955.225820643289;5967;5970.671613061323;5989.161517387569;5835.066389377679;5862.237909071793;5925.762969481259;5957.821265362046;5990.161377407167;5883.529317654577;5990.64056156632;6019.187409699722;6020.337762846083;6029.366916473795;5925.851853703605;5984.3417224105315;6004.369541198199;6021.397860213943;6047;4486.798094085774;4487.4839393470165;4576.6109880660515;4593.609543188866;4593.931091033637;4096.467459230341;4113.814878330482;4118.361653943583;4123.546409894909;4160;5667.829965101054;5739.655620662774;5746.224259724967;5760.596758226968;5818.5054270386645;5764.279465066867;5868.295804503401;5878.588498805043;5970.9701451492465;6043.909341359883;5702.45826646468;5764.164196191613;5791.681457519877;5794.623349482355;5800.9419905800405;4987.551120399182;5104.3619547556555;5139.897202056013;5151.201563757623;5185.818496352685;6140.140380346755;6151.753929842756;6254.437100660963;6278.843028924222;6322.620642761449;6043.184170136975;6115.235595550556;6147.44672979434;6147.723352449061;6151.384861513813;6049.637021778707;6142;6305.96847015762;6345.555811093179;6354.936450635434;5799.710014499174;5808.883822323614;5826.096954971986;5840.678762667924;5843.649381037151;5825.446582574648;5937.614055086406;5947.821565353046;5953.374895635896;5999.610025348338;5829.300483941955;5919.911201331897;5968.045112781934;5968.552358573212;5974.133750606051;5770.480656740746;5803.419658034163;5895.94104058954;5919.85200369977;5934.584579079423;5790.160426738015;5821.912671310019;5849.795257165979;5853.0635098384055;5864.912026319524;5925.703714814328;5936.257967754031;5985.431384018511;5987;6004.579679422399;5603.271574695264;5625.043742563692;5760.510356619567;5829.854253643693;5847.327557330961 07:15:14 INFO - 2015-11-20 07:15:14,121 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.7411516587205;592.899207134787;599.0475144520212;599.955003374747;605.966671833049;38691.226175476506;39374.8031259844;39665.40501892474;39731.80134099333;39852.20295594086;42568.78715606425;42903.570964290346;42933.785331073304;42955;43041.784791076076;8690.652373905052;8773.254273386738;8796.8680469793;8843.77890552738;8848.911510884873;8498.660053597849;8570.057293697688;8598.355123365742;8625;8657.826843463126;8704.173103555184;8734.213920747132;8801.867971980426;8827.646894124227;8838.160374764388;8655.307575393985;8724.825503489958;8727.519986400745;8740.082291359442;8744.475331480131;8630.525321107336;8710.21608055278;8728.69449569262;8755.212030917248;8777.385583009192;40238.19523609541;40688.59311406907;40781;40812.591874081474;40993.59006409928;3317.618473875511;3343.782654127474;3442.913927151816;3487.843047062888;4008.498937632796;29789.851050744823;29822.70177298221;30394;30476.390472190433;31229.843850780828;3766.8304926278383;3798.924021519582;3817.3319669058083;3859.1316953685478;3989;263362;264740;266681;266913;268999.6550017257;41492.58507414947;59581.702091489264;60294.39705602888;60389;60453;41729.79135104305;41802.79098604548;41826.79086604548;41954.580454195064;41956;14642.85357146415;14665.120092794466;14731.116133032052;14731.189784561951;14734.263286835616;11665.650030499099;11676.591319303954;11689.532418703327;11695.064394848392;11741.76516469683;14457.421703131968;14500;14501.854981450262;14612.561623151323;14639.414423423157;5915.349311575723;5943.632964418121;5944.138099975479;5954.261039921598;6004.819855404257;887.2768693514765;902.7697937026016;972.4359871274644;974.6929717139078;1035.4460363705382;28008.719912801018;28099.71900280971;28250.576241356397;28366.574501382496;28415;1040.6825918095053;1053.3995622495104;1056.3292309383596;1088.3796236145479;1144.2835746380429;14836.406543738129;16596.751048734277;17012.82987170137;17077;17235.3967611133;397285;399624;400511;401015;401055;54801;55238.72380638152;55395;55396.44603553913;55510;1344.408460277475;1349.9190048597115;1352.702405470795;1357.077187512501;1358.4498278197345;29368;30626.693733062384;31840.840795795873;32984;33045.00864974054;49759.751201243766;50166.2475062867;50346.2448063272;50482.74758626183;50490;298601;299464;299902;300674;301496;41775.79112104542;42656.78671606622;42884.571154289304;43297.78351108224;43659.12681746411;49097.50902490929;51143;51182.488175117775;51649;52171;36602;36703.63296367109;37126.814365927996;37218;38340.42489362606;37509;37620.435693465166;38093;38289;38547.42178867263;36751.632483675894;36751.816240918626;37344.066398340256;37581.81209093937;37604.24791504209;33083.834580826944;35924.28151437009;38224.426633599964;38488.23023539458;38817.805910970266;24932.750672493043;25847.224583262534;26791.464170716867;27137.321566960985;27247.45505089927 07:15:14 INFO - 2015-11-20 07:15:14,121 DEBUG : BROWSER_OUTPUT: |2;jquery.html;346.5892916893483;356.51335926460376;359.2455842730265;359.94420864765954;362.4237462434728;16446.91776541117;17186.570335741613;17545.3859114931;18133.274669013255;18235.452936411897;11025.338479691223;11096.611618593352;11282.041026512736;11304.886951130486;11308.151888608347;4949.999999999991;4956.281339205831;5084.364454443176;5087.974560127194;5115.258287548303;5023.120953833083;5061.1143049966295;5072.898542029157;5074.568661663763;5080.034793389263;5054.595632349403;5068.645194836363;5086.186210206368;5274.05067087924;5294.973525132388;5109.499992505146;5199.5580375668305;5230.581553475713;5235.162374020158;5890.793822216202;5275.314209152785;5300.946990530084;5304.257403963448;5309.070912590281;5309.814156504543;12362.44369003397;13270.734585308337;19550.608987820164;20107.994600270074;20186.697199542017;2037.8879161646103;2059.7528296604355;2132.338974917765;2201.482651576894;2257.5146343536053;9589.952050239704;9590.616375344978;9865.556049977768;9905.059019393146;9933;1813.1115753280797;1822.571695651521;1830.8718389712726;1914.8851068935908;1918.9712154317697;60505;62423;62609;63040.369596304365;64491.355086449475;9841.950790246003;10160.4919754012;10233.9488302558;10300.175985921258;10390;13567.389467473988;13612.115212511155;13650.795238071438;13684.794728079087;13721.862781372258;7379.594122323217;7393.297636724503;7442.292982166686;7453.217412171753;7469.402447804163;7086.751963681247;7145.214026457085;7293.088363954505;7299.41604671625;7335.1197856257595;4390.209762242763;4409.206342858252;4441.311596702516;4445.955540444555;4463.598276155161;1740.7301868210448;1832.743415921772;1866.5240363707169;1878.821511956362;1896.2699360746212;420.47860652790934;439.9164158809816;464.9651276154302;804.4891493901415;896.9372143949992;10319.226058045526;10824.891751082547;10974.341539507655;16181.838181618268;16820.411285604947;901.8557030875029;904.6607522179182;906.4244204929917;934.6495064350869;963.7349728824489;9641.517924103768;9893.406395616286;9987.80024399508;10051.597936082475;10058;541589;542267;549621;564147;564348;42142.57857421448;80649.19350806533;83140;83142;84019.15980840113;1121.2151493954102;1132.2074547816726;1163.6043745126528;1201.0931746531312;1201.171191877619;15601.219939002778;15721.921390392974;15968;15985.920070399574;16278.67442651164;32097.679023209468;33506;33831.830840845636;34381.656183437844;35136;45260.09479810319;45340;46433;46505.6048318551;48373.27440088472;9038.141376569478;9170.312226582899;9259.212966897889;9292.442453452815;9365.063493650852;11368.94315528417;17022.659546809242;17697.38059167923;17961.191746371183;18345.633087337912;14287.357068931715;14317.355718992878;14354.641133971734;14497.20265385414;15208.46770363032;13995.16029038261;14020.439182432588;14394.136351818925;14761.335739891945;14868;14146.504872329419;14366.497172598909;14462.349194286073;14494.927525362305;14697.632559186106;9796.412215267106;9828.557714902989;10005.449700266265;10023.74940626461;10084.445355505517;13237.404316805574;14452.205128718022;14684.706305874037;14959;15110.54668359951 07:15:14 INFO - 2015-11-20 07:15:14,121 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1465.7874608181808;1716.6995775739247;1778.1464896849511;1783.7770278715152;1793.2557988434796;6857.45140388769;6966.79099627012;7824.413169012326;7950.36397088233;8004.759857204279;7665.5783931883725;7873.094594121678;7965.920340796591;7997.920020799805;8031.598420079002;2265.1958554713046;2292.713410823647;2294.8164146868294;2300.367398965281;2304.412374844412;2311.4452531392512;2349.236498138112;2370.7747763962484;2389.8566086034807;2395.6167013277877;2264.7169103862016;2265.6261716816707;2318.1538738360546;2319.2810228829117;2327.394877331889;2260.660900864867;2273.579387813243;2282.954340913189;2284.154862700803;2290.3701482092392;2331.440454290958;2350.941226469352;2356.5286942611547;2362.326736879998;2366.5858474766846;7940.602969851542;7991.200879911962;8011.599420029033;8017.318527925133;8048.758537243892;4709.552592503706;4741.691790033637;4757;4766.356541866839;4799.2321228603605;3177.364527094567;3178.9205269868207;3240.821754803485;3243.96756032439;3266.7549933755063;1031.381171297223;1044.1229367331478;1045.153425725165;1047.0785708576404;1094.075506197262;10866.293690910066;10875.83686244707;10922.836157457565;10958.068564172056;10961.232713710044;4281.550437204111;4284.592963668447;4325.6106950374615;4367.235733746646;4379.540148284448;9227.95386023079;9290.349675522648;9373.297002724823;9379;9382.953085234667;4713.552212539803;4724.456687480915;4735.83424580138;4742.146413645577;4745.477997420281;4205.495340559152;4267.039916018871;4282.100758840616;4368.475782906072;4371.912561748747;3642.21692336149;3647.7811331320204;3648.0515066083008;3678.8528458861883;3695.464157697119;1115.6653004098737;1128.6162704680285;1130.3556972525746;1131.4455916600807;1132.1056365471186;1303.739252149574;1314.4873499335267;1319.2678063674562;1346.145197799385;1365.3105181883086;7253.165885923187;7450.105987281452;7453.701851925971;7462.403007759366;7497.062867141607;490.9607231421478;492.9433115191727;496.63993604637074;496.6498618473967;507.99238011429856;5614.157876318585;5632.7746890123935;5657.773689052392;5709.143628455765;5717.828465146053;9057.728268151966;9382.71851844432;9476.384035037701;9639.518024098907;9642.951785241028;9322.533873306307;9330.160285574331;9371.250299975985;9447.716568502956;9465.148136667594;7194.712211511585;7326.120865496175;7329.74345897891;7404.222556631584;7414.110306763223;7136.571805691675;7169.103862017248;7171.067761191221;7208.495405321577;7219.711211551479;7857.332126769289;8007.279344858991;8219.83560328802;8268.586570671563;8288.461250018729;8383.03595086573;8417.452865563719;8452.1547845215;8477.067522572388;8497.915020849712;6916.204636466669;7034.5427547209265;7158.4273258140265;7202.89195662076;7299.343059124704;7700.613889499944;7737.5744334062165;7775.377969762519;7776.650050747617;7792.181820908723;7159.319864612853;7331.670074846538;7334.119905611361;7381.298776616213;7446.478746487694;7203.531770434905;7241.660292845841;7258.274172582699;7283.271672832674;7290.890636640561;7069.399101076466;7206.7117315306805;7242.891356629761;7254.89117663246;7259.818504537428;6527.445167160655;6551.115599394021;6563.245226798788;6569.080328753883;6576.901346479711;6650.667466626746;6755.932440675727;6757.966210168917;6758.932410676027;6776.119104516579 07:15:14 INFO - 2015-11-20 07:15:14,121 DEBUG : BROWSER_OUTPUT: |4;prototype.html;332.80697195626533;335.4699574672018;339.4450074128799;341.4962929678724;348.6983759048424;6222.751089956397;6285.748570057192;6333.904991425121;6377.968110159449;6423.261324947633;6110.20567326247;6225.097360882669;6258.687065646723;6263.561550691454;6313.842153946153;4734.692245004081;4738.218193997986;4739.170645137105;4749.335093086971;4753.714777113367;4755.191617425046;4763.166445871976;4763.857084287477;4769.856904292859;4772.069446457942;4636.768161591924;4703.15343238217;4724.503927087658;4748.192807222763;4748.5251474852585;4698.718076915396;4702.835400760991;4722.905541889178;4731.597814185781;4737.313089602023;4082.510098788164;4106.897327566805;4117.279476091672;4129.648979836687;4157.251694694954;5920.585559010871;5960.731767070492;5965.22452081231;5970.253718285215;5975.462208401222;5396.541293990015;5554.805581804618;5557.138643510262;5567.3040869891265;5568.276124103881;6653.4344580710695;6661.433778128865;6663.8005159071345;6675.930461556933;6679.499037572153;4627.421572303462;4629.23617603095;4631.096936097462;4633.9536604634195;4635.072985402933;6801.18385793703;6953.582785032914;6994.860102798018;6998.160220773489;6999.265077166926;4736.242201247784;4740.502247264057;4742.383490146328;4742.596879265301;4748.596369308648;4794.688345257547;4795.928061079087;4796.712197268175;4803.831865884677;4806.855794326176;5537.446255374431;5545.9722701387045;5556.222128901957;5558.221848941152;5566.777328906798;6617.569857959314;6757.966210169016;6759.729610815512;6761.4590832733265;6795.898061529081;1627.8128015278157;1649.9587510312338;1654.1977141086563;1659.6348803263263;1690.8900921440068;1095.058249905081;1113.7215696075982;1118.5078565431184;1119.6976816259564;1119.8040342939953;6375.585586936834;6376.52176086786;6421.678916054178;6434.356564343529;6443.452306553995;6814.352636499525;6848.280930502325;6851.109355783717;6889.104416425833;6889.552179108442;6376.968115159394;6377.71300291488;6401.711922963478;6423;6430.260520040161;3769.8115094245177;3784.299904517673;3797.525309336333;3800.315943130208;3806.8286927088348;7342;7364.484486085923;7366.373858222004;7372.59450730215;7383.889241661379;7028.297170282931;7218.67515961783;7238.203797582261;7250.4199664026755;7256.637168141572;7300.707971681073;7334.889976650355;7339.009233753482;7380.298871607189;7381.077365329334;6968.407685346802;6995.545289556366;7013.193482749549;7013.964930175316;7026.754063607954;6733.461323094239;6907.20567134786;6910.44716422695;6945.236024037251;6947.79156625302;7287.979682844512;7306.890396643948;7308.926910731037;7316.561006339637;7348.448866334939;4652.93020604698;4690.15577196108;4701.341812146371;4706.67053306279;4711.905761884812;6805.353491418307;6832.863342733217;6979.96510017467;7001.754938577125;7039.19049309336;6732.057511948429;6759.155105611799;6776.728930842711;6816.147981502312;6830.829229269308;6735.25912149673;6775.220849602359;6791.626460544718;6798.8640227196165;6801.8639627206185;6583;6658;6686.030525573862;6695.866082678416;6707.295733947865;6788.558743681645;6832.931670683429;6836.111305530249;6858.828529286808;6863.245043045361;6588.275289718223;6618.238902526271;6620.569662971891;6627.734890604322;6676.5645386242195 07:15:14 INFO - 2015-11-20 07:15:14,121 DEBUG : BROWSER_OUTPUT: |5;yui.html;759.1800855076518;847.8473874702555;850.243283477705;864.9740507784767;865.463412684136;13824.377902994363;13941.163530188196;14025.158490490578;14084.577462676136;14097.92951035246;12576.308303043328;12627.873721262784;12665.176763510366;12770.106092573524;12811.551595694129;806.0931452116355;815.8776183572452;821.1911267401605;822.4736168851939;823.7281697039963;781.4178437064395;815.0545367373818;817.0440584516131;826.3265438667466;828.5691440450962;862.0732712334235;862.5514732339211;863.7667829685981;864.0668078475231;866.2853146154448;851.8509260879383;852.4629483425433;853.5348235211825;856.2550580994543;863.4603372891943;630.9589876658002;631.7946667333135;632.4402903430497;635.7107516080173;636.325494975323;13137.474501019948;13405.46378144873;13426.194428334331;13428;13428.597142085753;11694.766104677943;11705.70735731605;11912.58305959296;11972.760544789142;12104.576339828152;10366;10503.2122590806;10590.205734569861;10593.417362045084;10765.354078755221;3429.8971030869116;3476.200473890994;3477.2176260341475;3484.2160513884173;3503.5095086687884;48207.75896120532;48281.75859120682;48329.5167048325;48557.271640925064;48595;8831.425957312755;9291.349605527548;9534.761630959281;9858;9975.750606234757;16435.91782041082;16593.170341483117;16593.336266549446;16605.169741512876;16695.74956375655;7183.820404489825;7281.890771638429;7363.631818409058;7447;7706.113796913427;4317.848875289413;4407.36093266481;4424.469063712375;4445.955540444619;4491.191585514639;3086.706762857525;3091.165385345989;3108.129723677374;3123.703248191418;3136.40408322418;562.9380768115504;567.5402923631872;574.379669956446;577.2466930655451;589.2251689028914;539.0378174957682;592.3441747861802;654.5287393076977;654.8493846415352;675.1021141881287;8154.143814899468;8225.95887020573;8373.37199710012;8456.830863382698;8520.8721869172;618.1346115438422;641.5477088652582;645.602954183174;650.9381608747161;653.8921078022073;3760.172761992357;3911.198204368098;3916.6475017248586;4007.919841603152;4080.959190408058;58572.70713646404;59967;60138;60153.39846601566;60365.396346036854;51881.2217816733;52505;52543.73728131335;52648.73675631597;52713.47286527162;46934.530654693015;47247.055058899314;47318.29022564664;47967;48050.519494804605;7771.805704857424;7929.762107136795;8050.758477245692;8118.634661440131;8183.005367614356;33434.45601163502;33633.83183084069;33955.66044339525;34559.65440345564;35267.47098793572;39999.40000900047;45690;45807.31289030734;45828;47023.529764703286;10008.349457285252;10071.546780394754;10075.647352342927;10137.695869123938;10246.231532634933;11079.833802492807;11239.55041798319;11242.381669007957;11334.093272538012;11400;10047.598096076075;10096.495175241356;10107.69676909694;10267.58929642806;10326.432046237529;10417.739556511147;10454.947725261629;10461.320014199053;10587.523561439908;10639.042486176282;9777.951110244403;10190.796184076129;10800.297980631234;11106.444677765918;11269.943650281695;9039.141281578239;9303.72088837336;9366.314481044126;9709;9780.853287200556;7652.885206722015;8094.311983481234;8183.836323273382;8259.256666900008;8594.699185528727 07:15:14 INFO - 2015-11-20 07:15:14,122 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:15:14 INFO - 2015-11-20 07:15:14,122 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:15:14 INFO - 2015-11-20 07:15:14,122 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,280 07:15:14 INFO - 2015-11-20 07:15:14,122 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:15:14 INFO - 2015-11-20 07:15:14,122 DEBUG : BROWSER_OUTPUT: __startTimestamp1448032514114__endTimestamp 07:15:14 INFO - 2015-11-20 07:15:14,122 DEBUG : BROWSER_OUTPUT: 07:15:14 INFO - 2015-11-20 07:15:14,122 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:15:14 INFO - 2015-11-20 07:15:14,122 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:15:14 INFO - 2015-11-20 07:15:14,122 DEBUG : BROWSER_OUTPUT: 07:15:14 INFO - 2015-11-20 07:15:14,122 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5569.10 Median:5808.88 stddev:640.26 (11.0%) stddev-sans-first:615.32 07:15:14 INFO - 2015-11-20 07:15:14,124 DEBUG : BROWSER_OUTPUT: Values: 3227.7 3288.3 3298.4 3329.7 3337.6 5327.9 5446.9 5559.0 5565.1 5582.9 5413.3 5463.2 5527.5 5642.0 5642.8 4942.4 5015.4 5053.8 5075.1 5100.8 5093.5 5155.6 5193.5 5208.8 5212.2 4872.4 4966.7 5133.8 5144.3 5272.8 4979.3 5091.9 5103.8 5105.0 5105.2 5060.4 5123.1 5124.7 5134.5 5174.4 5105.1 5201.2 5254.7 5385.2 5449.7 6072.9 6074.0 6077.3 6080.1 6137.4 6083.2 6120.1 6123.3 6159.9 6167.9 5451.1 5528.5 5569.1 5693.1 5714.8 6015.4 6104.2 6153.5 6158.8 6173.5 5938.3 5955.2 5967.0 5970.7 5989.2 5835.1 5862.2 5925.8 5957.8 5990.2 5883.5 5990.6 6019.2 6020.3 6029.4 5925.9 5984.3 6004.4 6021.4 6047.0 4486.8 4487.5 4576.6 4593.6 4593.9 4096.5 4113.8 4118.4 4123.5 4160.0 5667.8 5739.7 5746.2 5760.6 5818.5 5764.3 5868.3 5878.6 5971.0 6043.9 5702.5 5764.2 5791.7 5794.6 5800.9 4987.6 5104.4 5139.9 5151.2 5185.8 6140.1 6151.8 6254.4 6278.8 6322.6 6043.2 6115.2 6147.4 6147.7 6151.4 6049.6 6142.0 6306.0 6345.6 6354.9 5799.7 5808.9 5826.1 5840.7 5843.6 5825.4 5937.6 5947.8 5953.4 5999.6 5829.3 5919.9 5968.0 5968.6 5974.1 5770.5 5803.4 5895.9 5919.9 5934.6 5790.2 5821.9 5849.8 5853.1 5864.9 5925.7 5936.3 5985.4 5987.0 6004.6 5603.3 5625.0 5760.5 5829.9 5847.3 07:15:14 INFO - 2015-11-20 07:15:14,124 DEBUG : BROWSER_OUTPUT: 07:15:14 INFO - 2015-11-20 07:15:14,124 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49196.35 Median:39520.10 stddev:85872.51 (217.3%) stddev-sans-first:86035.73 07:15:14 INFO - 2015-11-20 07:15:14,124 DEBUG : BROWSER_OUTPUT: Values: 550.7 592.9 599.0 600.0 606.0 38691.2 39374.8 39665.4 39731.8 39852.2 42568.8 42903.6 42933.8 42955.0 43041.8 8690.7 8773.3 8796.9 8843.8 8848.9 8498.7 8570.1 8598.4 8625.0 8657.8 8704.2 8734.2 8801.9 8827.6 8838.2 8655.3 8724.8 8727.5 8740.1 8744.5 8630.5 8710.2 8728.7 8755.2 8777.4 40238.2 40688.6 40781.0 40812.6 40993.6 3317.6 3343.8 3442.9 3487.8 4008.5 29789.9 29822.7 30394.0 30476.4 31229.8 3766.8 3798.9 3817.3 3859.1 3989.0 263362.0 264740.0 266681.0 266913.0 268999.7 41492.6 59581.7 60294.4 60389.0 60453.0 41729.8 41802.8 41826.8 41954.6 41956.0 14642.9 14665.1 14731.1 14731.2 14734.3 11665.7 11676.6 11689.5 11695.1 11741.8 14457.4 14500.0 14501.9 14612.6 14639.4 5915.3 5943.6 5944.1 5954.3 6004.8 887.3 902.8 972.4 974.7 1035.4 28008.7 28099.7 28250.6 28366.6 28415.0 1040.7 1053.4 1056.3 1088.4 1144.3 14836.4 16596.8 17012.8 17077.0 17235.4 397285.0 399624.0 400511.0 401015.0 401055.0 54801.0 55238.7 55395.0 55396.4 55510.0 1344.4 1349.9 1352.7 1357.1 1358.4 29368.0 30626.7 31840.8 32984.0 33045.0 49759.8 50166.2 50346.2 50482.7 50490.0 298601.0 299464.0 299902.0 300674.0 301496.0 41775.8 42656.8 42884.6 43297.8 43659.1 49097.5 51143.0 51182.5 51649.0 52171.0 36602.0 36703.6 37126.8 37218.0 38340.4 37509.0 37620.4 38093.0 38289.0 38547.4 36751.6 36751.8 37344.1 37581.8 37604.2 33083.8 35924.3 38224.4 38488.2 38817.8 24932.8 25847.2 26791.5 27137.3 27247.5 07:15:14 INFO - 2015-11-20 07:15:14,124 DEBUG : BROWSER_OUTPUT: 07:15:14 INFO - 2015-11-20 07:15:14,124 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28762.87 Median:357.88 stddev:90272.19 (25224.2%) stddev-sans-first:90500.21 07:15:14 INFO - 2015-11-20 07:15:14,124 DEBUG : BROWSER_OUTPUT: Values: 346.6 356.5 359.2 359.9 362.4 16446.9 17186.6 17545.4 18133.3 18235.5 11025.3 11096.6 11282.0 11304.9 11308.2 4950.0 4956.3 5084.4 5088.0 5115.3 5023.1 5061.1 5072.9 5074.6 5080.0 5054.6 5068.6 5086.2 5274.1 5295.0 5109.5 5199.6 5230.6 5235.2 5890.8 5275.3 5300.9 5304.3 5309.1 5309.8 12362.4 13270.7 19550.6 20108.0 20186.7 2037.9 2059.8 2132.3 2201.5 2257.5 9590.0 9590.6 9865.6 9905.1 9933.0 1813.1 1822.6 1830.9 1914.9 1919.0 60505.0 62423.0 62609.0 63040.4 64491.4 9842.0 10160.5 10233.9 10300.2 10390.0 13567.4 13612.1 13650.8 13684.8 13721.9 7379.6 7393.3 7442.3 7453.2 7469.4 7086.8 7145.2 7293.1 7299.4 7335.1 4390.2 4409.2 4441.3 4446.0 4463.6 1740.7 1832.7 1866.5 1878.8 1896.3 420.5 439.9 465.0 804.5 896.9 10319.2 10824.9 10974.3 16181.8 16820.4 901.9 904.7 906.4 934.6 963.7 9641.5 9893.4 9987.8 10051.6 10058.0 541589.0 542267.0 549621.0 564147.0 564348.0 42142.6 80649.2 83140.0 83142.0 84019.2 1121.2 1132.2 1163.6 1201.1 1201.2 15601.2 15721.9 15968.0 15985.9 16278.7 32097.7 33506.0 33831.8 34381.7 35136.0 45260.1 45340.0 46433.0 46505.6 48373.3 9038.1 9170.3 9259.2 9292.4 9365.1 11368.9 17022.7 17697.4 17961.2 18345.6 14287.4 14317.4 14354.6 14497.2 15208.5 13995.2 14020.4 14394.1 14761.3 14868.0 14146.5 14366.5 14462.3 14494.9 14697.6 9796.4 9828.6 10005.4 10023.7 10084.4 13237.4 14452.2 14684.7 14959.0 15110.5 07:15:14 INFO - 2015-11-20 07:15:14,124 DEBUG : BROWSER_OUTPUT: 07:15:14 INFO - 2015-11-20 07:15:14,124 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5526.38 Median:6539.28 stddev:2872.09 (43.9%) stddev-sans-first:2863.93 07:15:14 INFO - 2015-11-20 07:15:14,126 DEBUG : BROWSER_OUTPUT: Values: 1465.8 1716.7 1778.1 1783.8 1793.3 6857.5 6966.8 7824.4 7950.4 8004.8 7665.6 7873.1 7965.9 7997.9 8031.6 2265.2 2292.7 2294.8 2300.4 2304.4 2311.4 2349.2 2370.8 2389.9 2395.6 2264.7 2265.6 2318.2 2319.3 2327.4 2260.7 2273.6 2283.0 2284.2 2290.4 2331.4 2350.9 2356.5 2362.3 2366.6 7940.6 7991.2 8011.6 8017.3 8048.8 4709.6 4741.7 4757.0 4766.4 4799.2 3177.4 3178.9 3240.8 3244.0 3266.8 1031.4 1044.1 1045.2 1047.1 1094.1 10866.3 10875.8 10922.8 10958.1 10961.2 4281.6 4284.6 4325.6 4367.2 4379.5 9228.0 9290.3 9373.3 9379.0 9383.0 4713.6 4724.5 4735.8 4742.1 4745.5 4205.5 4267.0 4282.1 4368.5 4371.9 3642.2 3647.8 3648.1 3678.9 3695.5 1115.7 1128.6 1130.4 1131.4 1132.1 1303.7 1314.5 1319.3 1346.1 1365.3 7253.2 7450.1 7453.7 7462.4 7497.1 491.0 492.9 496.6 496.6 508.0 5614.2 5632.8 5657.8 5709.1 5717.8 9057.7 9382.7 9476.4 9639.5 9643.0 9322.5 9330.2 9371.3 9447.7 9465.1 7194.7 7326.1 7329.7 7404.2 7414.1 7136.6 7169.1 7171.1 7208.5 7219.7 7857.3 8007.3 8219.8 8268.6 8288.5 8383.0 8417.5 8452.2 8477.1 8497.9 6916.2 7034.5 7158.4 7202.9 7299.3 7700.6 7737.6 7775.4 7776.7 7792.2 7159.3 7331.7 7334.1 7381.3 7446.5 7203.5 7241.7 7258.3 7283.3 7290.9 7069.4 7206.7 7242.9 7254.9 7259.8 6527.4 6551.1 6563.2 6569.1 6576.9 6650.7 6755.9 6758.0 6758.9 6776.1 07:15:14 INFO - 2015-11-20 07:15:14,126 DEBUG : BROWSER_OUTPUT: 07:15:14 INFO - 2015-11-20 07:15:14,126 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5616.51 Median:6377.34 stddev:1727.11 (27.1%) stddev-sans-first:1685.81 07:15:14 INFO - 2015-11-20 07:15:14,126 DEBUG : BROWSER_OUTPUT: Values: 332.8 335.5 339.4 341.5 348.7 6222.8 6285.7 6333.9 6378.0 6423.3 6110.2 6225.1 6258.7 6263.6 6313.8 4734.7 4738.2 4739.2 4749.3 4753.7 4755.2 4763.2 4763.9 4769.9 4772.1 4636.8 4703.2 4724.5 4748.2 4748.5 4698.7 4702.8 4722.9 4731.6 4737.3 4082.5 4106.9 4117.3 4129.6 4157.3 5920.6 5960.7 5965.2 5970.3 5975.5 5396.5 5554.8 5557.1 5567.3 5568.3 6653.4 6661.4 6663.8 6675.9 6679.5 4627.4 4629.2 4631.1 4634.0 4635.1 6801.2 6953.6 6994.9 6998.2 6999.3 4736.2 4740.5 4742.4 4742.6 4748.6 4794.7 4795.9 4796.7 4803.8 4806.9 5537.4 5546.0 5556.2 5558.2 5566.8 6617.6 6758.0 6759.7 6761.5 6795.9 1627.8 1650.0 1654.2 1659.6 1690.9 1095.1 1113.7 1118.5 1119.7 1119.8 6375.6 6376.5 6421.7 6434.4 6443.5 6814.4 6848.3 6851.1 6889.1 6889.6 6377.0 6377.7 6401.7 6423.0 6430.3 3769.8 3784.3 3797.5 3800.3 3806.8 7342.0 7364.5 7366.4 7372.6 7383.9 7028.3 7218.7 7238.2 7250.4 7256.6 7300.7 7334.9 7339.0 7380.3 7381.1 6968.4 6995.5 7013.2 7014.0 7026.8 6733.5 6907.2 6910.4 6945.2 6947.8 7288.0 7306.9 7308.9 7316.6 7348.4 4652.9 4690.2 4701.3 4706.7 4711.9 6805.4 6832.9 6980.0 7001.8 7039.2 6732.1 6759.2 6776.7 6816.1 6830.8 6735.3 6775.2 6791.6 6798.9 6801.9 6583.0 6658.0 6686.0 6695.9 6707.3 6788.6 6832.9 6836.1 6858.8 6863.2 6588.3 6618.2 6620.6 6627.7 6676.6 07:15:14 INFO - 2015-11-20 07:15:14,126 DEBUG : BROWSER_OUTPUT: 07:15:14 INFO - 2015-11-20 07:15:14,126 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13650.98 Median:48305.64 stddev:16313.09 (33.8%) stddev-sans-first:16330.13 07:15:14 INFO - 2015-11-20 07:15:14,127 DEBUG : BROWSER_OUTPUT: Values: 759.2 847.8 850.2 865.0 865.5 13824.4 13941.2 14025.2 14084.6 14097.9 12576.3 12627.9 12665.2 12770.1 12811.6 806.1 815.9 821.2 822.5 823.7 781.4 815.1 817.0 826.3 828.6 862.1 862.6 863.8 864.1 866.3 851.9 852.5 853.5 856.3 863.5 631.0 631.8 632.4 635.7 636.3 13137.5 13405.5 13426.2 13428.0 13428.6 11694.8 11705.7 11912.6 11972.8 12104.6 10366.0 10503.2 10590.2 10593.4 10765.4 3429.9 3476.2 3477.2 3484.2 3503.5 48207.8 48281.8 48329.5 48557.3 48595.0 8831.4 9291.3 9534.8 9858.0 9975.8 16435.9 16593.2 16593.3 16605.2 16695.7 7183.8 7281.9 7363.6 7447.0 7706.1 4317.8 4407.4 4424.5 4446.0 4491.2 3086.7 3091.2 3108.1 3123.7 3136.4 562.9 567.5 574.4 577.2 589.2 539.0 592.3 654.5 654.8 675.1 8154.1 8226.0 8373.4 8456.8 8520.9 618.1 641.5 645.6 650.9 653.9 3760.2 3911.2 3916.6 4007.9 4081.0 58572.7 59967.0 60138.0 60153.4 60365.4 51881.2 52505.0 52543.7 52648.7 52713.5 46934.5 47247.1 47318.3 47967.0 48050.5 7771.8 7929.8 8050.8 8118.6 8183.0 33434.5 33633.8 33955.7 34559.7 35267.5 39999.4 45690.0 45807.3 45828.0 47023.5 10008.3 10071.5 10075.6 10137.7 10246.2 11079.8 11239.6 11242.4 11334.1 11400.0 10047.6 10096.5 10107.7 10267.6 10326.4 10417.7 10454.9 10461.3 10587.5 10639.0 9778.0 10190.8 10800.3 11106.4 11269.9 9039.1 9303.7 9366.3 9709.0 9780.9 7652.9 8094.3 8183.8 8259.3 8594.7 07:15:14 INFO - 2015-11-20 07:15:14,127 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:15:14 INFO - 2015-11-20 07:15:14,128 DEBUG : BROWSER_OUTPUT: 07:15:14 INFO - 2015-11-20 07:15:14,725 INFO : Browser exited with error code: 0 07:15:14 INFO - 2015-11-20 07:15:14,747 INFO : Completed test dromaeo_css (00:18:30) 07:15:14 INFO - 2015-11-20 07:15:14,747 INFO : Starting test kraken 07:15:14 INFO - 2015-11-20 07:15:14,747 DEBUG : operating with platform_type : linux_ 07:15:14 INFO - 2015-11-20 07:15:14,747 INFO : Initialising browser for kraken test... 07:15:14 INFO - 2015-11-20 07:15:14,753 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplgACr2/profile http://localhost:54755/getInfo.html 07:15:19 INFO - 2015-11-20 07:15:19,638 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:15:19 INFO - 2015-11-20 07:15:19,638 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:15:19 INFO - 2015-11-20 07:15:19,638 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:15:19 INFO - 2015-11-20 07:15:19,638 DEBUG : BROWSER_OUTPUT: __metrics 07:15:20 INFO - 2015-11-20 07:15:20,733 INFO : Browser initialized. 07:15:20 INFO - 2015-11-20 07:15:20,734 INFO : Running cycle 1/1 for kraken test... 07:15:20 INFO - 2015-11-20 07:15:20,734 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplgACr2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:15:32 INFO - 2015-11-20 07:15:32,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 141996032 07:15:32 INFO - 2015-11-20 07:15:32,478 DEBUG : BROWSER_OUTPUT: 07:15:34 INFO - 2015-11-20 07:15:34,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54755/tests/kraken/driver.html?testName=audio-beat-detection) 07:15:35 INFO - 2015-11-20 07:15:35,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 141717504 07:15:35 INFO - 2015-11-20 07:15:35,539 DEBUG : BROWSER_OUTPUT: 07:15:38 INFO - 2015-11-20 07:15:38,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54755/tests/kraken/driver.html?testName=audio-dft) 07:15:38 INFO - 2015-11-20 07:15:38,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 142249984 07:15:38 INFO - 2015-11-20 07:15:38,745 DEBUG : BROWSER_OUTPUT: 07:15:41 INFO - 2015-11-20 07:15:41,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54755/tests/kraken/driver.html?testName=audio-fft) 07:15:42 INFO - 2015-11-20 07:15:42,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 137420800 07:15:42 INFO - 2015-11-20 07:15:42,179 DEBUG : BROWSER_OUTPUT: 07:15:44 INFO - 2015-11-20 07:15:44,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54755/tests/kraken/driver.html?testName=audio-oscillator) 07:15:44 INFO - 2015-11-20 07:15:44,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 136818688 07:15:44 INFO - 2015-11-20 07:15:44,733 DEBUG : BROWSER_OUTPUT: 07:15:46 INFO - 2015-11-20 07:15:46,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:15:47 INFO - 2015-11-20 07:15:47,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 137588736 07:15:47 INFO - 2015-11-20 07:15:47,473 DEBUG : BROWSER_OUTPUT: 07:15:50 INFO - 2015-11-20 07:15:50,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54755/tests/kraken/driver.html?testName=imaging-darkroom) 07:15:51 INFO - 2015-11-20 07:15:51,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 138588160 07:15:51 INFO - 2015-11-20 07:15:51,079 DEBUG : BROWSER_OUTPUT: 07:15:54 INFO - 2015-11-20 07:15:54,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54755/tests/kraken/driver.html?testName=imaging-desaturate) 07:15:55 INFO - 2015-11-20 07:15:55,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 138985472 07:15:55 INFO - 2015-11-20 07:15:55,054 DEBUG : BROWSER_OUTPUT: 07:15:57 INFO - 2015-11-20 07:15:57,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54755/tests/kraken/driver.html?testName=json-parse-financial) 07:15:58 INFO - 2015-11-20 07:15:58,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 139673600 07:15:58 INFO - 2015-11-20 07:15:58,483 DEBUG : BROWSER_OUTPUT: 07:16:00 INFO - 2015-11-20 07:16:00,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:16:00 INFO - 2015-11-20 07:16:00,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 138711040 07:16:00 INFO - 2015-11-20 07:16:00,684 DEBUG : BROWSER_OUTPUT: 07:16:02 INFO - 2015-11-20 07:16:02,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54755/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:16:03 INFO - 2015-11-20 07:16:03,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 139476992 07:16:03 INFO - 2015-11-20 07:16:03,106 DEBUG : BROWSER_OUTPUT: 07:16:05 INFO - 2015-11-20 07:16:05,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:16:05 INFO - 2015-11-20 07:16:05,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 139849728 07:16:05 INFO - 2015-11-20 07:16:05,772 DEBUG : BROWSER_OUTPUT: 07:16:08 INFO - 2015-11-20 07:16:08,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:16:08 INFO - 2015-11-20 07:16:08,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 140165120 07:16:08 INFO - 2015-11-20 07:16:08,819 DEBUG : BROWSER_OUTPUT: 07:16:11 INFO - 2015-11-20 07:16:11,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:16:11 INFO - 2015-11-20 07:16:11,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 140816384 07:16:11 INFO - 2015-11-20 07:16:11,956 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54755/tests/kraken/driver.html?testName=ai-astar) 07:16:13 INFO - 2015-11-20 07:16:13,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 139239424 07:16:13 INFO - 2015-11-20 07:16:13,907 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,910 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:16:13 INFO - 2015-11-20 07:16:13,910 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:16:13 INFO - 2015-11-20 07:16:13,910 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:16:13 INFO - 2015-11-20 07:16:13,911 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:16:13 INFO - 2015-11-20 07:16:13,911 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;105;111;109;110;121;110;109;110;109 07:16:13 INFO - 2015-11-20 07:16:13,911 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;126;148;160;127;160;151;127;163;126 07:16:13 INFO - 2015-11-20 07:16:13,911 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;160;162;165;165;164;165;176;162 07:16:13 INFO - 2015-11-20 07:16:13,911 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;72;71;74;73;73;138;71 07:16:13 INFO - 2015-11-20 07:16:13,911 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;128;90;89;89;144;89;89;136 07:16:13 INFO - 2015-11-20 07:16:13,911 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;109;110;111;110 07:16:13 INFO - 2015-11-20 07:16:13,911 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;145;148;146;146;147;146;147 07:16:13 INFO - 2015-11-20 07:16:13,912 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;97;96;96;96;95;96;97 07:16:13 INFO - 2015-11-20 07:16:13,912 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;67;66;66;67;68;69;67;70;65;66 07:16:13 INFO - 2015-11-20 07:16:13,912 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;69;70;70;70;70;69;70 07:16:13 INFO - 2015-11-20 07:16:13,912 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;92;86;84;86;84;85;85;85;89 07:16:13 INFO - 2015-11-20 07:16:13,912 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;119;124;125;117;118;121;116;121;126 07:16:13 INFO - 2015-11-20 07:16:13,912 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;140;150;161;149;148;156;148;167;147 07:16:13 INFO - 2015-11-20 07:16:13,912 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;70;69;69;68;69;71;69;72 07:16:13 INFO - 2015-11-20 07:16:13,913 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:16:13 INFO - 2015-11-20 07:16:13,913 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:16:13 INFO - 2015-11-20 07:16:13,913 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,700 07:16:13 INFO - 2015-11-20 07:16:13,913 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:16:13 INFO - 2015-11-20 07:16:13,913 DEBUG : BROWSER_OUTPUT: __startTimestamp1448032573908__endTimestamp 07:16:13 INFO - 2015-11-20 07:16:13,913 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,917 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:16:13 INFO - 2015-11-20 07:16:13,917 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:16:13 INFO - 2015-11-20 07:16:13,917 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,917 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.40 Median:110.00 stddev:4.06 (3.7%) stddev-sans-first:4.30 07:16:13 INFO - 2015-11-20 07:16:13,917 DEBUG : BROWSER_OUTPUT: Values: 110.0 105.0 111.0 109.0 110.0 121.0 110.0 109.0 110.0 109.0 07:16:13 INFO - 2015-11-20 07:16:13,917 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,917 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.90 Median:151.00 stddev:15.68 (10.4%) stddev-sans-first:16.42 07:16:13 INFO - 2015-11-20 07:16:13,918 DEBUG : BROWSER_OUTPUT: Values: 151.0 126.0 148.0 160.0 127.0 160.0 151.0 127.0 163.0 126.0 07:16:13 INFO - 2015-11-20 07:16:13,918 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,918 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:4.40 (2.7%) stddev-sans-first:4.64 07:16:13 INFO - 2015-11-20 07:16:13,918 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 160.0 162.0 165.0 165.0 164.0 165.0 176.0 162.0 07:16:13 INFO - 2015-11-20 07:16:13,918 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,918 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.90 Median:72.50 stddev:20.79 (28.7%) stddev-sans-first:21.90 07:16:13 INFO - 2015-11-20 07:16:13,918 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 72.0 71.0 74.0 73.0 73.0 138.0 71.0 07:16:13 INFO - 2015-11-20 07:16:13,919 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,919 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:89.00 stddev:22.88 (25.7%) stddev-sans-first:23.68 07:16:13 INFO - 2015-11-20 07:16:13,919 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 128.0 90.0 89.0 89.0 144.0 89.0 89.0 136.0 07:16:13 INFO - 2015-11-20 07:16:13,919 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,919 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:16:13 INFO - 2015-11-20 07:16:13,919 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 111.0 110.0 07:16:13 INFO - 2015-11-20 07:16:13,919 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,920 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 07:16:13 INFO - 2015-11-20 07:16:13,920 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 145.0 148.0 146.0 146.0 147.0 146.0 147.0 07:16:13 INFO - 2015-11-20 07:16:13,920 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,920 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:16:13 INFO - 2015-11-20 07:16:13,920 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 97.0 96.0 96.0 96.0 95.0 96.0 97.0 07:16:13 INFO - 2015-11-20 07:16:13,920 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,920 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:67.10 Median:67.00 stddev:1.52 (2.3%) stddev-sans-first:1.62 07:16:13 INFO - 2015-11-20 07:16:13,921 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 66.0 67.0 68.0 69.0 67.0 70.0 65.0 66.0 07:16:13 INFO - 2015-11-20 07:16:13,921 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,921 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 07:16:13 INFO - 2015-11-20 07:16:13,921 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 70.0 70.0 70.0 70.0 69.0 70.0 07:16:13 INFO - 2015-11-20 07:16:13,921 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,921 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.50 stddev:2.51 (2.9%) stddev-sans-first:2.64 07:16:13 INFO - 2015-11-20 07:16:13,921 DEBUG : BROWSER_OUTPUT: Values: 85.0 92.0 86.0 84.0 86.0 84.0 85.0 85.0 85.0 89.0 07:16:13 INFO - 2015-11-20 07:16:13,921 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,922 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:121.50 stddev:3.41 (2.8%) stddev-sans-first:3.60 07:16:13 INFO - 2015-11-20 07:16:13,922 DEBUG : BROWSER_OUTPUT: Values: 122.0 119.0 124.0 125.0 117.0 118.0 121.0 116.0 121.0 126.0 07:16:13 INFO - 2015-11-20 07:16:13,922 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,922 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:149.50 stddev:8.43 (5.6%) stddev-sans-first:8.18 07:16:13 INFO - 2015-11-20 07:16:13,922 DEBUG : BROWSER_OUTPUT: Values: 141.0 140.0 150.0 161.0 149.0 148.0 156.0 148.0 167.0 147.0 07:16:13 INFO - 2015-11-20 07:16:13,922 DEBUG : BROWSER_OUTPUT: 07:16:13 INFO - 2015-11-20 07:16:13,922 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 07:16:13 INFO - 2015-11-20 07:16:13,922 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 69.0 69.0 68.0 69.0 71.0 69.0 72.0 07:16:13 INFO - 2015-11-20 07:16:13,922 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:16:13 INFO - 2015-11-20 07:16:13,922 DEBUG : BROWSER_OUTPUT: 07:16:14 INFO - 2015-11-20 07:16:14,785 INFO : Browser exited with error code: 0 07:16:14 INFO - 2015-11-20 07:16:14,837 INFO : Completed test kraken (00:01:00) 07:16:14 INFO - 2015-11-20 07:16:14,837 INFO : Starting test v8_7 07:16:14 INFO - 2015-11-20 07:16:14,837 DEBUG : operating with platform_type : linux_ 07:16:14 INFO - 2015-11-20 07:16:14,838 INFO : Initialising browser for v8_7 test... 07:16:14 INFO - 2015-11-20 07:16:14,843 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTGYBVb/profile http://localhost:54755/getInfo.html 07:16:19 INFO - 2015-11-20 07:16:19,559 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:16:19 INFO - 2015-11-20 07:16:19,560 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:16:19 INFO - 2015-11-20 07:16:19,560 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:16:19 INFO - 2015-11-20 07:16:19,560 DEBUG : BROWSER_OUTPUT: __metrics 07:16:20 INFO - 2015-11-20 07:16:20,613 INFO : Browser initialized. 07:16:20 INFO - 2015-11-20 07:16:20,614 INFO : Running cycle 1/1 for v8_7 test... 07:16:20 INFO - 2015-11-20 07:16:20,614 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTGYBVb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:16:32 INFO - 2015-11-20 07:16:32,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 141697024 07:16:32 INFO - 2015-11-20 07:16:32,340 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54755/tests/v8_7/run.html (next: http://localhost:54755/tests/v8_7/run.html) 07:16:53 INFO - 2015-11-20 07:16:53,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 138391552 07:16:53 INFO - 2015-11-20 07:16:53,956 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,956 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:16:53 INFO - 2015-11-20 07:16:53,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:16:53 INFO - 2015-11-20 07:16:53,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:16:53 INFO - 2015-11-20 07:16:53,958 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:16:53 INFO - 2015-11-20 07:16:53,958 DEBUG : BROWSER_OUTPUT: |0;Richards;165.7000828500414 07:16:53 INFO - 2015-11-20 07:16:53,958 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.42803877703207 07:16:53 INFO - 2015-11-20 07:16:53,959 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.74115665356544 07:16:53 INFO - 2015-11-20 07:16:53,959 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 07:16:53 INFO - 2015-11-20 07:16:53,959 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1055.9662090813094 07:16:53 INFO - 2015-11-20 07:16:53,959 DEBUG : BROWSER_OUTPUT: |5;Earley;708.7172218284904 07:16:53 INFO - 2015-11-20 07:16:53,959 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 07:16:53 INFO - 2015-11-20 07:16:53,960 DEBUG : BROWSER_OUTPUT: |7;RegExp;25024.39024390244 07:16:53 INFO - 2015-11-20 07:16:53,960 DEBUG : BROWSER_OUTPUT: |8;Splay;645.2854393842207 07:16:53 INFO - 2015-11-20 07:16:53,960 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 07:16:53 INFO - 2015-11-20 07:16:53,960 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:16:53 INFO - 2015-11-20 07:16:53,960 DEBUG : BROWSER_OUTPUT: __startTimestamp1448032613956__endTimestamp 07:16:53 INFO - 2015-11-20 07:16:53,961 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,961 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:16:53 INFO - 2015-11-20 07:16:53,961 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:16:53 INFO - 2015-11-20 07:16:53,961 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,961 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.70 Median:165.70 stddev:0.00 (0.0%) 07:16:53 INFO - 2015-11-20 07:16:53,961 DEBUG : BROWSER_OUTPUT: Values: 165.7 07:16:53 INFO - 2015-11-20 07:16:53,962 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,962 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.43 Median:186.43 stddev:0.00 (0.0%) 07:16:53 INFO - 2015-11-20 07:16:53,962 DEBUG : BROWSER_OUTPUT: Values: 186.4 07:16:53 INFO - 2015-11-20 07:16:53,962 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,963 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 07:16:53 INFO - 2015-11-20 07:16:53,964 DEBUG : BROWSER_OUTPUT: Values: 280.7 07:16:53 INFO - 2015-11-20 07:16:53,964 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,964 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 07:16:53 INFO - 2015-11-20 07:16:53,964 DEBUG : BROWSER_OUTPUT: Values: 5035.2 07:16:53 INFO - 2015-11-20 07:16:53,964 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,964 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 07:16:53 INFO - 2015-11-20 07:16:53,964 DEBUG : BROWSER_OUTPUT: Values: 1056.0 07:16:53 INFO - 2015-11-20 07:16:53,964 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,965 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:708.72 Median:708.72 stddev:0.00 (0.0%) 07:16:53 INFO - 2015-11-20 07:16:53,965 DEBUG : BROWSER_OUTPUT: Values: 708.7 07:16:53 INFO - 2015-11-20 07:16:53,965 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,965 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 07:16:53 INFO - 2015-11-20 07:16:53,965 DEBUG : BROWSER_OUTPUT: Values: 12096.4 07:16:53 INFO - 2015-11-20 07:16:53,965 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,965 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25024.39 Median:25024.39 stddev:0.00 (0.0%) 07:16:53 INFO - 2015-11-20 07:16:53,966 DEBUG : BROWSER_OUTPUT: Values: 25024.4 07:16:53 INFO - 2015-11-20 07:16:53,966 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,966 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:645.29 Median:645.29 stddev:0.00 (0.0%) 07:16:53 INFO - 2015-11-20 07:16:53,966 DEBUG : BROWSER_OUTPUT: Values: 645.3 07:16:53 INFO - 2015-11-20 07:16:53,966 DEBUG : BROWSER_OUTPUT: 07:16:53 INFO - 2015-11-20 07:16:53,966 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 07:16:53 INFO - 2015-11-20 07:16:53,966 DEBUG : BROWSER_OUTPUT: Values: 4854.4 07:16:53 INFO - 2015-11-20 07:16:53,966 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:16:53 INFO - 2015-11-20 07:16:53,967 DEBUG : BROWSER_OUTPUT: 07:16:54 INFO - 2015-11-20 07:16:54,873 INFO : Browser exited with error code: 0 07:16:54 INFO - 2015-11-20 07:16:54,885 INFO : Completed test v8_7 (00:00:40) 07:16:55 INFO - 2015-11-20 07:16:55,016 INFO : Completed test suite (00:20:10) 07:16:55 INFO - 2015-11-20 07:16:55,016 DEBUG : Working with test: dromaeo_css 07:16:55 INFO - 2015-11-20 07:16:55,016 DEBUG : Generating results file: dromaeo_css 07:16:55 INFO - 2015-11-20 07:16:55,017 DEBUG : Working with test: kraken 07:16:55 INFO - 2015-11-20 07:16:55,017 DEBUG : Generating results file: kraken 07:16:55 INFO - 2015-11-20 07:16:55,018 INFO : javascript benchmark 07:16:55 INFO - 2015-11-20 07:16:55,018 DEBUG : Working with test: v8_7 07:16:55 INFO - 2015-11-20 07:16:55,018 DEBUG : Generating results file: v8_7 07:16:55 INFO - 2015-11-20 07:16:55,018 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:16:55 INFO - 2015-11-20 07:16:55,075 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:16:55 INFO - 2015-11-20 07:16:55,075 DEBUG : process_Request line: dromaeo_css 7056.67 graph.html#tests=[[72,1,43]] 07:16:55 INFO - 2015-11-20 07:16:55,075 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:16:55 INFO - 2015-11-20 07:16:55,107 DEBUG : process_Request line: kraken 1517.90 graph.html#tests=[[232,1,43]] 07:16:55 INFO - 2015-11-20 07:16:55,107 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:16:55 INFO - 2015-11-20 07:16:55,138 DEBUG : process_Request line: v8_7 21395.53 graph.html#tests=[[230,1,43]] 07:16:55 INFO - 2015-11-20 07:16:55,139 INFO : javascript benchmark 07:16:55 INFO - 2015-11-20 07:16:55,143 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3227.7417806575468, 3288.2601414681685, 3298.422776014197, 3329.716974057206, 3337.5828021497314, 5327.866803329909, 5446.9106178764205, 5559.0, 5565.053940830058, 5582.86042848929, 5413.296271484702, 5463.2078348639425, 5527.474889885464, 5641.971790141054, 5642.802501912434, 4942.357493525837, 5015.398152221738, 5053.797848086072, 5075.061113693979, 5100.770465329069, 5093.465186155438, 5155.587552995751, 5193.506616871391, 5208.817691380802, 5212.192110222922, 4872.415310162768, 4966.726830024347, 5133.8203162889495, 5144.305518754976, 5272.762725677335, 4979.278004689336, 5091.872703182413, 5103.8213662522, 5105.0, 5105.2086926526445, 5060.418051924039, 5123.129068058439, 5124.718140502271, 5134.537891589737, 5174.3790745110455, 5105.055564720501, 5201.245819356172, 5254.65844720092, 5385.246065550826, 5449.700266485342, 6072.939270607281, 6073.969630151821, 6077.270727512727, 6080.118382834508, 6137.41694539018, 6083.239595050619, 6120.081987701836, 6123.265208175003, 6159.87680246397, 6167.87664246717, 5451.100568406208, 5528.5024347808485, 5569.10894256921, 5693.060644993612, 5714.828555143353, 6015.39846015395, 6104.236970378703, 6153.507719382439, 6158.784442544489, 6173.536984726164, 5938.287405511366, 5955.225820643289, 5967.0, 5970.671613061323, 5989.161517387569, 5835.066389377679, 5862.237909071793, 5925.762969481259, 5957.821265362046, 5990.161377407167, 5883.529317654577, 5990.64056156632, 6019.187409699722, 6020.337762846083, 6029.366916473795, 5925.851853703605, 5984.3417224105315, 6004.369541198199, 6021.397860213943, 6047.0, 4486.798094085774, 4487.4839393470165, 4576.6109880660515, 4593.609543188866, 4593.931091033637, 4096.467459230341, 4113.814878330482, 4118.361653943583, 4123.546409894909, 4160.0, 5667.829965101054, 5739.655620662774, 5746.224259724967, 5760.596758226968, 5818.5054270386645, 5764.279465066867, 5868.295804503401, 5878.588498805043, 5970.9701451492465, 6043.909341359883, 5702.45826646468, 5764.164196191613, 5791.681457519877, 5794.623349482355, 5800.9419905800405, 4987.551120399182, 5104.3619547556555, 5139.897202056013, 5151.201563757623, 5185.818496352685, 6140.140380346755, 6151.753929842756, 6254.437100660963, 6278.843028924222, 6322.620642761449, 6043.184170136975, 6115.235595550556, 6147.44672979434, 6147.723352449061, 6151.384861513813, 6049.637021778707, 6142.0, 6305.96847015762, 6345.555811093179, 6354.936450635434, 5799.710014499174, 5808.883822323614, 5826.096954971986, 5840.678762667924, 5843.649381037151, 5825.446582574648, 5937.614055086406, 5947.821565353046, 5953.374895635896, 5999.610025348338, 5829.300483941955, 5919.911201331897, 5968.045112781934, 5968.552358573212, 5974.133750606051, 5770.480656740746, 5803.419658034163, 5895.94104058954, 5919.85200369977, 5934.584579079423, 5790.160426738015, 5821.912671310019, 5849.795257165979, 5853.0635098384055, 5864.912026319524, 5925.703714814328, 5936.257967754031, 5985.431384018511, 5987.0, 6004.579679422399, 5603.271574695264, 5625.043742563692, 5760.510356619567, 5829.854253643693, 5847.327557330961], "unit": "ms", "name": "dojo.html", "value": 5526.211655359812}, {"lowerIsBetter": false, "replicates": [550.7411516587205, 592.899207134787, 599.0475144520212, 599.955003374747, 605.966671833049, 38691.226175476506, 39374.8031259844, 39665.40501892474, 39731.80134099333, 39852.20295594086, 42568.78715606425, 42903.570964290346, 42933.785331073304, 42955.0, 43041.784791076076, 8690.652373905052, 8773.254273386738, 8796.8680469793, 8843.77890552738, 8848.911510884873, 8498.660053597849, 8570.057293697688, 8598.355123365742, 8625.0, 8657.826843463126, 8704.173103555184, 8734.213920747132, 8801.867971980426, 8827.646894124227, 8838.160374764388, 8655.307575393985, 8724.825503489958, 8727.519986400745, 8740.082291359442, 8744.475331480131, 8630.525321107336, 8710.21608055278, 8728.69449569262, 8755.212030917248, 8777.385583009192, 40238.19523609541, 40688.59311406907, 40781.0, 40812.591874081474, 40993.59006409928, 3317.618473875511, 3343.782654127474, 3442.913927151816, 3487.843047062888, 4008.498937632796, 29789.851050744823, 29822.70177298221, 30394.0, 30476.390472190433, 31229.843850780828, 3766.8304926278383, 3798.924021519582, 3817.3319669058083, 3859.1316953685478, 3989.0, 263362.0, 264740.0, 266681.0, 266913.0, 268999.6550017257, 41492.58507414947, 59581.702091489264, 60294.39705602888, 60389.0, 60453.0, 41729.79135104305, 41802.79098604548, 41826.79086604548, 41954.580454195064, 41956.0, 14642.85357146415, 14665.120092794466, 14731.116133032052, 14731.189784561951, 14734.263286835616, 11665.650030499099, 11676.591319303954, 11689.532418703327, 11695.064394848392, 11741.76516469683, 14457.421703131968, 14500.0, 14501.854981450262, 14612.561623151323, 14639.414423423157, 5915.349311575723, 5943.632964418121, 5944.138099975479, 5954.261039921598, 6004.819855404257, 887.2768693514765, 902.7697937026016, 972.4359871274644, 974.6929717139078, 1035.4460363705382, 28008.719912801018, 28099.71900280971, 28250.576241356397, 28366.574501382496, 28415.0, 1040.6825918095053, 1053.3995622495104, 1056.3292309383596, 1088.3796236145479, 1144.2835746380429, 14836.406543738129, 16596.751048734277, 17012.82987170137, 17077.0, 17235.3967611133, 397285.0, 399624.0, 400511.0, 401015.0, 401055.0, 54801.0, 55238.72380638152, 55395.0, 55396.44603553913, 55510.0, 1344.408460277475, 1349.9190048597115, 1352.702405470795, 1357.077187512501, 1358.4498278197345, 29368.0, 30626.693733062384, 31840.840795795873, 32984.0, 33045.00864974054, 49759.751201243766, 50166.2475062867, 50346.2448063272, 50482.74758626183, 50490.0, 298601.0, 299464.0, 299902.0, 300674.0, 301496.0, 41775.79112104542, 42656.78671606622, 42884.571154289304, 43297.78351108224, 43659.12681746411, 49097.50902490929, 51143.0, 51182.488175117775, 51649.0, 52171.0, 36602.0, 36703.63296367109, 37126.814365927996, 37218.0, 38340.42489362606, 37509.0, 37620.435693465166, 38093.0, 38289.0, 38547.42178867263, 36751.632483675894, 36751.816240918626, 37344.066398340256, 37581.81209093937, 37604.24791504209, 33083.834580826944, 35924.28151437009, 38224.426633599964, 38488.23023539458, 38817.805910970266, 24932.750672493043, 25847.224583262534, 26791.464170716867, 27137.321566960985, 27247.45505089927], "unit": "ms", "name": "ext.html", "value": 18694.986600851236}, {"lowerIsBetter": false, "replicates": [346.5892916893483, 356.51335926460376, 359.2455842730265, 359.94420864765954, 362.4237462434728, 16446.91776541117, 17186.570335741613, 17545.3859114931, 18133.274669013255, 18235.452936411897, 11025.338479691223, 11096.611618593352, 11282.041026512736, 11304.886951130486, 11308.151888608347, 4949.999999999991, 4956.281339205831, 5084.364454443176, 5087.974560127194, 5115.258287548303, 5023.120953833083, 5061.1143049966295, 5072.898542029157, 5074.568661663763, 5080.034793389263, 5054.595632349403, 5068.645194836363, 5086.186210206368, 5274.05067087924, 5294.973525132388, 5109.499992505146, 5199.5580375668305, 5230.581553475713, 5235.162374020158, 5890.793822216202, 5275.314209152785, 5300.946990530084, 5304.257403963448, 5309.070912590281, 5309.814156504543, 12362.44369003397, 13270.734585308337, 19550.608987820164, 20107.994600270074, 20186.697199542017, 2037.8879161646103, 2059.7528296604355, 2132.338974917765, 2201.482651576894, 2257.5146343536053, 9589.952050239704, 9590.616375344978, 9865.556049977768, 9905.059019393146, 9933.0, 1813.1115753280797, 1822.571695651521, 1830.8718389712726, 1914.8851068935908, 1918.9712154317697, 60505.0, 62423.0, 62609.0, 63040.369596304365, 64491.355086449475, 9841.950790246003, 10160.4919754012, 10233.9488302558, 10300.175985921258, 10390.0, 13567.389467473988, 13612.115212511155, 13650.795238071438, 13684.794728079087, 13721.862781372258, 7379.594122323217, 7393.297636724503, 7442.292982166686, 7453.217412171753, 7469.402447804163, 7086.751963681247, 7145.214026457085, 7293.088363954505, 7299.41604671625, 7335.1197856257595, 4390.209762242763, 4409.206342858252, 4441.311596702516, 4445.955540444555, 4463.598276155161, 1740.7301868210448, 1832.743415921772, 1866.5240363707169, 1878.821511956362, 1896.2699360746212, 420.47860652790934, 439.9164158809816, 464.9651276154302, 804.4891493901415, 896.9372143949992, 10319.226058045526, 10824.891751082547, 10974.341539507655, 16181.838181618268, 16820.411285604947, 901.8557030875029, 904.6607522179182, 906.4244204929917, 934.6495064350869, 963.7349728824489, 9641.517924103768, 9893.406395616286, 9987.80024399508, 10051.597936082475, 10058.0, 541589.0, 542267.0, 549621.0, 564147.0, 564348.0, 42142.57857421448, 80649.19350806533, 83140.0, 83142.0, 84019.15980840113, 1121.2151493954102, 1132.2074547816726, 1163.6043745126528, 1201.0931746531312, 1201.171191877619, 15601.219939002778, 15721.921390392974, 15968.0, 15985.920070399574, 16278.67442651164, 32097.679023209468, 33506.0, 33831.830840845636, 34381.656183437844, 35136.0, 45260.09479810319, 45340.0, 46433.0, 46505.6048318551, 48373.27440088472, 9038.141376569478, 9170.312226582899, 9259.212966897889, 9292.442453452815, 9365.063493650852, 11368.94315528417, 17022.659546809242, 17697.38059167923, 17961.191746371183, 18345.633087337912, 14287.357068931715, 14317.355718992878, 14354.641133971734, 14497.20265385414, 15208.46770363032, 13995.16029038261, 14020.439182432588, 14394.136351818925, 14761.335739891945, 14868.0, 14146.504872329419, 14366.497172598909, 14462.349194286073, 14494.927525362305, 14697.632559186106, 9796.412215267106, 9828.557714902989, 10005.449700266265, 10023.74940626461, 10084.445355505517, 13237.404316805574, 14452.205128718022, 14684.706305874037, 14959.0, 15110.54668359951], "unit": "ms", "name": "jquery.html", "value": 8565.905863029619}, {"lowerIsBetter": false, "replicates": [1465.7874608181808, 1716.6995775739247, 1778.1464896849511, 1783.7770278715152, 1793.2557988434796, 6857.45140388769, 6966.79099627012, 7824.413169012326, 7950.36397088233, 8004.759857204279, 7665.5783931883725, 7873.094594121678, 7965.920340796591, 7997.920020799805, 8031.598420079002, 2265.1958554713046, 2292.713410823647, 2294.8164146868294, 2300.367398965281, 2304.412374844412, 2311.4452531392512, 2349.236498138112, 2370.7747763962484, 2389.8566086034807, 2395.6167013277877, 2264.7169103862016, 2265.6261716816707, 2318.1538738360546, 2319.2810228829117, 2327.394877331889, 2260.660900864867, 2273.579387813243, 2282.954340913189, 2284.154862700803, 2290.3701482092392, 2331.440454290958, 2350.941226469352, 2356.5286942611547, 2362.326736879998, 2366.5858474766846, 7940.602969851542, 7991.200879911962, 8011.599420029033, 8017.318527925133, 8048.758537243892, 4709.552592503706, 4741.691790033637, 4757.0, 4766.356541866839, 4799.2321228603605, 3177.364527094567, 3178.9205269868207, 3240.821754803485, 3243.96756032439, 3266.7549933755063, 1031.381171297223, 1044.1229367331478, 1045.153425725165, 1047.0785708576404, 1094.075506197262, 10866.293690910066, 10875.83686244707, 10922.836157457565, 10958.068564172056, 10961.232713710044, 4281.550437204111, 4284.592963668447, 4325.6106950374615, 4367.235733746646, 4379.540148284448, 9227.95386023079, 9290.349675522648, 9373.297002724823, 9379.0, 9382.953085234667, 4713.552212539803, 4724.456687480915, 4735.83424580138, 4742.146413645577, 4745.477997420281, 4205.495340559152, 4267.039916018871, 4282.100758840616, 4368.475782906072, 4371.912561748747, 3642.21692336149, 3647.7811331320204, 3648.0515066083008, 3678.8528458861883, 3695.464157697119, 1115.6653004098737, 1128.6162704680285, 1130.3556972525746, 1131.4455916600807, 1132.1056365471186, 1303.739252149574, 1314.4873499335267, 1319.2678063674562, 1346.145197799385, 1365.3105181883086, 7253.165885923187, 7450.105987281452, 7453.701851925971, 7462.403007759366, 7497.062867141607, 490.9607231421478, 492.9433115191727, 496.63993604637074, 496.6498618473967, 507.99238011429856, 5614.157876318585, 5632.7746890123935, 5657.773689052392, 5709.143628455765, 5717.828465146053, 9057.728268151966, 9382.71851844432, 9476.384035037701, 9639.518024098907, 9642.951785241028, 9322.533873306307, 9330.160285574331, 9371.250299975985, 9447.716568502956, 9465.148136667594, 7194.712211511585, 7326.120865496175, 7329.74345897891, 7404.222556631584, 7414.110306763223, 7136.571805691675, 7169.103862017248, 7171.067761191221, 7208.495405321577, 7219.711211551479, 7857.332126769289, 8007.279344858991, 8219.83560328802, 8268.586570671563, 8288.461250018729, 8383.03595086573, 8417.452865563719, 8452.1547845215, 8477.067522572388, 8497.915020849712, 6916.204636466669, 7034.5427547209265, 7158.4273258140265, 7202.89195662076, 7299.343059124704, 7700.613889499944, 7737.5744334062165, 7775.377969762519, 7776.650050747617, 7792.181820908723, 7159.319864612853, 7331.670074846538, 7334.119905611361, 7381.298776616213, 7446.478746487694, 7203.531770434905, 7241.660292845841, 7258.274172582699, 7283.271672832674, 7290.890636640561, 7069.399101076466, 7206.7117315306805, 7242.891356629761, 7254.89117663246, 7259.818504537428, 6527.445167160655, 6551.115599394021, 6563.245226798788, 6569.080328753883, 6576.901346479711, 6650.667466626746, 6755.932440675727, 6757.966210168917, 6758.932410676027, 6776.119104516579], "unit": "ms", "name": "mootools.html", "value": 4476.216034508286}, {"lowerIsBetter": false, "replicates": [332.80697195626533, 335.4699574672018, 339.4450074128799, 341.4962929678724, 348.6983759048424, 6222.751089956397, 6285.748570057192, 6333.904991425121, 6377.968110159449, 6423.261324947633, 6110.20567326247, 6225.097360882669, 6258.687065646723, 6263.561550691454, 6313.842153946153, 4734.692245004081, 4738.218193997986, 4739.170645137105, 4749.335093086971, 4753.714777113367, 4755.191617425046, 4763.166445871976, 4763.857084287477, 4769.856904292859, 4772.069446457942, 4636.768161591924, 4703.15343238217, 4724.503927087658, 4748.192807222763, 4748.5251474852585, 4698.718076915396, 4702.835400760991, 4722.905541889178, 4731.597814185781, 4737.313089602023, 4082.510098788164, 4106.897327566805, 4117.279476091672, 4129.648979836687, 4157.251694694954, 5920.585559010871, 5960.731767070492, 5965.22452081231, 5970.253718285215, 5975.462208401222, 5396.541293990015, 5554.805581804618, 5557.138643510262, 5567.3040869891265, 5568.276124103881, 6653.4344580710695, 6661.433778128865, 6663.8005159071345, 6675.930461556933, 6679.499037572153, 4627.421572303462, 4629.23617603095, 4631.096936097462, 4633.9536604634195, 4635.072985402933, 6801.18385793703, 6953.582785032914, 6994.860102798018, 6998.160220773489, 6999.265077166926, 4736.242201247784, 4740.502247264057, 4742.383490146328, 4742.596879265301, 4748.596369308648, 4794.688345257547, 4795.928061079087, 4796.712197268175, 4803.831865884677, 4806.855794326176, 5537.446255374431, 5545.9722701387045, 5556.222128901957, 5558.221848941152, 5566.777328906798, 6617.569857959314, 6757.966210169016, 6759.729610815512, 6761.4590832733265, 6795.898061529081, 1627.8128015278157, 1649.9587510312338, 1654.1977141086563, 1659.6348803263263, 1690.8900921440068, 1095.058249905081, 1113.7215696075982, 1118.5078565431184, 1119.6976816259564, 1119.8040342939953, 6375.585586936834, 6376.52176086786, 6421.678916054178, 6434.356564343529, 6443.452306553995, 6814.352636499525, 6848.280930502325, 6851.109355783717, 6889.104416425833, 6889.552179108442, 6376.968115159394, 6377.71300291488, 6401.711922963478, 6423.0, 6430.260520040161, 3769.8115094245177, 3784.299904517673, 3797.525309336333, 3800.315943130208, 3806.8286927088348, 7342.0, 7364.484486085923, 7366.373858222004, 7372.59450730215, 7383.889241661379, 7028.297170282931, 7218.67515961783, 7238.203797582261, 7250.4199664026755, 7256.637168141572, 7300.707971681073, 7334.889976650355, 7339.009233753482, 7380.298871607189, 7381.077365329334, 6968.407685346802, 6995.545289556366, 7013.193482749549, 7013.964930175316, 7026.754063607954, 6733.461323094239, 6907.20567134786, 6910.44716422695, 6945.236024037251, 6947.79156625302, 7287.979682844512, 7306.890396643948, 7308.926910731037, 7316.561006339637, 7348.448866334939, 4652.93020604698, 4690.15577196108, 4701.341812146371, 4706.67053306279, 4711.905761884812, 6805.353491418307, 6832.863342733217, 6979.96510017467, 7001.754938577125, 7039.19049309336, 6732.057511948429, 6759.155105611799, 6776.728930842711, 6816.147981502312, 6830.829229269308, 6735.25912149673, 6775.220849602359, 6791.626460544718, 6798.8640227196165, 6801.8639627206185, 6583.0, 6658.0, 6686.030525573862, 6695.866082678416, 6707.295733947865, 6788.558743681645, 6832.931670683429, 6836.111305530249, 6858.828529286808, 6863.245043045361, 6588.275289718223, 6618.238902526271, 6620.569662971891, 6627.734890604322, 6676.5645386242195], "unit": "ms", "name": "prototype.html", "value": 5047.585260145333}, {"lowerIsBetter": false, "replicates": [759.1800855076518, 847.8473874702555, 850.243283477705, 864.9740507784767, 865.463412684136, 13824.377902994363, 13941.163530188196, 14025.158490490578, 14084.577462676136, 14097.92951035246, 12576.308303043328, 12627.873721262784, 12665.176763510366, 12770.106092573524, 12811.551595694129, 806.0931452116355, 815.8776183572452, 821.1911267401605, 822.4736168851939, 823.7281697039963, 781.4178437064395, 815.0545367373818, 817.0440584516131, 826.3265438667466, 828.5691440450962, 862.0732712334235, 862.5514732339211, 863.7667829685981, 864.0668078475231, 866.2853146154448, 851.8509260879383, 852.4629483425433, 853.5348235211825, 856.2550580994543, 863.4603372891943, 630.9589876658002, 631.7946667333135, 632.4402903430497, 635.7107516080173, 636.325494975323, 13137.474501019948, 13405.46378144873, 13426.194428334331, 13428.0, 13428.597142085753, 11694.766104677943, 11705.70735731605, 11912.58305959296, 11972.760544789142, 12104.576339828152, 10366.0, 10503.2122590806, 10590.205734569861, 10593.417362045084, 10765.354078755221, 3429.8971030869116, 3476.200473890994, 3477.2176260341475, 3484.2160513884173, 3503.5095086687884, 48207.75896120532, 48281.75859120682, 48329.5167048325, 48557.271640925064, 48595.0, 8831.425957312755, 9291.349605527548, 9534.761630959281, 9858.0, 9975.750606234757, 16435.91782041082, 16593.170341483117, 16593.336266549446, 16605.169741512876, 16695.74956375655, 7183.820404489825, 7281.890771638429, 7363.631818409058, 7447.0, 7706.113796913427, 4317.848875289413, 4407.36093266481, 4424.469063712375, 4445.955540444619, 4491.191585514639, 3086.706762857525, 3091.165385345989, 3108.129723677374, 3123.703248191418, 3136.40408322418, 562.9380768115504, 567.5402923631872, 574.379669956446, 577.2466930655451, 589.2251689028914, 539.0378174957682, 592.3441747861802, 654.5287393076977, 654.8493846415352, 675.1021141881287, 8154.143814899468, 8225.95887020573, 8373.37199710012, 8456.830863382698, 8520.8721869172, 618.1346115438422, 641.5477088652582, 645.602954183174, 650.9381608747161, 653.8921078022073, 3760.172761992357, 3911.198204368098, 3916.6475017248586, 4007.919841603152, 4080.959190408058, 58572.70713646404, 59967.0, 60138.0, 60153.39846601566, 60365.396346036854, 51881.2217816733, 52505.0, 52543.73728131335, 52648.73675631597, 52713.47286527162, 46934.530654693015, 47247.055058899314, 47318.29022564664, 47967.0, 48050.519494804605, 7771.805704857424, 7929.762107136795, 8050.758477245692, 8118.634661440131, 8183.005367614356, 33434.45601163502, 33633.83183084069, 33955.66044339525, 34559.65440345564, 35267.47098793572, 39999.40000900047, 45690.0, 45807.31289030734, 45828.0, 47023.529764703286, 10008.349457285252, 10071.546780394754, 10075.647352342927, 10137.695869123938, 10246.231532634933, 11079.833802492807, 11239.55041798319, 11242.381669007957, 11334.093272538012, 11400.0, 10047.598096076075, 10096.495175241356, 10107.69676909694, 10267.58929642806, 10326.432046237529, 10417.739556511147, 10454.947725261629, 10461.320014199053, 10587.523561439908, 10639.042486176282, 9777.951110244403, 10190.796184076129, 10800.297980631234, 11106.444677765918, 11269.943650281695, 9039.141281578239, 9303.72088837336, 9366.314481044126, 9709.0, 9780.853287200556, 7652.885206722015, 8094.311983481234, 8183.836323273382, 8259.256666900008, 8594.699185528727], "unit": "ms", "name": "yui.html", "value": 6175.059179999234}], "name": "dromaeo_css", "value": 7056.668876295484}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 111.0, 109.0, 110.0, 121.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [151.0, 126.0, 148.0, 160.0, 127.0, 160.0, 151.0, 127.0, 163.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.9}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 160.0, 162.0, 165.0, 165.0, 164.0, 165.0, 176.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 72.0, 71.0, 74.0, 73.0, 73.0, 138.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [89.0, 90.0, 128.0, 90.0, 89.0, 89.0, 144.0, 89.0, 89.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 103.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 145.0, 148.0, 146.0, 146.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 67.0, 68.0, 69.0, 67.0, 70.0, 65.0, 66.0], "unit": "ms", "name": "json-parse-financial", "value": 67.1}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 70.0, 70.0, 70.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [85.0, 92.0, 86.0, 84.0, 86.0, 84.0, 85.0, 85.0, 85.0, 89.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [122.0, 119.0, 124.0, 125.0, 117.0, 118.0, 121.0, 116.0, 121.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [141.0, 140.0, 150.0, 161.0, 149.0, 148.0, 156.0, 148.0, 167.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 69.0, 69.0, 68.0, 69.0, 71.0, 69.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1517.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.7000828500414], "unit": "score", "name": "Richards", "value": 213.04756999999998}, {"lowerIsBetter": false, "replicates": [186.42803877703207], "unit": "score", "name": "DeltaBlue", "value": 354.6569519999998}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [1055.9662090813094], "unit": "score", "name": "RayTrace", "value": 700.7695829999997}, {"lowerIsBetter": false, "replicates": [708.7172218284904], "unit": "score", "name": "Earley", "value": 940.379293}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [25024.39024390244], "unit": "score", "name": "RegExp", "value": 36.40388401559457}, {"lowerIsBetter": false, "replicates": [645.2854393842207], "unit": "score", "name": "Splay", "value": 126.28674850894632}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21395.532496504682}]} 07:16:55 INFO - RETURN: dromaeo_css: 7056.67 07:16:55 INFO - RETURN: kraken: 1517.90 07:16:55 INFO - RETURN: v8_7: 21395.53 07:16:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21395.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1517.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7056.67"}}} 07:16:55 INFO - Return code: 0 07:16:55 INFO - # TBPL SUCCESS # 07:16:55 INFO - Running post-action listener: _resource_record_post_action 07:16:55 INFO - Running post-run listener: _resource_record_post_run 07:16:56 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 602112; Write bytes: 279838720; Read time: 404; Write time: 199616 07:16:56 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 466944; Read time: 0; Write time: 40 07:16:56 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 602112; Write bytes: 272486400; Read time: 404; Write time: 198636 07:16:56 INFO - Running post-run listener: _upload_blobber_files 07:16:56 INFO - Blob upload gear active. 07:16:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:16:56 INFO - Copying logs to upload dir... 07:16:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1288.582500 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2015-11-20 07:16:56.378053) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 07:16:56.381528) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008639 build_url: 'https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 07:16:56.430358) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:16:56.430693) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448030650.948226-378628906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:16:56.479999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 07:16:56.480505) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 07:16:56.480852) ========= ========= Total master_lag: 0.20 =========