builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1448052755.28 results: success (0) buildid: 20151120103030 builduid: 8acaad21b7844ac4bbbfd3d6e0ef3603 revision: 0b2b0570777f82dc37a2af2e49e170114ff28e2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.276950) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.277452) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.277738) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006433 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.305931) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.306397) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.376520) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.376834) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.431382) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.431659) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.431993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.432279) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 12:52:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2015-11-20 12:52:35 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170050 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.616029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.616388) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016886 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.666263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.666642) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b2b0570777f82dc37a2af2e49e170114ff28e2b --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 0b2b0570777f82dc37a2af2e49e170114ff28e2b --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=d7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 12:52:35,723 truncating revision to first 12 chars 2015-11-20 12:52:35,723 Setting DEBUG logging. 2015-11-20 12:52:35,723 attempt 1/10 2015-11-20 12:52:35,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b2b0570777f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 12:52:36,006 unpacking tar archive at: mozilla-central-0b2b0570777f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574191 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:36.253564) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:36.253862) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:36.263879) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:36.264248) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:36.264677) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-20 12:52:36.264982) ========= /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=d7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:52:36 INFO - MultiFileLogger online at 20151120 12:52:36 in /builds/slave/test-pgo 12:52:36 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 12:52:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:52:36 INFO - {'append_to_log': False, 12:52:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:52:36 INFO - 'blob_upload_branch': 'Firefox', 12:52:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:52:36 INFO - 'branch': 'Firefox', 12:52:36 INFO - 'buildbot_json_path': 'buildprops.json', 12:52:36 INFO - 'config_files': ('talos/linux_config.py',), 12:52:36 INFO - 'default_actions': ('clobber', 12:52:36 INFO - 'read-buildbot-config', 12:52:36 INFO - 'download-and-extract', 12:52:36 INFO - 'populate-webroot', 12:52:36 INFO - 'create-virtualenv', 12:52:36 INFO - 'install', 12:52:36 INFO - 'run-tests'), 12:52:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:52:36 INFO - 'download_minidump_stackwalk': True, 12:52:36 INFO - 'download_symbols': 'ondemand', 12:52:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:52:36 INFO - 'tooltool.py': '/tools/tooltool.py', 12:52:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:52:36 INFO - '/tools/misc-python/virtualenv.py')}, 12:52:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:52:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:52:36 INFO - 'installer_path': 'installer.exe', 12:52:36 INFO - 'log_level': 'info', 12:52:36 INFO - 'log_name': 'talos', 12:52:36 INFO - 'log_to_console': True, 12:52:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:52:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:52:36 INFO - 'opt_config_files': (), 12:52:36 INFO - 'pip_index': False, 12:52:36 INFO - 'sps_profile': False, 12:52:36 INFO - 'sps_profile_interval': 0, 12:52:36 INFO - 'suite': 'dromaeojs-e10s', 12:52:36 INFO - 'system_bits': '64', 12:52:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:52:36 INFO - 'title': 'talos-linux64-ix-068', 12:52:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:52:36 INFO - 'use_talos_json': True, 12:52:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:52:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:52:36 INFO - 'work_dir': 'build'} 12:52:36 INFO - ##### 12:52:36 INFO - ##### Running clobber step. 12:52:36 INFO - ##### 12:52:36 INFO - Running pre-action listener: _resource_record_pre_action 12:52:36 INFO - Running main action method: clobber 12:52:36 INFO - rmtree: /builds/slave/test-pgo/build 12:52:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:52:36 INFO - Running post-action listener: _resource_record_post_action 12:52:36 INFO - ##### 12:52:36 INFO - ##### Running read-buildbot-config step. 12:52:36 INFO - ##### 12:52:36 INFO - Running pre-action listener: _resource_record_pre_action 12:52:36 INFO - Running main action method: read_buildbot_config 12:52:36 INFO - Using buildbot properties: 12:52:36 INFO - { 12:52:36 INFO - "properties": { 12:52:36 INFO - "buildnumber": 553, 12:52:36 INFO - "product": "firefox", 12:52:36 INFO - "script_repo_revision": "production", 12:52:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:52:36 INFO - "repository": "", 12:52:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 12:52:36 INFO - "buildid": "20151120103030", 12:52:36 INFO - "slavename": "talos-linux64-ix-068", 12:52:36 INFO - "pgo_build": "True", 12:52:36 INFO - "basedir": "/builds/slave/test-pgo", 12:52:36 INFO - "project": "", 12:52:36 INFO - "platform": "ubuntu64_hw", 12:52:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:52:36 INFO - "slavebuilddir": "test", 12:52:36 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 12:52:36 INFO - "branch": "mozilla-central", 12:52:36 INFO - "repo_path": "mozilla-central", 12:52:36 INFO - "stage_platform": "linux64-pgo", 12:52:36 INFO - "builduid": "8acaad21b7844ac4bbbfd3d6e0ef3603", 12:52:36 INFO - "revision": "0b2b0570777f82dc37a2af2e49e170114ff28e2b" 12:52:36 INFO - }, 12:52:36 INFO - "sourcestamp": { 12:52:36 INFO - "repository": "", 12:52:36 INFO - "hasPatch": false, 12:52:36 INFO - "project": "", 12:52:36 INFO - "branch": "mozilla-central-linux64-pgo-talos", 12:52:36 INFO - "changes": [ 12:52:36 INFO - { 12:52:36 INFO - "category": null, 12:52:36 INFO - "files": [ 12:52:36 INFO - { 12:52:36 INFO - "url": null, 12:52:36 INFO - "name": "https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:52:36 INFO - } 12:52:36 INFO - ], 12:52:36 INFO - "repository": "", 12:52:36 INFO - "rev": "0b2b0570777f82dc37a2af2e49e170114ff28e2b", 12:52:36 INFO - "who": "sendchange", 12:52:36 INFO - "when": 1448052730, 12:52:36 INFO - "number": 6690469, 12:52:36 INFO - "comments": "", 12:52:36 INFO - "project": "", 12:52:36 INFO - "at": "Fri 20 Nov 2015 12:52:10", 12:52:36 INFO - "branch": "mozilla-central-linux64-pgo-talos", 12:52:36 INFO - "revlink": "", 12:52:36 INFO - "properties": [ 12:52:36 INFO - [ 12:52:36 INFO - "buildid", 12:52:36 INFO - "20151120103030", 12:52:36 INFO - "Change" 12:52:36 INFO - ], 12:52:36 INFO - [ 12:52:36 INFO - "builduid", 12:52:36 INFO - "8acaad21b7844ac4bbbfd3d6e0ef3603", 12:52:36 INFO - "Change" 12:52:36 INFO - ], 12:52:36 INFO - [ 12:52:36 INFO - "pgo_build", 12:52:36 INFO - "True", 12:52:36 INFO - "Change" 12:52:36 INFO - ] 12:52:36 INFO - ], 12:52:36 INFO - "revision": "0b2b0570777f82dc37a2af2e49e170114ff28e2b" 12:52:36 INFO - } 12:52:36 INFO - ], 12:52:36 INFO - "revision": "0b2b0570777f82dc37a2af2e49e170114ff28e2b" 12:52:36 INFO - } 12:52:36 INFO - } 12:52:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:52:36 INFO - Running post-action listener: _resource_record_post_action 12:52:36 INFO - ##### 12:52:36 INFO - ##### Running download-and-extract step. 12:52:36 INFO - ##### 12:52:36 INFO - Running pre-action listener: _resource_record_pre_action 12:52:36 INFO - Running main action method: download_and_extract 12:52:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:36 INFO - https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/test_packages.json 12:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/test_packages.json 12:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:52:41 INFO - Downloaded 1302 bytes. 12:52:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:52:41 INFO - Using the following test package requirements: 12:52:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:52:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:52:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:41 INFO - u'jsshell-linux-x86_64.zip'], 12:52:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:52:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:52:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:52:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:52:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:52:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:52:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:52:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:41 INFO - https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:52:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:52:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:52:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:44 INFO - Downloaded 22524569 bytes. 12:52:44 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 12:52:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:52:44 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 12:52:45 INFO - Return code: 0 12:52:45 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 12:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:45 INFO - https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:52:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:52:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:52:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:47 INFO - Downloaded 22524569 bytes. 12:52:47 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 12:52:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:52:47 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 12:52:48 INFO - Return code: 0 12:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:48 INFO - https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:52:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:52:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:52:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:49 INFO - Downloaded 11130997 bytes. 12:52:49 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 12:52:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:52:49 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 12:52:50 INFO - Return code: 0 12:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:50 INFO - https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:52:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:52:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:52:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:51 INFO - Downloaded 57346809 bytes. 12:52:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:52:51 INFO - mkdir: /builds/slave/test-pgo/properties 12:52:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:52:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:52:51 INFO - Contents: 12:52:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:52:51 INFO - Running post-action listener: _resource_record_post_action 12:52:51 INFO - Running post-action listener: set_extra_try_arguments 12:52:51 INFO - ##### 12:52:51 INFO - ##### Running populate-webroot step. 12:52:51 INFO - ##### 12:52:51 INFO - Running pre-action listener: _resource_record_pre_action 12:52:51 INFO - Running main action method: populate_webroot 12:52:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:52:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:52:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:52:51 INFO - '../fennec_ids.txt'], 12:52:51 INFO - 'tests': ['tcheck2']}, 12:52:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:52:51 INFO - '--tppagecycles', 12:52:51 INFO - '7'], 12:52:51 INFO - 'tests': ['tsvgm']}}, 12:52:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:52:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:52:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:52:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:52:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'tests': ['damp', 'tps']}, 12:52:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['damp', 'tps']}, 12:52:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:52:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:52:51 INFO - 'other': {'tests': ['a11yr', 12:52:51 INFO - 'ts_paint', 12:52:51 INFO - 'tpaint', 12:52:51 INFO - 'sessionrestore', 12:52:51 INFO - 'sessionrestore_no_auto_restore']}, 12:52:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['a11yr', 12:52:51 INFO - 'ts_paint', 12:52:51 INFO - 'tpaint', 12:52:51 INFO - 'sessionrestore', 12:52:51 INFO - 'sessionrestore_no_auto_restore']}, 12:52:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['a11yr', 12:52:51 INFO - 'ts_paint', 12:52:51 INFO - 'tpaint', 12:52:51 INFO - 'sessionrestore', 12:52:51 INFO - 'sessionrestore_no_auto_restore']}, 12:52:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['a11yr', 12:52:51 INFO - 'ts_paint', 12:52:51 INFO - 'tpaint', 12:52:51 INFO - 'sessionrestore', 12:52:51 INFO - 'sessionrestore_no_auto_restore']}, 12:52:51 INFO - 'other_l64': {'tests': ['a11yr', 12:52:51 INFO - 'ts_paint', 12:52:51 INFO - 'tpaint', 12:52:51 INFO - 'sessionrestore', 12:52:51 INFO - 'sessionrestore_no_auto_restore']}, 12:52:51 INFO - 'other_nol64': {'tests': ['a11yr', 12:52:51 INFO - 'ts_paint', 12:52:51 INFO - 'tpaint', 12:52:51 INFO - 'sessionrestore', 12:52:51 INFO - 'sessionrestore_no_auto_restore']}, 12:52:51 INFO - 'svgr': {'tests': ['tsvgx', 12:52:51 INFO - 'tsvgr_opacity', 12:52:51 INFO - 'tart', 12:52:51 INFO - 'tscrollx', 12:52:51 INFO - 'cart']}, 12:52:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['tsvgx', 12:52:51 INFO - 'tsvgr_opacity', 12:52:51 INFO - 'tart', 12:52:51 INFO - 'tscrollx', 12:52:51 INFO - 'cart']}, 12:52:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'tests': ['tp5o']}, 12:52:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['tp5o']}, 12:52:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'talos_options': ['--xperf_path', 12:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:51 INFO - 'tests': ['tp5n']}, 12:52:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'talos_options': ['--e10s', 12:52:51 INFO - '--xperf_path', 12:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:51 INFO - 'tests': ['tp5n']}}, 12:52:51 INFO - 'talos.zip': {'path': '', 12:52:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:52:51 INFO - Running post-action listener: _resource_record_post_action 12:52:51 INFO - ##### 12:52:51 INFO - ##### Running create-virtualenv step. 12:52:51 INFO - ##### 12:52:51 INFO - Running pre-action listener: _resource_record_pre_action 12:52:51 INFO - Running main action method: create_virtualenv 12:52:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:52:51 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 12:52:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:52:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:52:51 INFO - Using real prefix '/usr' 12:52:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:52:52 INFO - Installing distribute.............................................................................................................................................................................................done. 12:52:54 INFO - Installing pip.................done. 12:52:54 INFO - Return code: 0 12:52:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:52: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')]} 12:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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')]} 12:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:54 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 0x7fefbf77dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dfd70>, '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 0x20e0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0fb0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', '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 12:52:54 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 12:52:54 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 12:52:54 INFO - Using env: {'DISPLAY': ':0', 12:52:54 INFO - 'HOME': '/home/cltbld', 12:52:54 INFO - 'LANG': 'en_US.UTF-8', 12:52:54 INFO - 'LANGUAGE': 'en_US:en', 12:52:54 INFO - 'LOGNAME': 'cltbld', 12:52:54 INFO - 'MAIL': '/var/mail/cltbld', 12:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:54 INFO - 'MOZ_NO_REMOTE': '1', 12:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:54 INFO - 'NO_EM_RESTART': '1', 12:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:54 INFO - 'SHELL': '/bin/bash', 12:52:54 INFO - 'SHLVL': '1', 12:52:54 INFO - 'TERM': 'linux', 12:52:54 INFO - 'TMOUT': '86400', 12:52:54 INFO - 'USER': 'cltbld', 12:52:54 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', 12:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:54 INFO - '_': '/tools/buildbot/bin/python'} 12:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:54 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 12:52:54 INFO - Cleaning up... 12:52:54 INFO - Return code: 0 12:52:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:52: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')]} 12:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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')]} 12:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:54 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 0x7fefbf77dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dfd70>, '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 0x20e0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0fb0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', '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 12:52:54 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 12:52:54 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 12:52:54 INFO - Using env: {'DISPLAY': ':0', 12:52:54 INFO - 'HOME': '/home/cltbld', 12:52:54 INFO - 'LANG': 'en_US.UTF-8', 12:52:54 INFO - 'LANGUAGE': 'en_US:en', 12:52:54 INFO - 'LOGNAME': 'cltbld', 12:52:54 INFO - 'MAIL': '/var/mail/cltbld', 12:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:54 INFO - 'MOZ_NO_REMOTE': '1', 12:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:54 INFO - 'NO_EM_RESTART': '1', 12:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:54 INFO - 'SHELL': '/bin/bash', 12:52:54 INFO - 'SHLVL': '1', 12:52:54 INFO - 'TERM': 'linux', 12:52:54 INFO - 'TMOUT': '86400', 12:52:54 INFO - 'USER': 'cltbld', 12:52:54 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', 12:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:54 INFO - '_': '/tools/buildbot/bin/python'} 12:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:54 INFO - Downloading/unpacking psutil>=0.7.1 12:52:54 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 12:52:54 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 12:52:54 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 12:52:54 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 12:52:54 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 12:52:54 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 12:52:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:52:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:52:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:52:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:57 INFO - Installing collected packages: psutil 12:52:57 INFO - Running setup.py install for psutil 12:52:57 INFO - building 'psutil._psutil_linux' extension 12:52:57 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 12:52:57 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 12:52:57 INFO - building 'psutil._psutil_posix' extension 12:52:57 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 12:52:57 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 12:52:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:57 INFO - Successfully installed psutil 12:52:57 INFO - Cleaning up... 12:52:57 INFO - Return code: 0 12:52:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fefbf77dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dfd70>, '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 0x20e0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0fb0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', '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 12:52:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 12:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:52:57 INFO - Using env: {'DISPLAY': ':0', 12:52:57 INFO - 'HOME': '/home/cltbld', 12:52:57 INFO - 'LANG': 'en_US.UTF-8', 12:52:57 INFO - 'LANGUAGE': 'en_US:en', 12:52:57 INFO - 'LOGNAME': 'cltbld', 12:52:57 INFO - 'MAIL': '/var/mail/cltbld', 12:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:57 INFO - 'MOZ_NO_REMOTE': '1', 12:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:57 INFO - 'NO_EM_RESTART': '1', 12:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:57 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:57 INFO - 'SHELL': '/bin/bash', 12:52:57 INFO - 'SHLVL': '1', 12:52:57 INFO - 'TERM': 'linux', 12:52:57 INFO - 'TMOUT': '86400', 12:52:57 INFO - 'USER': 'cltbld', 12:52:57 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', 12:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:57 INFO - '_': '/tools/buildbot/bin/python'} 12:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:52:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:52:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:52:59 INFO - Installing collected packages: mozsystemmonitor 12:52:59 INFO - Running setup.py install for mozsystemmonitor 12:52:59 INFO - Successfully installed mozsystemmonitor 12:52:59 INFO - Cleaning up... 12:52:59 INFO - Return code: 0 12:52:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fefbf77dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dfd70>, '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 0x20e0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0fb0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', '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 12:52:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 12:52:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:52:59 INFO - Using env: {'DISPLAY': ':0', 12:52:59 INFO - 'HOME': '/home/cltbld', 12:52:59 INFO - 'LANG': 'en_US.UTF-8', 12:52:59 INFO - 'LANGUAGE': 'en_US:en', 12:52:59 INFO - 'LOGNAME': 'cltbld', 12:52:59 INFO - 'MAIL': '/var/mail/cltbld', 12:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:59 INFO - 'MOZ_NO_REMOTE': '1', 12:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:59 INFO - 'NO_EM_RESTART': '1', 12:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:59 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:59 INFO - 'SHELL': '/bin/bash', 12:52:59 INFO - 'SHLVL': '1', 12:52:59 INFO - 'TERM': 'linux', 12:52:59 INFO - 'TMOUT': '86400', 12:52:59 INFO - 'USER': 'cltbld', 12:52:59 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', 12:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:59 INFO - '_': '/tools/buildbot/bin/python'} 12:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:00 INFO - Downloading/unpacking blobuploader==1.2.4 12:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:01 INFO - Downloading blobuploader-1.2.4.tar.gz 12:53:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:53:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:53:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:53:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:53:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:02 INFO - Downloading docopt-0.6.1.tar.gz 12:53:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:53:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:53:02 INFO - Installing collected packages: blobuploader, requests, docopt 12:53:02 INFO - Running setup.py install for blobuploader 12:53:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:53:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:53:02 INFO - Running setup.py install for requests 12:53:02 INFO - Running setup.py install for docopt 12:53:03 INFO - Successfully installed blobuploader requests docopt 12:53:03 INFO - Cleaning up... 12:53:03 INFO - Return code: 0 12:53:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:53:03 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')]} 12:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:03 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')]} 12:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:03 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 0x7fefbf77dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dfd70>, '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 0x20e0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0fb0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', '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 12:53:03 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 12:53:03 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 12:53:03 INFO - Using env: {'DISPLAY': ':0', 12:53:03 INFO - 'HOME': '/home/cltbld', 12:53:03 INFO - 'LANG': 'en_US.UTF-8', 12:53:03 INFO - 'LANGUAGE': 'en_US:en', 12:53:03 INFO - 'LOGNAME': 'cltbld', 12:53:03 INFO - 'MAIL': '/var/mail/cltbld', 12:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:03 INFO - 'MOZ_NO_REMOTE': '1', 12:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:03 INFO - 'NO_EM_RESTART': '1', 12:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:03 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:03 INFO - 'SHELL': '/bin/bash', 12:53:03 INFO - 'SHLVL': '1', 12:53:03 INFO - 'TERM': 'linux', 12:53:03 INFO - 'TMOUT': '86400', 12:53:03 INFO - 'USER': 'cltbld', 12:53:03 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', 12:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:03 INFO - '_': '/tools/buildbot/bin/python'} 12:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:53:03 INFO - Running setup.py (path:/tmp/pip-DE0W2k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:53:03 INFO - Running setup.py (path:/tmp/pip-JRBs6Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:53:03 INFO - Running setup.py (path:/tmp/pip-66UYbc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:53:03 INFO - Running setup.py (path:/tmp/pip-d7ZEl0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:53:03 INFO - Running setup.py (path:/tmp/pip-XcXIxx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:53:03 INFO - Running setup.py (path:/tmp/pip-u_b6b3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:53:03 INFO - Running setup.py (path:/tmp/pip-oOtd_8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:53:03 INFO - Running setup.py (path:/tmp/pip-WHXfUn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:53:03 INFO - Running setup.py (path:/tmp/pip-xPCVND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:53:03 INFO - Running setup.py (path:/tmp/pip-vANoVw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:53:04 INFO - Running setup.py (path:/tmp/pip-x08Eg_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:53:04 INFO - Running setup.py (path:/tmp/pip-iPgEHE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:53:04 INFO - Running setup.py (path:/tmp/pip-LKfBTA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:53:04 INFO - Running setup.py (path:/tmp/pip-qlipk8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:53:04 INFO - Running setup.py (path:/tmp/pip-GdZrqx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:53:04 INFO - Running setup.py (path:/tmp/pip-oTUDxx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:53:04 INFO - Running setup.py (path:/tmp/pip-qpOzZM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:53:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:53:04 INFO - Running setup.py install for manifestparser 12:53:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Running setup.py install for mozcrash 12:53:04 INFO - Running setup.py install for mozdebug 12:53:04 INFO - Running setup.py install for mozdevice 12:53:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Running setup.py install for mozfile 12:53:05 INFO - Running setup.py install for mozhttpd 12:53:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Running setup.py install for mozinfo 12:53:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Running setup.py install for mozInstall 12:53:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Running setup.py install for mozleak 12:53:05 INFO - Running setup.py install for mozlog 12:53:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Running setup.py install for moznetwork 12:53:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Running setup.py install for mozprocess 12:53:05 INFO - Running setup.py install for mozprofile 12:53:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Running setup.py install for mozrunner 12:53:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:53:06 INFO - Running setup.py install for mozscreenshot 12:53:06 INFO - Running setup.py install for moztest 12:53:06 INFO - Running setup.py install for mozversion 12:53:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:53:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:53:06 INFO - Cleaning up... 12:53:06 INFO - Return code: 0 12:53:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:53:06 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')]} 12:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:06 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')]} 12:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:06 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 0x7fefbf77dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dfd70>, '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 0x20e0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0fb0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', '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 12:53:06 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 12:53:06 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 12:53:06 INFO - Using env: {'DISPLAY': ':0', 12:53:06 INFO - 'HOME': '/home/cltbld', 12:53:06 INFO - 'LANG': 'en_US.UTF-8', 12:53:06 INFO - 'LANGUAGE': 'en_US:en', 12:53:06 INFO - 'LOGNAME': 'cltbld', 12:53:06 INFO - 'MAIL': '/var/mail/cltbld', 12:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:06 INFO - 'MOZ_NO_REMOTE': '1', 12:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:06 INFO - 'NO_EM_RESTART': '1', 12:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:06 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:06 INFO - 'SHELL': '/bin/bash', 12:53:06 INFO - 'SHLVL': '1', 12:53:06 INFO - 'TERM': 'linux', 12:53:06 INFO - 'TMOUT': '86400', 12:53:06 INFO - 'USER': 'cltbld', 12:53:06 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', 12:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:06 INFO - '_': '/tools/buildbot/bin/python'} 12:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:53:06 INFO - Running setup.py (path:/tmp/pip-W7Oz3a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:53:06 INFO - Running setup.py (path:/tmp/pip-SUkRYT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:53:06 INFO - Running setup.py (path:/tmp/pip-4IFcR8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:53:06 INFO - Running setup.py (path:/tmp/pip-YnbYdU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:53:06 INFO - Running setup.py (path:/tmp/pip-vW9DEJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:53:06 INFO - Running setup.py (path:/tmp/pip-5UnFzw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:53:06 INFO - Running setup.py (path:/tmp/pip-MIhEQk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:53:07 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)) 12:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:53:07 INFO - Running setup.py (path:/tmp/pip-ljsLYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:53:07 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)) 12:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:53:07 INFO - Running setup.py (path:/tmp/pip-58FpeU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:53:07 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)) 12:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:53:07 INFO - Running setup.py (path:/tmp/pip-RkAVXX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:53:07 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)) 12:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:53:07 INFO - Running setup.py (path:/tmp/pip-zrOD4w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:53:07 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)) 12:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:53:07 INFO - Running setup.py (path:/tmp/pip-v2HEyM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:53:07 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)) 12:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:53:07 INFO - Running setup.py (path:/tmp/pip-xo9zys-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:53:07 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)) 12:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:53:07 INFO - Running setup.py (path:/tmp/pip-1kixbP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:53:07 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)) 12:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:53:07 INFO - Running setup.py (path:/tmp/pip-AUfkty-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:53:07 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)) 12:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:53:07 INFO - Running setup.py (path:/tmp/pip-7pB3ma-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:53:07 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)) 12:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:53:07 INFO - Running setup.py (path:/tmp/pip-V9Arow-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:53:07 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)) 12:53:07 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)) 12:53:07 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)) 12:53:07 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)) 12:53:07 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)) 12:53:07 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)) 12:53:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:53:07 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 12:53:07 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 12:53:07 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 12:53:07 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 12:53:07 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 12:53:07 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 12:53:09 INFO - Downloading blessings-1.5.1.tar.gz 12:53:09 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 12:53:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:53:09 INFO - Installing collected packages: blessings 12:53:09 INFO - Running setup.py install for blessings 12:53:09 INFO - Successfully installed blessings 12:53:09 INFO - Cleaning up... 12:53:09 INFO - Return code: 0 12:53:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:53:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:53:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:53:09 INFO - Reading from file tmpfile_stdout 12:53:09 INFO - Current package versions: 12:53:09 INFO - argparse == 1.2.1 12:53:09 INFO - blessings == 1.5.1 12:53:09 INFO - blobuploader == 1.2.4 12:53:09 INFO - docopt == 0.6.1 12:53:09 INFO - manifestparser == 1.1 12:53:09 INFO - mozInstall == 1.12 12:53:09 INFO - mozcrash == 0.16 12:53:09 INFO - mozdebug == 0.1 12:53:09 INFO - mozdevice == 0.47 12:53:09 INFO - mozfile == 1.2 12:53:09 INFO - mozhttpd == 0.7 12:53:09 INFO - mozinfo == 0.9 12:53:09 INFO - mozleak == 0.1 12:53:09 INFO - mozlog == 3.0 12:53:09 INFO - moznetwork == 0.27 12:53:09 INFO - mozprocess == 0.22 12:53:09 INFO - mozprofile == 0.27 12:53:09 INFO - mozrunner == 6.11 12:53:09 INFO - mozscreenshot == 0.1 12:53:09 INFO - mozsystemmonitor == 0.0 12:53:09 INFO - moztest == 0.7 12:53:09 INFO - mozversion == 1.4 12:53:09 INFO - psutil == 3.1.1 12:53:09 INFO - requests == 1.2.3 12:53:09 INFO - wsgiref == 0.1.2 12:53:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:53: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')]} 12:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:09 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 0x7fefbf77dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dfd70>, '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 0x20e0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0fb0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', '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 12:53:09 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 12:53:09 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 12:53:09 INFO - Using env: {'DISPLAY': ':0', 12:53:09 INFO - 'HOME': '/home/cltbld', 12:53:09 INFO - 'LANG': 'en_US.UTF-8', 12:53:09 INFO - 'LANGUAGE': 'en_US:en', 12:53:09 INFO - 'LOGNAME': 'cltbld', 12:53:09 INFO - 'MAIL': '/var/mail/cltbld', 12:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:09 INFO - 'MOZ_NO_REMOTE': '1', 12:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:09 INFO - 'NO_EM_RESTART': '1', 12:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:09 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:09 INFO - 'SHELL': '/bin/bash', 12:53:09 INFO - 'SHLVL': '1', 12:53:09 INFO - 'TERM': 'linux', 12:53:09 INFO - 'TMOUT': '86400', 12:53:09 INFO - 'USER': 'cltbld', 12:53:09 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', 12:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:09 INFO - '_': '/tools/buildbot/bin/python'} 12:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:10 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)) 12:53:10 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)) 12:53:10 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)) 12:53:10 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)) 12:53:10 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)) 12:53:10 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)) 12:53:10 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)) 12:53:10 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)) 12:53:10 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)) 12:53:10 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)) 12:53:10 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)) 12:53:10 INFO - Cleaning up... 12:53:10 INFO - Return code: 0 12:53:10 INFO - Running post-action listener: _resource_record_post_action 12:53:10 INFO - Running post-action listener: _start_resource_monitoring 12:53:10 INFO - Starting resource monitoring. 12:53:10 INFO - ##### 12:53:10 INFO - ##### Running install step. 12:53:10 INFO - ##### 12:53:10 INFO - Running pre-action listener: _resource_record_pre_action 12:53:10 INFO - Running main action method: install 12:53:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:53:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:53:10 INFO - Reading from file tmpfile_stdout 12:53:10 INFO - Detecting whether we're running mozinstall >=1.0... 12:53:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:53:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:53:10 INFO - Reading from file tmpfile_stdout 12:53:10 INFO - Output received: 12:53:10 INFO - Usage: mozinstall [options] installer 12:53:10 INFO - Options: 12:53:10 INFO - -h, --help show this help message and exit 12:53:10 INFO - -d DEST, --destination=DEST 12:53:10 INFO - Directory to install application into. [default: 12:53:10 INFO - "/builds/slave/test-pgo"] 12:53:10 INFO - --app=APP Application being installed. [default: firefox] 12:53:10 INFO - mkdir: /builds/slave/test-pgo/build/application 12:53:10 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'] 12:53:10 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 12:53:24 INFO - Reading from file tmpfile_stdout 12:53:24 INFO - Output received: 12:53:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:53:24 INFO - Running post-action listener: _resource_record_post_action 12:53:24 INFO - ##### 12:53:24 INFO - ##### Running run-tests step. 12:53:24 INFO - ##### 12:53:24 INFO - Running pre-action listener: _resource_record_pre_action 12:53:24 INFO - Running main action method: run_tests 12:53:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:53:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:53:24 INFO - Python 2.7.3 12:53:24 INFO - Return code: 0 12:53:24 INFO - grabbing minidump binary from tooltool 12:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:24 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 0x20dfd70>, '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 0x20e0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:53:24 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 12:53:24 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 12:53:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:53:24 INFO - Return code: 0 12:53:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:53:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:53:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:53:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:53:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:53:24 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/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:53:24 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/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 12:53:24 INFO - Using env: {'DISPLAY': ':0', 12:53:24 INFO - 'HOME': '/home/cltbld', 12:53:24 INFO - 'LANG': 'en_US.UTF-8', 12:53:24 INFO - 'LANGUAGE': 'en_US:en', 12:53:24 INFO - 'LOGNAME': 'cltbld', 12:53:24 INFO - 'MAIL': '/var/mail/cltbld', 12:53:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:53:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:24 INFO - 'MOZ_NO_REMOTE': '1', 12:53:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:24 INFO - 'NO_EM_RESTART': '1', 12:53:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:24 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:53:24 INFO - 'SHELL': '/bin/bash', 12:53:24 INFO - 'SHLVL': '1', 12:53:24 INFO - 'TERM': 'linux', 12:53:24 INFO - 'TMOUT': '86400', 12:53:24 INFO - 'USER': 'cltbld', 12:53:24 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589', 12:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:24 INFO - '_': '/tools/buildbot/bin/python'} 12:53:24 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/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 12:53:25 INFO - mozversion INFO | application_buildid: 20151120103030 12:53:25 INFO - mozversion INFO | application_changeset: 0b2b0570777f82dc37a2af2e49e170114ff28e2b 12:53:25 INFO - mozversion INFO | application_display_name: Nightly 12:53:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:53:25 INFO - mozversion INFO | application_name: Firefox 12:53:25 INFO - mozversion INFO | application_remotingname: firefox 12:53:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 12:53:25 INFO - mozversion INFO | application_vendor: Mozilla 12:53:25 INFO - mozversion INFO | application_version: 45.0a1 12:53:25 INFO - mozversion INFO | platform_buildid: 20151120103030 12:53:25 INFO - mozversion INFO | platform_changeset: 0b2b0570777f82dc37a2af2e49e170114ff28e2b 12:53:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 12:53:25 INFO - mozversion INFO | platform_version: 45.0a1 12:53:25 INFO - 2015-11-20 12:53:25,149 DEBUG : using testdate: 1448052805 12:53:25 INFO - 2015-11-20 12:53:25,149 DEBUG : actual date: 1448052805 12:53:25 INFO - 2015-11-20 12:53:25,197 INFO : starting webserver on 'localhost:41019' 12:53:25 INFO - 2015-11-20 12:53:25,198 INFO : Starting test suite talos-linux64-ix-068.e 12:53:25 INFO - 2015-11-20 12:53:25,199 INFO : Starting test dromaeo_css 12:53:25 INFO - 2015-11-20 12:53:25,199 DEBUG : operating with platform_type : linux_ 12:53:25 INFO - 2015-11-20 12:53:25,199 INFO : Initialising browser for dromaeo_css test... 12:53:25 INFO - 2015-11-20 12:53:25,212 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8TcFWx/profile http://localhost:41019/getInfo.html 12:53:29 INFO - 2015-11-20 12:53:29,914 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:53:29 INFO - 2015-11-20 12:53:29,914 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:53:29 INFO - 2015-11-20 12:53:29,915 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:53:29 INFO - 2015-11-20 12:53:29,915 DEBUG : BROWSER_OUTPUT: __metrics 12:53:30 INFO - 2015-11-20 12:53:30,933 INFO : Browser initialized. 12:53:30 INFO - 2015-11-20 12:53:30,934 INFO : Running cycle 1/1 for dromaeo_css test... 12:53:30 INFO - 2015-11-20 12:53:30,934 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8TcFWx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:53:42 INFO - 2015-11-20 12:53:42,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 141664256 12:53:42 INFO - 2015-11-20 12:53:42,727 DEBUG : BROWSER_OUTPUT: 12:54:32 INFO - 2015-11-20 12:54:32,344 DEBUG : BROWSER_OUTPUT: 1448052872336 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] 12:56:40 INFO - 2015-11-20 12:56:40,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41019/tests/dromaeo/cssquery-ext.html) 12:56:42 INFO - 2015-11-20 12:56:42,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 145510400 12:56:42 INFO - 2015-11-20 12:56:42,063 DEBUG : BROWSER_OUTPUT: 12:59:44 INFO - 2015-11-20 12:59:44,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/dromaeo/cssquery-ext.html (next: http://localhost:41019/tests/dromaeo/cssquery-jquery.html) 12:59:44 INFO - 2015-11-20 12:59:44,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 141565952 12:59:44 INFO - 2015-11-20 12:59:44,659 DEBUG : BROWSER_OUTPUT: 13:02:46 INFO - 2015-11-20 13:02:46,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41019/tests/dromaeo/cssquery-mootools.html) 13:02:46 INFO - 2015-11-20 13:02:46,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 142348288 13:02:46 INFO - 2015-11-20 13:02:46,931 DEBUG : BROWSER_OUTPUT: 13:05:48 INFO - 2015-11-20 13:05:48,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41019/tests/dromaeo/cssquery-prototype.html) 13:05:49 INFO - 2015-11-20 13:05:49,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 141348864 13:05:49 INFO - 2015-11-20 13:05:49,153 DEBUG : BROWSER_OUTPUT: 13:08:51 INFO - 2015-11-20 13:08:51,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41019/tests/dromaeo/cssquery-yui.html) 13:08:52 INFO - 2015-11-20 13:08:52,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 141873152 13:08:52 INFO - 2015-11-20 13:08:52,065 DEBUG : BROWSER_OUTPUT: 13:11:54 INFO - 2015-11-20 13:11:54,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/dromaeo/cssquery-yui.html (next: http://localhost:41019/tests/dromaeo/cssquery-dojo.html) 13:11:54 INFO - 2015-11-20 13:11:54,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 144846848 13:11:54 INFO - 2015-11-20 13:11:54,766 DEBUG : BROWSER_OUTPUT: 13:11:54 INFO - 2015-11-20 13:11:54,767 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:11:54 INFO - 2015-11-20 13:11:54,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:11:54 INFO - 2015-11-20 13:11:54,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:11:54 INFO - 2015-11-20 13:11:54,767 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:11:54 INFO - 2015-11-20 13:11:54,769 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3227.8547465364054;3254.6745325467455;3275.197576593735;3291.1278511194537;3310.4703247480406;5381.623286369956;5435.9456405435985;5444.020076386249;5455.918161227575;5497.642653227543;5366.677999320033;5465.125579907216;5475.863103422416;5523.28197334347;5554.389017208114;4970.70175789452;5055.5702765265;5109;5122.974385128069;5138.100832354342;109.4244342722766;4926.753662316888;5002.199648056312;5036.848894533152;5044.520770526794;4875.829345972892;4960.131976904064;4968.354113965162;4980.526849949285;5000.949990500085;5000.924986125211;5027.371578552681;5037.345145131109;5055.721935293557;5085.364329458817;4825.806967721287;4885.609151267926;4932.062908047459;4990.351254336949;5018.648694591344;5287.995280896617;5327.573794096463;5341.172118321666;5353.732313384316;5387.353517577876;5940.079287710412;6021.066734656135;6026.638401695912;6029.698515074273;6032;5822.912656310159;5963.254593175853;5987.970060149715;5997;5997.310309314441;5542.9168562471195;5561.110222364443;5591.245181900432;5626.2967129108865;5630.634008789457;6093.776336793724;6101.641069425254;6109.236345456818;6115.605440958429;6123.112148738497;5867.706614669335;5885.264341957255;5892.587518873724;5893.469587737124;5924.289085309704;5799;5880.882382352329;5912.4923144598715;5998.910016349758;6021.458068773743;5934.7922822701;5943.465088142088;5957.821265362046;5974.551908606872;6046.606970546901;5920.348761636216;5924.348321684612;5956.52347812174;5958.910616340759;5982.760689572368;4448.488423831301;4519.050999290186;4530.320451932171;4563.703359281636;4567.954320456819;3948.881533553998;4052.4731784867777;4066.4916885389325;4076.5515793262716;4083.4895638045246;5695.772169113189;5710.571707121982;5736.13957906309;5748.482636562646;5769.336526299446;5889.911651325234;6016.308124565643;6020;6062.666553339521;6074.453299203093;5570.582206334541;5622.606417550732;5644.435556444405;5648.548116150698;5690.0895856663565;4966.15575352191;5004.974975125101;5018.548330650259;5041.117804384291;5046.495350464924;6008.429199226067;6027.156198132265;6048.304444988795;6070.848228794227;6117.736059405574;6021.337652858269;6025.728842202199;6047.78832740852;6053.485453736482;6065.090236464565;6225.564210505402;6228.968855155696;6236.407541283571;6239.188905442445;6251.437370636664;5725.0267454531995;5734.483896449339;5797.188393624811;5839.620424672383;5963.552733544915;5917.408259174048;5944.375840536854;5947;5947.821565353046;5967.31375891778;5794.1308803679785;5795.275590551181;5811.070228763378;5822.796202132905;5836.533077353886;5649.774009039593;5661.320641523043;5748.856278593069;5775.566832487664;5796.956547821264;5696.373398926032;5702.885942281048;5707.6575405475805;5725.942740572541;5734.3692193857805;5784.045632470764;5795.449432303924;5846.473817356458;5861.472467477947;5863.325717542537;5576;5636.323641163087;5639.8590035249445;5736.19693242938;5797.275340582427 13:11:54 INFO - 2015-11-20 13:11:54,770 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.1671531119351;584.2259006815968;591.1310373750586;603.3845477612836;608.8538750699834;40815;41246.79376603113;41275;41312.58687413125;41319.38020929685;43367;44006.339904901375;44030;44039.3394099088;44050.77974610122;8679.47923124613;8799.824003519925;8830.735077947671;8849.115088491164;8856.380053396264;8588.699395521158;8696.17386348299;8753.431026983257;8755.430896991675;8762.21140097391;8683.522406267653;8697;8752.518611476366;8790.296776257916;8805.42764720291;8653.740387788377;8747.912520874805;8755;8763.036066032731;8807.559622018873;8604;8732.47605143687;8741.300695944372;8751.649934002633;8772.561371931379;41421.58578414207;41730.79134604338;41820.581794182275;41868.371974420406;42038.78980605077;3289.5394644749754;3330.6835850594157;3378.712809411203;3725.5156829612247;3742.2141350316465;29987.550186747216;30390;31242.687573124203;31329.84335078333;31882.840585796923;3965.6017466470707;4032.6773858091283;4081.1429599784083;4089.0517817785535;4131.690123240769;270562;271036;271707;271819.999999998;272173;60879;61096;61125.69437152786;61291.387086129456;61819.690901546106;65617.34382656208;65920.6703966477;65997;66190.66904665445;72295.63852180811;15182.46861359847;15492.922535387477;15501.302441389938;15586.454474093352;15638.98346607467;11639.418029098511;11650.941745291218;11681;11690.357030363411;11698;21006.369808905758;21311.78688213129;21353.572928541344;21368.893155534435;21374.679379809317;7848.529088254723;8029.1167971524255;8051.315638170821;8060.234277743605;8126;990.8266053440764;1017.5065093429681;1047.5600247895902;1079.255313833468;1087.7443800706828;29605.85197074001;29746.40507189844;29789.255268618024;29929.251768705955;34113.317733645184;1035.7876635289747;1193.7612477504533;1194.9761004779855;1196.8803119688137;1211.6486218996567;15882.44411445617;16014.67970640604;16030.398031668054;16177.4337898173;16187.757183642254;387368;389196;393970;394054;394952;56048.719756400955;56501.71749141228;56578;56803.71598141983;56831.715841420526;1364.0519838712;1371.7805151175965;1376.483818568037;1376.7315373502272;1387.195426652539;27920;29711.55432668555;29718.702812971595;29732.40535189241;29837;41458;41544.58455415528;41650.791746041075;42668.35997460103;42785.78607107069;293390;293694;294463;295306;297657;33306.167345816546;45088.54911450844;45395;45558;45848;45553.31670025019;46361.53638463572;46395.53604463912;46494.53505464902;46729.53270467252;37239;37315.44026839654;38938.4159237606;39257.411138833515;39400.802995985985;38581.807090964365;39076;39257.607423925394;39344.80327598344;39802.2039559213;37560.624393755716;37565.81217093897;37617.62382376251;38083.428748568236;38155;32029.67970320267;35197.120071998404;35277.29445411129;35471.64528354684;36001.81999089988;26286.60570091412;26630.334241644116;27676.308092297855;27924.022659206832;27984.58023129614 13:11:54 INFO - 2015-11-20 13:11:54,773 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.8078637535731;360.04946940078196;360.6177451900987;361.0540384193413;363.723570086734;17046.914765426187;17574.209160587772;17877.910610446947;17926.64146717068;18789.436316910498;11539.192256542045;13114.672133196651;17089;17258.913705431485;17636.559086022855;4926.901461970768;5018.2974383586325;5085.821996230115;5095.923561146567;5109.386873575176;5030.924536131961;5055.443901170868;5058.519440653132;5060.671056381342;5068.949310506885;5253.763580638881;5412.648177868446;5413.106837371829;5515.4760297771645;5673.177389278552;5344.706041167715;5363.651362661453;5365.651232669864;5381.919271210896;5392.703401312926;5352.785888564453;5370.3287089113865;5380.273663055476;5382.67703937765;5388.030154572176;11924.224925379822;12166.452509637087;18510;18904.71642925357;19358.128884200105;1906.485248982767;1906.9713954290696;1963.5091227193202;2048.9180432782673;2054.5685406064745;9515.476648784314;9829.705108846745;9975.501224938796;10692.839607405895;12920.41858116387;1720.329071662053;1755.4382597568783;1810.900400477973;1811.429399739078;1819.372316550801;59846.700766496324;61733;61870.69064654693;63154.0526892097;63158.684206579135;10244.59021639141;10293.125084367912;10342.224333175041;10375.27373083877;10414.635487757892;13626.454941802414;13680;13711.725765484634;13740.519081832088;13780;7408.629568521553;7436.814079647944;7686.884696729554;7718.884216736754;7731.072271327364;7347.5224110432655;7353.669084891193;7359.37445317154;7393.778186654301;7456.51532650376;4456.153330867125;4492.9775351123035;4497.2804351304285;4503.256962601135;4530.682852200314;1822.5443639090226;1834.8807327523668;1849.898255595955;1898.1078892920304;1912.4645099372199;417.83077853469393;425.5786771096592;458.52084571622737;812.1999830167399;937.2127412972999;10654.307470014579;11208.04731597807;15846.76229856553;16601.667966640598;16738.665226695397;932.664240873285;945.6075728572703;949.6106596295624;956.4261443134203;961;9673.129418352382;9777.217822574177;10060.647877324258;10109.949450252849;10166.8474972874;491280;500761;514251;517946;522260;74951.62524187344;77380.61309693416;77486;77519;78281.2171878274;1133.393634405589;1178;1184.2598376014992;1186.1815347410259;1196.5931583261734;14820.777688334469;15014;15684.137372444626;15871.444499442465;16016.839831601535;31244.68755312418;31644;31822.840885795424;31968.840155799073;32416.513752293264;40771;44171.77914110538;44951.32573011342;45325.546744532134;47645.52354476411;14272.571822845332;14547;14770.261486925825;15188.392464301745;15327.770083448535;18534;18638.068096595387;18692.532686682942;18718.812811871707;19966.70049949281;9957.950210248902;9981.650642227487;10177.745556361151;10223.693289201336;10267.640632577824;10050;10129.240306976859;10205.38767673942;10241.539130739284;10507.579696812347;10080.495975201356;10540.209484288862;10702.678919632424;10752.51613677402;10955.890441095487;14919.25403729831;14970.775438368215;15133.697326053638;15278.312475938832;15284.235788210322;15708.214589270263;15925.68148637044;16019.759703604688;16161.27274272684;16545.172741362643 13:11:54 INFO - 2015-11-20 13:11:54,775 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1491.470527962574;1704.9829501704983;1764.3207365164408;1778.5375802291408;1780.5548612846785;7297.489175757699;7390.408767298617;7600.20197879223;7624.656890439923;7771.106322772883;7793.493422927506;7800.531968081905;7809.960950195241;7829.256220659028;7905.328047116002;2240.6863039174486;2292.495650956787;2295.2196253273883;2297.931062068132;2302.988485057581;2280.1107568048474;2288.347820871052;2346.577616029114;2348.037304705071;2348.8708121053337;2196.934091977243;2229.9331020069344;2251.966220506694;2252.0653928619604;2282.3267136194863;2169.425102347879;2227.888605569723;2253.8985745641485;2258.7515373308925;2262.6040442922504;2281.726192856868;2299.586074506588;2306.7116610423695;2313.8958746856433;2314.5023819878807;7609.353204977583;7615.504992175491;7630.809229769245;7640.312371886502;7677.769666909946;4619.12236675034;4712.64655150865;4722.929156062662;4730.526947305242;4734.928976065362;3024.7882648214636;3065.2336915771057;3096.814191148538;3136.2002689314077;3139.827309497977;984.0012387426767;1006.8338724110513;1037.31537185458;1047.958081676732;1048.3459045578775;10300.918403567668;10324.380537167794;10340.534675939525;10373.325733827278;10422.062014418738;4050.5746896576024;4098;4120.7733574653685;4141.79291035447;4145.440365550612;8504.532250726146;8540.829183416421;8566.14338566151;8579.099194584604;8603.139686031347;4578.862634120982;4599.264117741145;4636.629069674418;4643.187442197669;4662.603678687282;4210.263203939359;4218.240716670967;4226.154769046203;4229.788510574459;4262.595053469915;3386.390449719025;3393.474011528217;3402.1834759657504;3406.131436483681;3413.7269018478464;1019.9949000254951;1024.9231307651955;1025.5795123999274;1028.2545154762886;1036.2849633752687;1041.5313109100935;1050.1546255264586;1053.115383078218;1185.6917201527665;1312.068431413688;7107.111611048619;7146.285371462812;7148.070750802362;7153.141623005168;7159.749408770668;1140.880207578209;1158.2645020412099;1165.854268216473;1169.1231576317762;1180.221054104287;5674.574406919498;5683.715814209273;5739.770409183586;5743.138529220567;5768.567357448208;8866.601002954883;8922.73231803047;9062.592183351633;9201.907980920105;9207;8935.642574296955;8944.239739622206;8954.68658596959;8963.955180224188;9038.774030649154;7061.364477197077;7134.215236324;7143.464240182007;7152.92847071533;7189.173245076883;6707.5975441473665;6731.394174524316;6742.325767423218;6748.460123190035;6761.0534525167495;7766.301032907066;8037.437379383387;8131.2681858633005;8144.959275203586;8163.591820408837;8130.065042520186;8242.793930151794;8250.133735957637;8360.540170290693;8361.707340243061;6425.935740642721;6569;6575.079488871657;6819.863602728017;6825.522213445011;7223.313785190398;7359.558426494427;7394.33450989392;7438.144613369532;7451.552906825608;6858.3827455529245;6936.0636314096955;6955.095837541087;6966.895496567454;7125.501214915113;6539.346065393423;6650.700718467778;6877.6217308048535;6881.449484041164;7007.7196912122945;6767.39093481589;6783.762568310085;6784.050232967487;6790.490713196431;6801.353871382211;5682.232898558642;5990.580659353804;5996.040633498619;6010.699465026819;6128.724207410588;6210.099535567408;6233.501319894488;6235.095911092775;6240.906386404298;6244.906326405016 13:11:54 INFO - 2015-11-20 13:11:54,776 DEBUG : BROWSER_OUTPUT: |4;prototype.html;320.87165133946417;328.35478285169637;334.11126403765985;340.5929913753066;347.05427709491624;6335.683215839207;6357.3642635736405;6376.968115159418;6404.487640988721;6528.183977002875;6279.497640188785;6315.336889626592;6323.24121105468;6329.430351268385;6343.777967771129;4769.070031343889;4772.498887616785;4775.283707443877;4775.426948766136;4783.139034973703;4771.165046116933;4779.6176305895615;4781.976090119544;4786.37777088978;4790.23356262998;4647.14027904837;4731.550502702255;4733.952660473386;4739.028499157665;4746.193147164973;4677.695949763254;4695.859124226278;4713.293006049086;4717.433907931053;4722.315264286659;4064.512258528966;4070.979645101785;4071.694622903294;4076.9388459172837;4085.9182816343805;5968.46283834457;6003.339632640406;6034.758609655652;6046.576739628228;6047.334793172748;5383.78464861409;5437.510624043815;5497.532709719679;5501.559875210014;5502.779888804443;6604.405603495708;6618.338166183391;6645.3354664533645;6685.565438246498;6689.096971908779;4498.392716983198;4522.276435770261;4546.022605139878;4549.294859296814;4558.840440584564;6737.225219099768;6814;6926.792196234071;6937.924621683647;6944.097267355262;4528.773561321921;4531.161735079021;4532.252178390529;4535.909281814345;4545.749983750859;4590.540945905383;4613.561711637389;4618.630509559294;4620.0990806793025;4630.490646028934;5438.5377242934;5442.047641662693;5444.50999410055;5445.237666726662;5447.237386765856;6534.379233972765;6621.966890165615;6686.231083425371;6725.19297684281;6740.460763138937;1600.7198740220415;1621.4324986254717;1625.8780591455688;1627.4059968111553;1636.0347395036986;1057.862477877871;1084.1272775415866;1105.7125147461718;1111.2721167635211;1121.4448847820381;6307.211598550181;6344.58760180596;6369.777057802955;6398.648074355955;6403;6843.076184715099;6852.554583952027;6858.794236172923;6859.279775623588;6862.622555759481;6394.424501794861;6415;6422.165118534654;6422.8715425691225;6426.6144031357335;3765.548134223911;3769.9246015079543;3780.716446266541;3801.2967600993907;3826.311263972512;7305.159906610807;7337.19290878003;7341.669624866894;7341.70633174667;7344.96327518359;6997.405220556309;7116.893246601305;7137.10786151731;7188.245234250433;7209.0988626421695;7231.63841807918;7247.456440766963;7270.745523906638;7278;7284;6972.965135174291;6976.7558135465015;6981.232064473005;7020;7025.473089518205;6678;6807.978803179364;6850.6574671267235;6865.965670171817;6921.446284297345;7210.521843022273;7258.818529536804;7277.3086556777025;7295.343419092307;7296.96351518239;4681.812727490998;4722.716637001791;4727.929081063856;4729.763511824326;4736.8105275788585;6678.265390806911;6697.732090716317;6772.492063095189;6937.549059311129;6942.375186233263;6550.115734375989;6677.866442671217;6690.899636505554;6723;6725.293844146294;6757.493188010821;6779.864402712017;6781.525293229427;6797.864042719217;6801.387875091265;6539.509536784665;6593.0769692244085;6637.103990961158;6637.1703537057865;6649.800505984828;6730.764423245163;6749.493787965824;6756.358145976124;6794.456443484608;6816.454683625398;6616.106825578485;6622.10601568782;6635.800925972036;6640.90038649411;6664.333566643297 13:11:54 INFO - 2015-11-20 13:11:54,778 DEBUG : BROWSER_OUTPUT: |5;yui.html;765.1736124985017;779.2635959018729;822.4284122534841;861.1345597674338;867.8437881181387;13458.59624211274;13709.177449353047;13772.931135344323;13818.30908454577;13830.446782128703;12628.558000469986;12818;12888.097833151684;12954.028447866423;13127.868721312809;809.7044578728766;831.4886344897905;840.7687885831384;840.8990921089478;841.6675413211777;821.109096630157;833.0794472108324;838.4172999765166;841.5287439034161;843.6625349860044;867.4361664917791;873.3755364914085;877.2806298834957;879.0813599788205;882.867569864519;854.7435769269194;870.0299166429448;871.5598622695561;871.904090550039;872.289084396215;631.1794666933015;633.7496688807942;634.3181080338654;639.229728177545;639.6545865232769;12205.45075471606;12313;12414.317212553306;12489.18820276679;12506.062045346636;10719.98160174782;10974.122070234362;11063.778724425467;11124.110071194285;11306.547738090549;9417.717468475888;9729.311063888967;9846.90153098467;9878.654247101316;9918.702438926844;3614.3855544557227;3644.125409901631;3652;3671.889843304705;3796.2597293527774;45440.54559454396;45624;46448.07103857938;46582.301265481045;46779.766101169276;10277.691669249934;10319.649682636802;10391.792164156675;10504.527296271686;10825.945870270598;18385.356512521998;18407;18465.261389544536;18493.260269589067;18512.907435462737;7287.3441390274065;7602.847943041108;7721.189275126031;7800.843983120306;7804.219578042151;4002.699797515198;4029.979850100731;4188.350805625133;4214.241436541452;4215.262329092397;3104.2084268511385;3113.252819323346;3115.610548681415;3144.402563512925;3150.291184483473;531.0812294730061;547.0426753181931;552.2268823646926;552.5496720173127;553.8670719027485;650.4796163069525;705.5308220033722;712.8752468318023;719.6890625155282;734.4931996922106;8595.613197406132;8686.86969695455;8742.606582703793;8742.694005709769;8758.124187581318;679.2935347238915;713.8929160625844;714.9428045756327;718.2171433137905;742.2354974376401;3983.4821473208876;4505.5719706627815;4562.315652652129;4579.358889755437;4591.586757191869;56548.43451565514;56826;56865.71567142138;57326.426735732945;57454.425455745746;49748.75125624421;51592.74203628958;51976;51995.220071698954;52449.2132618011;41880.1623967519;46335.99999999932;49064.26403603949;51527.484725153015;51562;8748.600223964135;9076.455412675261;9121.680741174026;9161.679341223025;9230.861537077084;35144.47283290701;35920.4611930816;35943.64056359403;36138.09654758547;36936.26127477489;40375.798121009204;40840.183196336504;43354;45417;45526.54473455223;11688.298702077902;11749.29504229749;11822.645320640395;11918.36897105704;12196.268223906594;12329.321887296284;12449.93775031119;12575.371231438208;12658.936705316783;12777.616671499869;11477.885221147682;11812.232204906653;11824.881751182722;12170.574029909265;12235.510579576718;11438.17747382387;11685.415729213675;11937;12022.819657704966;12032.699182520508;11689.240199387013;11837.526498939946;11872.287662740264;12253.387330633612;12264.632061038183;9763.658271960447;10017.499125043865;10102.39385636864;10229.590816367261;10451;9534.332596718163;9851.408915465096;9908.35595686278;9944.701658950244;10095.091441770275 13:11:54 INFO - 2015-11-20 13:11:54,778 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:11:54 INFO - 2015-11-20 13:11:54,778 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:11:54 INFO - 2015-11-20 13:11:54,778 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,279 13:11:54 INFO - 2015-11-20 13:11:54,778 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:11:54 INFO - 2015-11-20 13:11:54,778 DEBUG : BROWSER_OUTPUT: __startTimestamp1448053914765__endTimestamp 13:11:54 INFO - 2015-11-20 13:11:54,778 DEBUG : BROWSER_OUTPUT: 13:11:54 INFO - 2015-11-20 13:11:54,778 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:11:54 INFO - 2015-11-20 13:11:54,779 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:11:54 INFO - 2015-11-20 13:11:54,779 DEBUG : BROWSER_OUTPUT: 13:11:54 INFO - 2015-11-20 13:11:54,779 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5478.12 Median:5734.37 stddev:762.53 (13.3%) stddev-sans-first:744.16 13:11:54 INFO - 2015-11-20 13:11:54,780 DEBUG : BROWSER_OUTPUT: Values: 3227.9 3254.7 3275.2 3291.1 3310.5 5381.6 5435.9 5444.0 5455.9 5497.6 5366.7 5465.1 5475.9 5523.3 5554.4 4970.7 5055.6 5109.0 5123.0 5138.1 109.4 4926.8 5002.2 5036.8 5044.5 4875.8 4960.1 4968.4 4980.5 5000.9 5000.9 5027.4 5037.3 5055.7 5085.4 4825.8 4885.6 4932.1 4990.4 5018.6 5288.0 5327.6 5341.2 5353.7 5387.4 5940.1 6021.1 6026.6 6029.7 6032.0 5822.9 5963.3 5988.0 5997.0 5997.3 5542.9 5561.1 5591.2 5626.3 5630.6 6093.8 6101.6 6109.2 6115.6 6123.1 5867.7 5885.3 5892.6 5893.5 5924.3 5799.0 5880.9 5912.5 5998.9 6021.5 5934.8 5943.5 5957.8 5974.6 6046.6 5920.3 5924.3 5956.5 5958.9 5982.8 4448.5 4519.1 4530.3 4563.7 4568.0 3948.9 4052.5 4066.5 4076.6 4083.5 5695.8 5710.6 5736.1 5748.5 5769.3 5889.9 6016.3 6020.0 6062.7 6074.5 5570.6 5622.6 5644.4 5648.5 5690.1 4966.2 5005.0 5018.5 5041.1 5046.5 6008.4 6027.2 6048.3 6070.8 6117.7 6021.3 6025.7 6047.8 6053.5 6065.1 6225.6 6229.0 6236.4 6239.2 6251.4 5725.0 5734.5 5797.2 5839.6 5963.6 5917.4 5944.4 5947.0 5947.8 5967.3 5794.1 5795.3 5811.1 5822.8 5836.5 5649.8 5661.3 5748.9 5775.6 5797.0 5696.4 5702.9 5707.7 5725.9 5734.4 5784.0 5795.4 5846.5 5861.5 5863.3 5576.0 5636.3 5639.9 5736.2 5797.3 13:11:54 INFO - 2015-11-20 13:11:54,780 DEBUG : BROWSER_OUTPUT: 13:11:54 INFO - 2015-11-20 13:11:54,780 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49944.40 Median:216685.40 stddev:84863.37 (39.2%) stddev-sans-first:85020.41 13:11:54 INFO - 2015-11-20 13:11:54,780 DEBUG : BROWSER_OUTPUT: Values: 553.2 584.2 591.1 603.4 608.9 40815.0 41246.8 41275.0 41312.6 41319.4 43367.0 44006.3 44030.0 44039.3 44050.8 8679.5 8799.8 8830.7 8849.1 8856.4 8588.7 8696.2 8753.4 8755.4 8762.2 8683.5 8697.0 8752.5 8790.3 8805.4 8653.7 8747.9 8755.0 8763.0 8807.6 8604.0 8732.5 8741.3 8751.6 8772.6 41421.6 41730.8 41820.6 41868.4 42038.8 3289.5 3330.7 3378.7 3725.5 3742.2 29987.6 30390.0 31242.7 31329.8 31882.8 3965.6 4032.7 4081.1 4089.1 4131.7 270562.0 271036.0 271707.0 271820.0 272173.0 60879.0 61096.0 61125.7 61291.4 61819.7 65617.3 65920.7 65997.0 66190.7 72295.6 15182.5 15492.9 15501.3 15586.5 15639.0 11639.4 11650.9 11681.0 11690.4 11698.0 21006.4 21311.8 21353.6 21368.9 21374.7 7848.5 8029.1 8051.3 8060.2 8126.0 990.8 1017.5 1047.6 1079.3 1087.7 29605.9 29746.4 29789.3 29929.3 34113.3 1035.8 1193.8 1195.0 1196.9 1211.6 15882.4 16014.7 16030.4 16177.4 16187.8 387368.0 389196.0 393970.0 394054.0 394952.0 56048.7 56501.7 56578.0 56803.7 56831.7 1364.1 1371.8 1376.5 1376.7 1387.2 27920.0 29711.6 29718.7 29732.4 29837.0 41458.0 41544.6 41650.8 42668.4 42785.8 293390.0 293694.0 294463.0 295306.0 297657.0 33306.2 45088.5 45395.0 45558.0 45848.0 45553.3 46361.5 46395.5 46494.5 46729.5 37239.0 37315.4 38938.4 39257.4 39400.8 38581.8 39076.0 39257.6 39344.8 39802.2 37560.6 37565.8 37617.6 38083.4 38155.0 32029.7 35197.1 35277.3 35471.6 36001.8 26286.6 26630.3 27676.3 27924.0 27984.6 13:11:54 INFO - 2015-11-20 13:11:54,780 DEBUG : BROWSER_OUTPUT: 13:11:54 INFO - 2015-11-20 13:11:54,781 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27743.28 Median:11007.81 stddev:83241.20 (756.2%) stddev-sans-first:83449.31 13:11:54 INFO - 2015-11-20 13:11:54,782 DEBUG : BROWSER_OUTPUT: Values: 355.8 360.0 360.6 361.1 363.7 17046.9 17574.2 17877.9 17926.6 18789.4 11539.2 13114.7 17089.0 17258.9 17636.6 4926.9 5018.3 5085.8 5095.9 5109.4 5030.9 5055.4 5058.5 5060.7 5068.9 5253.8 5412.6 5413.1 5515.5 5673.2 5344.7 5363.7 5365.7 5381.9 5392.7 5352.8 5370.3 5380.3 5382.7 5388.0 11924.2 12166.5 18510.0 18904.7 19358.1 1906.5 1907.0 1963.5 2048.9 2054.6 9515.5 9829.7 9975.5 10692.8 12920.4 1720.3 1755.4 1810.9 1811.4 1819.4 59846.7 61733.0 61870.7 63154.1 63158.7 10244.6 10293.1 10342.2 10375.3 10414.6 13626.5 13680.0 13711.7 13740.5 13780.0 7408.6 7436.8 7686.9 7718.9 7731.1 7347.5 7353.7 7359.4 7393.8 7456.5 4456.2 4493.0 4497.3 4503.3 4530.7 1822.5 1834.9 1849.9 1898.1 1912.5 417.8 425.6 458.5 812.2 937.2 10654.3 11208.0 15846.8 16601.7 16738.7 932.7 945.6 949.6 956.4 961.0 9673.1 9777.2 10060.6 10109.9 10166.8 491280.0 500761.0 514251.0 517946.0 522260.0 74951.6 77380.6 77486.0 77519.0 78281.2 1133.4 1178.0 1184.3 1186.2 1196.6 14820.8 15014.0 15684.1 15871.4 16016.8 31244.7 31644.0 31822.8 31968.8 32416.5 40771.0 44171.8 44951.3 45325.5 47645.5 14272.6 14547.0 14770.3 15188.4 15327.8 18534.0 18638.1 18692.5 18718.8 19966.7 9958.0 9981.7 10177.7 10223.7 10267.6 10050.0 10129.2 10205.4 10241.5 10507.6 10080.5 10540.2 10702.7 10752.5 10955.9 14919.3 14970.8 15133.7 15278.3 15284.2 15708.2 15925.7 16019.8 16161.3 16545.2 13:11:54 INFO - 2015-11-20 13:11:54,782 DEBUG : BROWSER_OUTPUT: 13:11:54 INFO - 2015-11-20 13:11:54,782 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5315.02 Median:5993.31 stddev:2706.52 (45.2%) stddev-sans-first:2698.85 13:11:54 INFO - 2015-11-20 13:11:54,782 DEBUG : BROWSER_OUTPUT: Values: 1491.5 1705.0 1764.3 1778.5 1780.6 7297.5 7390.4 7600.2 7624.7 7771.1 7793.5 7800.5 7810.0 7829.3 7905.3 2240.7 2292.5 2295.2 2297.9 2303.0 2280.1 2288.3 2346.6 2348.0 2348.9 2196.9 2229.9 2252.0 2252.1 2282.3 2169.4 2227.9 2253.9 2258.8 2262.6 2281.7 2299.6 2306.7 2313.9 2314.5 7609.4 7615.5 7630.8 7640.3 7677.8 4619.1 4712.6 4722.9 4730.5 4734.9 3024.8 3065.2 3096.8 3136.2 3139.8 984.0 1006.8 1037.3 1048.0 1048.3 10300.9 10324.4 10340.5 10373.3 10422.1 4050.6 4098.0 4120.8 4141.8 4145.4 8504.5 8540.8 8566.1 8579.1 8603.1 4578.9 4599.3 4636.6 4643.2 4662.6 4210.3 4218.2 4226.2 4229.8 4262.6 3386.4 3393.5 3402.2 3406.1 3413.7 1020.0 1024.9 1025.6 1028.3 1036.3 1041.5 1050.2 1053.1 1185.7 1312.1 7107.1 7146.3 7148.1 7153.1 7159.7 1140.9 1158.3 1165.9 1169.1 1180.2 5674.6 5683.7 5739.8 5743.1 5768.6 8866.6 8922.7 9062.6 9201.9 9207.0 8935.6 8944.2 8954.7 8964.0 9038.8 7061.4 7134.2 7143.5 7152.9 7189.2 6707.6 6731.4 6742.3 6748.5 6761.1 7766.3 8037.4 8131.3 8145.0 8163.6 8130.1 8242.8 8250.1 8360.5 8361.7 6425.9 6569.0 6575.1 6819.9 6825.5 7223.3 7359.6 7394.3 7438.1 7451.6 6858.4 6936.1 6955.1 6966.9 7125.5 6539.3 6650.7 6877.6 6881.4 7007.7 6767.4 6783.8 6784.1 6790.5 6801.4 5682.2 5990.6 5996.0 6010.7 6128.7 6210.1 6233.5 6235.1 6240.9 6244.9 13:11:54 INFO - 2015-11-20 13:11:54,783 DEBUG : BROWSER_OUTPUT: 13:11:54 INFO - 2015-11-20 13:11:54,783 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5579.45 Median:6385.70 stddev:1723.07 (27.0%) stddev-sans-first:1682.09 13:11:54 INFO - 2015-11-20 13:11:54,784 DEBUG : BROWSER_OUTPUT: Values: 320.9 328.4 334.1 340.6 347.1 6335.7 6357.4 6377.0 6404.5 6528.2 6279.5 6315.3 6323.2 6329.4 6343.8 4769.1 4772.5 4775.3 4775.4 4783.1 4771.2 4779.6 4782.0 4786.4 4790.2 4647.1 4731.6 4734.0 4739.0 4746.2 4677.7 4695.9 4713.3 4717.4 4722.3 4064.5 4071.0 4071.7 4076.9 4085.9 5968.5 6003.3 6034.8 6046.6 6047.3 5383.8 5437.5 5497.5 5501.6 5502.8 6604.4 6618.3 6645.3 6685.6 6689.1 4498.4 4522.3 4546.0 4549.3 4558.8 6737.2 6814.0 6926.8 6937.9 6944.1 4528.8 4531.2 4532.3 4535.9 4545.7 4590.5 4613.6 4618.6 4620.1 4630.5 5438.5 5442.0 5444.5 5445.2 5447.2 6534.4 6622.0 6686.2 6725.2 6740.5 1600.7 1621.4 1625.9 1627.4 1636.0 1057.9 1084.1 1105.7 1111.3 1121.4 6307.2 6344.6 6369.8 6398.6 6403.0 6843.1 6852.6 6858.8 6859.3 6862.6 6394.4 6415.0 6422.2 6422.9 6426.6 3765.5 3769.9 3780.7 3801.3 3826.3 7305.2 7337.2 7341.7 7341.7 7345.0 6997.4 7116.9 7137.1 7188.2 7209.1 7231.6 7247.5 7270.7 7278.0 7284.0 6973.0 6976.8 6981.2 7020.0 7025.5 6678.0 6808.0 6850.7 6866.0 6921.4 7210.5 7258.8 7277.3 7295.3 7297.0 4681.8 4722.7 4727.9 4729.8 4736.8 6678.3 6697.7 6772.5 6937.5 6942.4 6550.1 6677.9 6690.9 6723.0 6725.3 6757.5 6779.9 6781.5 6797.9 6801.4 6539.5 6593.1 6637.1 6637.2 6649.8 6730.8 6749.5 6756.4 6794.5 6816.5 6616.1 6622.1 6635.8 6640.9 6664.3 13:11:54 INFO - 2015-11-20 13:11:54,784 DEBUG : BROWSER_OUTPUT: 13:11:54 INFO - 2015-11-20 13:11:54,784 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13843.70 Median:25101.68 stddev:15861.00 (63.2%) stddev-sans-first:15875.09 13:11:54 INFO - 2015-11-20 13:11:54,784 DEBUG : BROWSER_OUTPUT: Values: 765.2 779.3 822.4 861.1 867.8 13458.6 13709.2 13772.9 13818.3 13830.4 12628.6 12818.0 12888.1 12954.0 13127.9 809.7 831.5 840.8 840.9 841.7 821.1 833.1 838.4 841.5 843.7 867.4 873.4 877.3 879.1 882.9 854.7 870.0 871.6 871.9 872.3 631.2 633.7 634.3 639.2 639.7 12205.5 12313.0 12414.3 12489.2 12506.1 10720.0 10974.1 11063.8 11124.1 11306.5 9417.7 9729.3 9846.9 9878.7 9918.7 3614.4 3644.1 3652.0 3671.9 3796.3 45440.5 45624.0 46448.1 46582.3 46779.8 10277.7 10319.6 10391.8 10504.5 10825.9 18385.4 18407.0 18465.3 18493.3 18512.9 7287.3 7602.8 7721.2 7800.8 7804.2 4002.7 4030.0 4188.4 4214.2 4215.3 3104.2 3113.3 3115.6 3144.4 3150.3 531.1 547.0 552.2 552.5 553.9 650.5 705.5 712.9 719.7 734.5 8595.6 8686.9 8742.6 8742.7 8758.1 679.3 713.9 714.9 718.2 742.2 3983.5 4505.6 4562.3 4579.4 4591.6 56548.4 56826.0 56865.7 57326.4 57454.4 49748.8 51592.7 51976.0 51995.2 52449.2 41880.2 46336.0 49064.3 51527.5 51562.0 8748.6 9076.5 9121.7 9161.7 9230.9 35144.5 35920.5 35943.6 36138.1 36936.3 40375.8 40840.2 43354.0 45417.0 45526.5 11688.3 11749.3 11822.6 11918.4 12196.3 12329.3 12449.9 12575.4 12658.9 12777.6 11477.9 11812.2 11824.9 12170.6 12235.5 11438.2 11685.4 11937.0 12022.8 12032.7 11689.2 11837.5 11872.3 12253.4 12264.6 9763.7 10017.5 10102.4 10229.6 10451.0 9534.3 9851.4 9908.4 9944.7 10095.1 13:11:54 INFO - 2015-11-20 13:11:54,784 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:11:54 INFO - 2015-11-20 13:11:54,784 DEBUG : BROWSER_OUTPUT: 13:11:55 INFO - 2015-11-20 13:11:55,441 INFO : Browser exited with error code: 0 13:11:55 INFO - 2015-11-20 13:11:55,465 INFO : Completed test dromaeo_css (00:18:30) 13:11:55 INFO - 2015-11-20 13:11:55,465 INFO : Starting test kraken 13:11:55 INFO - 2015-11-20 13:11:55,465 DEBUG : operating with platform_type : linux_ 13:11:55 INFO - 2015-11-20 13:11:55,466 INFO : Initialising browser for kraken test... 13:11:55 INFO - 2015-11-20 13:11:55,472 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUOgMh8/profile http://localhost:41019/getInfo.html 13:11:59 INFO - 2015-11-20 13:11:59,829 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:11:59 INFO - 2015-11-20 13:11:59,829 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:11:59 INFO - 2015-11-20 13:11:59,829 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:11:59 INFO - 2015-11-20 13:11:59,829 DEBUG : BROWSER_OUTPUT: __metrics 13:12:00 INFO - 2015-11-20 13:12:00,829 INFO : Browser initialized. 13:12:00 INFO - 2015-11-20 13:12:00,830 INFO : Running cycle 1/1 for kraken test... 13:12:00 INFO - 2015-11-20 13:12:00,830 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUOgMh8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:12:12 INFO - 2015-11-20 13:12:12,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 142049280 13:12:12 INFO - 2015-11-20 13:12:12,621 DEBUG : BROWSER_OUTPUT: 13:12:15 INFO - 2015-11-20 13:12:15,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41019/tests/kraken/driver.html?testName=audio-beat-detection) 13:12:15 INFO - 2015-11-20 13:12:15,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 141606912 13:12:15 INFO - 2015-11-20 13:12:15,720 DEBUG : BROWSER_OUTPUT: 13:12:18 INFO - 2015-11-20 13:12:18,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41019/tests/kraken/driver.html?testName=audio-dft) 13:12:18 INFO - 2015-11-20 13:12:18,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 141762560 13:12:18 INFO - 2015-11-20 13:12:18,959 DEBUG : BROWSER_OUTPUT: 13:12:21 INFO - 2015-11-20 13:12:21,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41019/tests/kraken/driver.html?testName=audio-fft) 13:12:22 INFO - 2015-11-20 13:12:22,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 136167424 13:12:22 INFO - 2015-11-20 13:12:22,385 DEBUG : BROWSER_OUTPUT: 13:12:24 INFO - 2015-11-20 13:12:24,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41019/tests/kraken/driver.html?testName=audio-oscillator) 13:12:24 INFO - 2015-11-20 13:12:24,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 137924608 13:12:24 INFO - 2015-11-20 13:12:24,898 DEBUG : BROWSER_OUTPUT: 13:12:27 INFO - 2015-11-20 13:12:27,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41019/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:12:27 INFO - 2015-11-20 13:12:27,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 137789440 13:12:27 INFO - 2015-11-20 13:12:27,645 DEBUG : BROWSER_OUTPUT: 13:12:30 INFO - 2015-11-20 13:12:30,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41019/tests/kraken/driver.html?testName=imaging-darkroom) 13:12:31 INFO - 2015-11-20 13:12:31,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 137273344 13:12:31 INFO - 2015-11-20 13:12:31,208 DEBUG : BROWSER_OUTPUT: 13:12:34 INFO - 2015-11-20 13:12:34,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41019/tests/kraken/driver.html?testName=imaging-desaturate) 13:12:35 INFO - 2015-11-20 13:12:35,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 138604544 13:12:35 INFO - 2015-11-20 13:12:35,202 DEBUG : BROWSER_OUTPUT: 13:12:38 INFO - 2015-11-20 13:12:38,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41019/tests/kraken/driver.html?testName=json-parse-financial) 13:12:38 INFO - 2015-11-20 13:12:38,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 139304960 13:12:38 INFO - 2015-11-20 13:12:38,633 DEBUG : BROWSER_OUTPUT: 13:12:40 INFO - 2015-11-20 13:12:40,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41019/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:12:40 INFO - 2015-11-20 13:12:40,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 139964416 13:12:40 INFO - 2015-11-20 13:12:40,775 DEBUG : BROWSER_OUTPUT: 13:12:42 INFO - 2015-11-20 13:12:42,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41019/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:12:43 INFO - 2015-11-20 13:12:43,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 139796480 13:12:43 INFO - 2015-11-20 13:12:43,220 DEBUG : BROWSER_OUTPUT: 13:12:45 INFO - 2015-11-20 13:12:45,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41019/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:12:45 INFO - 2015-11-20 13:12:45,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 140091392 13:12:45 INFO - 2015-11-20 13:12:45,907 DEBUG : BROWSER_OUTPUT: 13:12:48 INFO - 2015-11-20 13:12:48,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41019/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:12:48 INFO - 2015-11-20 13:12:48,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 140632064 13:12:48 INFO - 2015-11-20 13:12:48,943 DEBUG : BROWSER_OUTPUT: 13:12:51 INFO - 2015-11-20 13:12:51,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41019/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:12:52 INFO - 2015-11-20 13:12:52,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 140292096 13:12:52 INFO - 2015-11-20 13:12:52,098 DEBUG : BROWSER_OUTPUT: 13:12:53 INFO - 2015-11-20 13:12:53,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41019/tests/kraken/driver.html?testName=ai-astar) 13:12:54 INFO - 2015-11-20 13:12:54,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 140759040 13:12:54 INFO - 2015-11-20 13:12:54,043 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,043 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:12:54 INFO - 2015-11-20 13:12:54,043 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:12:54 INFO - 2015-11-20 13:12:54,044 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:12:54 INFO - 2015-11-20 13:12:54,044 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:12:54 INFO - 2015-11-20 13:12:54,044 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;106;111;110;114;124;110;113;113;112 13:12:54 INFO - 2015-11-20 13:12:54,044 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;127;154;180;125;151;152;125;164;127 13:12:54 INFO - 2015-11-20 13:12:54,044 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;162;160;161;162;163;160;162;172;163 13:12:54 INFO - 2015-11-20 13:12:54,045 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;74;73;73;72;124;72;73;73;72 13:12:54 INFO - 2015-11-20 13:12:54,045 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;130;91;91;90;130;91;91;129 13:12:54 INFO - 2015-11-20 13:12:54,045 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;109;109;111;111;111 13:12:54 INFO - 2015-11-20 13:12:54,045 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;148;147;145;147;147;147;148 13:12:54 INFO - 2015-11-20 13:12:54,045 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;97;96;96;101;96;96;96 13:12:54 INFO - 2015-11-20 13:12:54,045 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;62;61;61;63;61;63;63;60;59 13:12:54 INFO - 2015-11-20 13:12:54,046 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;70;69;69;70;69;68 13:12:54 INFO - 2015-11-20 13:12:54,046 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;93;88;85;85;87;87;85;86;88;86 13:12:54 INFO - 2015-11-20 13:12:54,046 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;129;123;118;125;119;124;123;115;115 13:12:54 INFO - 2015-11-20 13:12:54,047 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;150;151;154;151;153;151;148;152;140 13:12:54 INFO - 2015-11-20 13:12:54,047 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;68;68;66;68;68;66;70;67 13:12:54 INFO - 2015-11-20 13:12:54,047 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:12:54 INFO - 2015-11-20 13:12:54,047 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:12:54 INFO - 2015-11-20 13:12:54,047 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,703 13:12:54 INFO - 2015-11-20 13:12:54,047 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:12:54 INFO - 2015-11-20 13:12:54,047 DEBUG : BROWSER_OUTPUT: __startTimestamp1448053974042__endTimestamp 13:12:54 INFO - 2015-11-20 13:12:54,047 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,049 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:12:54 INFO - 2015-11-20 13:12:54,049 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:12:54 INFO - 2015-11-20 13:12:54,049 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,049 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.30 Median:112.50 stddev:4.69 (4.2%) stddev-sans-first:4.90 13:12:54 INFO - 2015-11-20 13:12:54,049 DEBUG : BROWSER_OUTPUT: Values: 110.0 106.0 111.0 110.0 114.0 124.0 110.0 113.0 113.0 112.0 13:12:54 INFO - 2015-11-20 13:12:54,049 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,049 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.10 Median:153.00 stddev:19.17 (12.5%) stddev-sans-first:20.00 13:12:54 INFO - 2015-11-20 13:12:54,050 DEBUG : BROWSER_OUTPUT: Values: 156.0 127.0 154.0 180.0 125.0 151.0 152.0 125.0 164.0 127.0 13:12:54 INFO - 2015-11-20 13:12:54,050 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,050 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:3.45 (2.1%) stddev-sans-first:3.63 13:12:54 INFO - 2015-11-20 13:12:54,050 DEBUG : BROWSER_OUTPUT: Values: 164.0 162.0 160.0 161.0 162.0 163.0 160.0 162.0 172.0 163.0 13:12:54 INFO - 2015-11-20 13:12:54,050 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,050 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:77.70 Median:73.00 stddev:16.29 (22.3%) stddev-sans-first:17.10 13:12:54 INFO - 2015-11-20 13:12:54,050 DEBUG : BROWSER_OUTPUT: Values: 71.0 74.0 73.0 73.0 72.0 124.0 72.0 73.0 73.0 72.0 13:12:54 INFO - 2015-11-20 13:12:54,050 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,051 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.30 Median:90.50 stddev:18.89 (20.9%) stddev-sans-first:19.51 13:12:54 INFO - 2015-11-20 13:12:54,051 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 130.0 91.0 91.0 90.0 130.0 91.0 91.0 129.0 13:12:54 INFO - 2015-11-20 13:12:54,051 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,051 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 13:12:54 INFO - 2015-11-20 13:12:54,052 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 109.0 109.0 111.0 111.0 111.0 13:12:54 INFO - 2015-11-20 13:12:54,052 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,052 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.92 (0.6%) stddev-sans-first:0.93 13:12:54 INFO - 2015-11-20 13:12:54,052 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 148.0 147.0 145.0 147.0 147.0 147.0 148.0 13:12:54 INFO - 2015-11-20 13:12:54,053 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,053 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.57 (1.6%) stddev-sans-first:1.66 13:12:54 INFO - 2015-11-20 13:12:54,053 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 97.0 96.0 96.0 101.0 96.0 96.0 96.0 13:12:54 INFO - 2015-11-20 13:12:54,053 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,053 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.40 Median:61.50 stddev:1.35 (2.2%) stddev-sans-first:1.42 13:12:54 INFO - 2015-11-20 13:12:54,053 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 61.0 61.0 63.0 61.0 63.0 63.0 60.0 59.0 13:12:54 INFO - 2015-11-20 13:12:54,053 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,054 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 13:12:54 INFO - 2015-11-20 13:12:54,054 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 70.0 69.0 69.0 70.0 69.0 68.0 13:12:54 INFO - 2015-11-20 13:12:54,054 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,054 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:2.40 (2.8%) stddev-sans-first:1.22 13:12:54 INFO - 2015-11-20 13:12:54,054 DEBUG : BROWSER_OUTPUT: Values: 93.0 88.0 85.0 85.0 87.0 87.0 85.0 86.0 88.0 86.0 13:12:54 INFO - 2015-11-20 13:12:54,054 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,054 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:123.50 stddev:5.64 (4.6%) stddev-sans-first:4.76 13:12:54 INFO - 2015-11-20 13:12:54,055 DEBUG : BROWSER_OUTPUT: Values: 132.0 129.0 123.0 118.0 125.0 119.0 124.0 123.0 115.0 115.0 13:12:54 INFO - 2015-11-20 13:12:54,055 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,055 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:151.00 stddev:4.33 (2.9%) stddev-sans-first:4.12 13:12:54 INFO - 2015-11-20 13:12:54,055 DEBUG : BROWSER_OUTPUT: Values: 144.0 150.0 151.0 154.0 151.0 153.0 151.0 148.0 152.0 140.0 13:12:54 INFO - 2015-11-20 13:12:54,055 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,055 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 13:12:54 INFO - 2015-11-20 13:12:54,055 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 68.0 68.0 66.0 68.0 68.0 66.0 70.0 67.0 13:12:54 INFO - 2015-11-20 13:12:54,055 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:12:54 INFO - 2015-11-20 13:12:54,055 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-20 13:12:54,893 INFO : Browser exited with error code: 0 13:12:54 INFO - 2015-11-20 13:12:54,948 INFO : Completed test kraken (00:00:59) 13:12:54 INFO - 2015-11-20 13:12:54,949 INFO : Starting test v8_7 13:12:54 INFO - 2015-11-20 13:12:54,949 DEBUG : operating with platform_type : linux_ 13:12:54 INFO - 2015-11-20 13:12:54,949 INFO : Initialising browser for v8_7 test... 13:12:54 INFO - 2015-11-20 13:12:54,955 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphhNK5v/profile http://localhost:41019/getInfo.html 13:12:59 INFO - 2015-11-20 13:12:59,200 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:12:59 INFO - 2015-11-20 13:12:59,200 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:12:59 INFO - 2015-11-20 13:12:59,201 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:12:59 INFO - 2015-11-20 13:12:59,201 DEBUG : BROWSER_OUTPUT: __metrics 13:13:00 INFO - 2015-11-20 13:13:00,197 INFO : Browser initialized. 13:13:00 INFO - 2015-11-20 13:13:00,198 INFO : Running cycle 1/1 for v8_7 test... 13:13:00 INFO - 2015-11-20 13:13:00,198 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphhNK5v/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:13:11 INFO - 2015-11-20 13:13:11,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 141848576 13:13:11 INFO - 2015-11-20 13:13:11,989 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41019/tests/v8_7/run.html (next: http://localhost:41019/tests/v8_7/run.html) 13:13:33 INFO - 2015-11-20 13:13:33,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 138805248 13:13:33 INFO - 2015-11-20 13:13:33,561 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,562 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:13:33 INFO - 2015-11-20 13:13:33,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:13:33 INFO - 2015-11-20 13:13:33,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:13:33 INFO - 2015-11-20 13:13:33,563 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:13:33 INFO - 2015-11-20 13:13:33,563 DEBUG : BROWSER_OUTPUT: |0;Richards;171.82130584192439 13:13:33 INFO - 2015-11-20 13:13:33,563 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.56716417910448 13:13:33 INFO - 2015-11-20 13:13:33,563 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.37310073157005 13:13:33 INFO - 2015-11-20 13:13:33,564 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5102.040816326531 13:13:33 INFO - 2015-11-20 13:13:33,564 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1059.322033898305 13:13:33 INFO - 2015-11-20 13:13:33,564 DEBUG : BROWSER_OUTPUT: |5;Earley;697.350069735007 13:13:33 INFO - 2015-11-20 13:13:33,564 DEBUG : BROWSER_OUTPUT: |6;Boyer;12084.33734939759 13:13:33 INFO - 2015-11-20 13:13:33,564 DEBUG : BROWSER_OUTPUT: |7;RegExp;25425 13:13:33 INFO - 2015-11-20 13:13:33,564 DEBUG : BROWSER_OUTPUT: |8;Splay;619.8142414860681 13:13:33 INFO - 2015-11-20 13:13:33,564 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 13:13:33 INFO - 2015-11-20 13:13:33,564 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:13:33 INFO - 2015-11-20 13:13:33,564 DEBUG : BROWSER_OUTPUT: __startTimestamp1448054013561__endTimestamp 13:13:33 INFO - 2015-11-20 13:13:33,565 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,565 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:13:33 INFO - 2015-11-20 13:13:33,565 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:13:33 INFO - 2015-11-20 13:13:33,565 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,565 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.82 Median:171.82 stddev:0.00 (0.0%) 13:13:33 INFO - 2015-11-20 13:13:33,565 DEBUG : BROWSER_OUTPUT: Values: 171.8 13:13:33 INFO - 2015-11-20 13:13:33,565 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,565 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.57 Median:186.57 stddev:0.00 (0.0%) 13:13:33 INFO - 2015-11-20 13:13:33,565 DEBUG : BROWSER_OUTPUT: Values: 186.6 13:13:33 INFO - 2015-11-20 13:13:33,565 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,565 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 13:13:33 INFO - 2015-11-20 13:13:33,566 DEBUG : BROWSER_OUTPUT: Values: 281.4 13:13:33 INFO - 2015-11-20 13:13:33,566 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,566 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5102.04 Median:5102.04 stddev:0.00 (0.0%) 13:13:33 INFO - 2015-11-20 13:13:33,566 DEBUG : BROWSER_OUTPUT: Values: 5102.0 13:13:33 INFO - 2015-11-20 13:13:33,566 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,566 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1059.32 Median:1059.32 stddev:0.00 (0.0%) 13:13:33 INFO - 2015-11-20 13:13:33,566 DEBUG : BROWSER_OUTPUT: Values: 1059.3 13:13:33 INFO - 2015-11-20 13:13:33,566 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,566 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:697.35 Median:697.35 stddev:0.00 (0.0%) 13:13:33 INFO - 2015-11-20 13:13:33,566 DEBUG : BROWSER_OUTPUT: Values: 697.4 13:13:33 INFO - 2015-11-20 13:13:33,566 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12084.34 Median:12084.34 stddev:0.00 (0.0%) 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: Values: 12084.3 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25425.00 Median:25425.00 stddev:0.00 (0.0%) 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: Values: 25425.0 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.81 Median:619.81 stddev:0.00 (0.0%) 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: Values: 619.8 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: Values: 4854.4 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:13:33 INFO - 2015-11-20 13:13:33,567 DEBUG : BROWSER_OUTPUT: 13:13:34 INFO - 2015-11-20 13:13:34,414 INFO : Browser exited with error code: 0 13:13:34 INFO - 2015-11-20 13:13:34,428 INFO : Completed test v8_7 (00:00:39) 13:13:34 INFO - 2015-11-20 13:13:34,674 INFO : Completed test suite (00:20:09) 13:13:34 INFO - 2015-11-20 13:13:34,674 DEBUG : Working with test: dromaeo_css 13:13:34 INFO - 2015-11-20 13:13:34,674 DEBUG : Generating results file: dromaeo_css 13:13:34 INFO - 2015-11-20 13:13:34,675 DEBUG : Working with test: kraken 13:13:34 INFO - 2015-11-20 13:13:34,676 DEBUG : Generating results file: kraken 13:13:34 INFO - 2015-11-20 13:13:34,676 INFO : javascript benchmark 13:13:34 INFO - 2015-11-20 13:13:34,676 DEBUG : Working with test: v8_7 13:13:34 INFO - 2015-11-20 13:13:34,676 DEBUG : Generating results file: v8_7 13:13:34 INFO - 2015-11-20 13:13:34,677 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:13:34 INFO - 2015-11-20 13:13:34,732 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 13:13:34 INFO - 2015-11-20 13:13:34,732 DEBUG : process_Request line: dromaeo_css 7112.09 graph.html#tests=[[72,1,43]] 13:13:34 INFO - 2015-11-20 13:13:34,732 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:13:34 INFO - 2015-11-20 13:13:34,762 DEBUG : process_Request line: kraken 1511.70 graph.html#tests=[[232,1,43]] 13:13:34 INFO - 2015-11-20 13:13:34,763 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:13:34 INFO - 2015-11-20 13:13:34,801 DEBUG : process_Request line: v8_7 21366.39 graph.html#tests=[[230,1,43]] 13:13:34 INFO - 2015-11-20 13:13:34,802 INFO : javascript benchmark 13:13:34 INFO - 2015-11-20 13:13:34,806 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3227.8547465364054, 3254.6745325467455, 3275.197576593735, 3291.1278511194537, 3310.4703247480406, 5381.623286369956, 5435.9456405435985, 5444.020076386249, 5455.918161227575, 5497.642653227543, 5366.677999320033, 5465.125579907216, 5475.863103422416, 5523.28197334347, 5554.389017208114, 4970.70175789452, 5055.5702765265, 5109.0, 5122.974385128069, 5138.100832354342, 109.4244342722766, 4926.753662316888, 5002.199648056312, 5036.848894533152, 5044.520770526794, 4875.829345972892, 4960.131976904064, 4968.354113965162, 4980.526849949285, 5000.949990500085, 5000.924986125211, 5027.371578552681, 5037.345145131109, 5055.721935293557, 5085.364329458817, 4825.806967721287, 4885.609151267926, 4932.062908047459, 4990.351254336949, 5018.648694591344, 5287.995280896617, 5327.573794096463, 5341.172118321666, 5353.732313384316, 5387.353517577876, 5940.079287710412, 6021.066734656135, 6026.638401695912, 6029.698515074273, 6032.0, 5822.912656310159, 5963.254593175853, 5987.970060149715, 5997.0, 5997.310309314441, 5542.9168562471195, 5561.110222364443, 5591.245181900432, 5626.2967129108865, 5630.634008789457, 6093.776336793724, 6101.641069425254, 6109.236345456818, 6115.605440958429, 6123.112148738497, 5867.706614669335, 5885.264341957255, 5892.587518873724, 5893.469587737124, 5924.289085309704, 5799.0, 5880.882382352329, 5912.4923144598715, 5998.910016349758, 6021.458068773743, 5934.7922822701, 5943.465088142088, 5957.821265362046, 5974.551908606872, 6046.606970546901, 5920.348761636216, 5924.348321684612, 5956.52347812174, 5958.910616340759, 5982.760689572368, 4448.488423831301, 4519.050999290186, 4530.320451932171, 4563.703359281636, 4567.954320456819, 3948.881533553998, 4052.4731784867777, 4066.4916885389325, 4076.5515793262716, 4083.4895638045246, 5695.772169113189, 5710.571707121982, 5736.13957906309, 5748.482636562646, 5769.336526299446, 5889.911651325234, 6016.308124565643, 6020.0, 6062.666553339521, 6074.453299203093, 5570.582206334541, 5622.606417550732, 5644.435556444405, 5648.548116150698, 5690.0895856663565, 4966.15575352191, 5004.974975125101, 5018.548330650259, 5041.117804384291, 5046.495350464924, 6008.429199226067, 6027.156198132265, 6048.304444988795, 6070.848228794227, 6117.736059405574, 6021.337652858269, 6025.728842202199, 6047.78832740852, 6053.485453736482, 6065.090236464565, 6225.564210505402, 6228.968855155696, 6236.407541283571, 6239.188905442445, 6251.437370636664, 5725.0267454531995, 5734.483896449339, 5797.188393624811, 5839.620424672383, 5963.552733544915, 5917.408259174048, 5944.375840536854, 5947.0, 5947.821565353046, 5967.31375891778, 5794.1308803679785, 5795.275590551181, 5811.070228763378, 5822.796202132905, 5836.533077353886, 5649.774009039593, 5661.320641523043, 5748.856278593069, 5775.566832487664, 5796.956547821264, 5696.373398926032, 5702.885942281048, 5707.6575405475805, 5725.942740572541, 5734.3692193857805, 5784.045632470764, 5795.449432303924, 5846.473817356458, 5861.472467477947, 5863.325717542537, 5576.0, 5636.323641163087, 5639.8590035249445, 5736.19693242938, 5797.275340582427], "unit": "ms", "name": "dojo.html", "value": 5428.753409490229}, {"lowerIsBetter": false, "replicates": [553.1671531119351, 584.2259006815968, 591.1310373750586, 603.3845477612836, 608.8538750699834, 40815.0, 41246.79376603113, 41275.0, 41312.58687413125, 41319.38020929685, 43367.0, 44006.339904901375, 44030.0, 44039.3394099088, 44050.77974610122, 8679.47923124613, 8799.824003519925, 8830.735077947671, 8849.115088491164, 8856.380053396264, 8588.699395521158, 8696.17386348299, 8753.431026983257, 8755.430896991675, 8762.21140097391, 8683.522406267653, 8697.0, 8752.518611476366, 8790.296776257916, 8805.42764720291, 8653.740387788377, 8747.912520874805, 8755.0, 8763.036066032731, 8807.559622018873, 8604.0, 8732.47605143687, 8741.300695944372, 8751.649934002633, 8772.561371931379, 41421.58578414207, 41730.79134604338, 41820.581794182275, 41868.371974420406, 42038.78980605077, 3289.5394644749754, 3330.6835850594157, 3378.712809411203, 3725.5156829612247, 3742.2141350316465, 29987.550186747216, 30390.0, 31242.687573124203, 31329.84335078333, 31882.840585796923, 3965.6017466470707, 4032.6773858091283, 4081.1429599784083, 4089.0517817785535, 4131.690123240769, 270562.0, 271036.0, 271707.0, 271819.999999998, 272173.0, 60879.0, 61096.0, 61125.69437152786, 61291.387086129456, 61819.690901546106, 65617.34382656208, 65920.6703966477, 65997.0, 66190.66904665445, 72295.63852180811, 15182.46861359847, 15492.922535387477, 15501.302441389938, 15586.454474093352, 15638.98346607467, 11639.418029098511, 11650.941745291218, 11681.0, 11690.357030363411, 11698.0, 21006.369808905758, 21311.78688213129, 21353.572928541344, 21368.893155534435, 21374.679379809317, 7848.529088254723, 8029.1167971524255, 8051.315638170821, 8060.234277743605, 8126.0, 990.8266053440764, 1017.5065093429681, 1047.5600247895902, 1079.255313833468, 1087.7443800706828, 29605.85197074001, 29746.40507189844, 29789.255268618024, 29929.251768705955, 34113.317733645184, 1035.7876635289747, 1193.7612477504533, 1194.9761004779855, 1196.8803119688137, 1211.6486218996567, 15882.44411445617, 16014.67970640604, 16030.398031668054, 16177.4337898173, 16187.757183642254, 387368.0, 389196.0, 393970.0, 394054.0, 394952.0, 56048.719756400955, 56501.71749141228, 56578.0, 56803.71598141983, 56831.715841420526, 1364.0519838712, 1371.7805151175965, 1376.483818568037, 1376.7315373502272, 1387.195426652539, 27920.0, 29711.55432668555, 29718.702812971595, 29732.40535189241, 29837.0, 41458.0, 41544.58455415528, 41650.791746041075, 42668.35997460103, 42785.78607107069, 293390.0, 293694.0, 294463.0, 295306.0, 297657.0, 33306.167345816546, 45088.54911450844, 45395.0, 45558.0, 45848.0, 45553.31670025019, 46361.53638463572, 46395.53604463912, 46494.53505464902, 46729.53270467252, 37239.0, 37315.44026839654, 38938.4159237606, 39257.411138833515, 39400.802995985985, 38581.807090964365, 39076.0, 39257.607423925394, 39344.80327598344, 39802.2039559213, 37560.624393755716, 37565.81217093897, 37617.62382376251, 38083.428748568236, 38155.0, 32029.67970320267, 35197.120071998404, 35277.29445411129, 35471.64528354684, 36001.81999089988, 26286.60570091412, 26630.334241644116, 27676.308092297855, 27924.022659206832, 27984.58023129614], "unit": "ms", "name": "ext.html", "value": 19441.615544763805}, {"lowerIsBetter": false, "replicates": [355.8078637535731, 360.04946940078196, 360.6177451900987, 361.0540384193413, 363.723570086734, 17046.914765426187, 17574.209160587772, 17877.910610446947, 17926.64146717068, 18789.436316910498, 11539.192256542045, 13114.672133196651, 17089.0, 17258.913705431485, 17636.559086022855, 4926.901461970768, 5018.2974383586325, 5085.821996230115, 5095.923561146567, 5109.386873575176, 5030.924536131961, 5055.443901170868, 5058.519440653132, 5060.671056381342, 5068.949310506885, 5253.763580638881, 5412.648177868446, 5413.106837371829, 5515.4760297771645, 5673.177389278552, 5344.706041167715, 5363.651362661453, 5365.651232669864, 5381.919271210896, 5392.703401312926, 5352.785888564453, 5370.3287089113865, 5380.273663055476, 5382.67703937765, 5388.030154572176, 11924.224925379822, 12166.452509637087, 18510.0, 18904.71642925357, 19358.128884200105, 1906.485248982767, 1906.9713954290696, 1963.5091227193202, 2048.9180432782673, 2054.5685406064745, 9515.476648784314, 9829.705108846745, 9975.501224938796, 10692.839607405895, 12920.41858116387, 1720.329071662053, 1755.4382597568783, 1810.900400477973, 1811.429399739078, 1819.372316550801, 59846.700766496324, 61733.0, 61870.69064654693, 63154.0526892097, 63158.684206579135, 10244.59021639141, 10293.125084367912, 10342.224333175041, 10375.27373083877, 10414.635487757892, 13626.454941802414, 13680.0, 13711.725765484634, 13740.519081832088, 13780.0, 7408.629568521553, 7436.814079647944, 7686.884696729554, 7718.884216736754, 7731.072271327364, 7347.5224110432655, 7353.669084891193, 7359.37445317154, 7393.778186654301, 7456.51532650376, 4456.153330867125, 4492.9775351123035, 4497.2804351304285, 4503.256962601135, 4530.682852200314, 1822.5443639090226, 1834.8807327523668, 1849.898255595955, 1898.1078892920304, 1912.4645099372199, 417.83077853469393, 425.5786771096592, 458.52084571622737, 812.1999830167399, 937.2127412972999, 10654.307470014579, 11208.04731597807, 15846.76229856553, 16601.667966640598, 16738.665226695397, 932.664240873285, 945.6075728572703, 949.6106596295624, 956.4261443134203, 961.0, 9673.129418352382, 9777.217822574177, 10060.647877324258, 10109.949450252849, 10166.8474972874, 491280.0, 500761.0, 514251.0, 517946.0, 522260.0, 74951.62524187344, 77380.61309693416, 77486.0, 77519.0, 78281.2171878274, 1133.393634405589, 1178.0, 1184.2598376014992, 1186.1815347410259, 1196.5931583261734, 14820.777688334469, 15014.0, 15684.137372444626, 15871.444499442465, 16016.839831601535, 31244.68755312418, 31644.0, 31822.840885795424, 31968.840155799073, 32416.513752293264, 40771.0, 44171.77914110538, 44951.32573011342, 45325.546744532134, 47645.52354476411, 14272.571822845332, 14547.0, 14770.261486925825, 15188.392464301745, 15327.770083448535, 18534.0, 18638.068096595387, 18692.532686682942, 18718.812811871707, 19966.70049949281, 9957.950210248902, 9981.650642227487, 10177.745556361151, 10223.693289201336, 10267.640632577824, 10050.0, 10129.240306976859, 10205.38767673942, 10241.539130739284, 10507.579696812347, 10080.495975201356, 10540.209484288862, 10702.678919632424, 10752.51613677402, 10955.890441095487, 14919.25403729831, 14970.775438368215, 15133.697326053638, 15278.312475938832, 15284.235788210322, 15708.214589270263, 15925.68148637044, 16019.759703604688, 16161.27274272684, 16545.172741362643], "unit": "ms", "name": "jquery.html", "value": 8681.442993416635}, {"lowerIsBetter": false, "replicates": [1491.470527962574, 1704.9829501704983, 1764.3207365164408, 1778.5375802291408, 1780.5548612846785, 7297.489175757699, 7390.408767298617, 7600.20197879223, 7624.656890439923, 7771.106322772883, 7793.493422927506, 7800.531968081905, 7809.960950195241, 7829.256220659028, 7905.328047116002, 2240.6863039174486, 2292.495650956787, 2295.2196253273883, 2297.931062068132, 2302.988485057581, 2280.1107568048474, 2288.347820871052, 2346.577616029114, 2348.037304705071, 2348.8708121053337, 2196.934091977243, 2229.9331020069344, 2251.966220506694, 2252.0653928619604, 2282.3267136194863, 2169.425102347879, 2227.888605569723, 2253.8985745641485, 2258.7515373308925, 2262.6040442922504, 2281.726192856868, 2299.586074506588, 2306.7116610423695, 2313.8958746856433, 2314.5023819878807, 7609.353204977583, 7615.504992175491, 7630.809229769245, 7640.312371886502, 7677.769666909946, 4619.12236675034, 4712.64655150865, 4722.929156062662, 4730.526947305242, 4734.928976065362, 3024.7882648214636, 3065.2336915771057, 3096.814191148538, 3136.2002689314077, 3139.827309497977, 984.0012387426767, 1006.8338724110513, 1037.31537185458, 1047.958081676732, 1048.3459045578775, 10300.918403567668, 10324.380537167794, 10340.534675939525, 10373.325733827278, 10422.062014418738, 4050.5746896576024, 4098.0, 4120.7733574653685, 4141.79291035447, 4145.440365550612, 8504.532250726146, 8540.829183416421, 8566.14338566151, 8579.099194584604, 8603.139686031347, 4578.862634120982, 4599.264117741145, 4636.629069674418, 4643.187442197669, 4662.603678687282, 4210.263203939359, 4218.240716670967, 4226.154769046203, 4229.788510574459, 4262.595053469915, 3386.390449719025, 3393.474011528217, 3402.1834759657504, 3406.131436483681, 3413.7269018478464, 1019.9949000254951, 1024.9231307651955, 1025.5795123999274, 1028.2545154762886, 1036.2849633752687, 1041.5313109100935, 1050.1546255264586, 1053.115383078218, 1185.6917201527665, 1312.068431413688, 7107.111611048619, 7146.285371462812, 7148.070750802362, 7153.141623005168, 7159.749408770668, 1140.880207578209, 1158.2645020412099, 1165.854268216473, 1169.1231576317762, 1180.221054104287, 5674.574406919498, 5683.715814209273, 5739.770409183586, 5743.138529220567, 5768.567357448208, 8866.601002954883, 8922.73231803047, 9062.592183351633, 9201.907980920105, 9207.0, 8935.642574296955, 8944.239739622206, 8954.68658596959, 8963.955180224188, 9038.774030649154, 7061.364477197077, 7134.215236324, 7143.464240182007, 7152.92847071533, 7189.173245076883, 6707.5975441473665, 6731.394174524316, 6742.325767423218, 6748.460123190035, 6761.0534525167495, 7766.301032907066, 8037.437379383387, 8131.2681858633005, 8144.959275203586, 8163.591820408837, 8130.065042520186, 8242.793930151794, 8250.133735957637, 8360.540170290693, 8361.707340243061, 6425.935740642721, 6569.0, 6575.079488871657, 6819.863602728017, 6825.522213445011, 7223.313785190398, 7359.558426494427, 7394.33450989392, 7438.144613369532, 7451.552906825608, 6858.3827455529245, 6936.0636314096955, 6955.095837541087, 6966.895496567454, 7125.501214915113, 6539.346065393423, 6650.700718467778, 6877.6217308048535, 6881.449484041164, 7007.7196912122945, 6767.39093481589, 6783.762568310085, 6784.050232967487, 6790.490713196431, 6801.353871382211, 5682.232898558642, 5990.580659353804, 5996.040633498619, 6010.699465026819, 6128.724207410588, 6210.099535567408, 6233.501319894488, 6235.095911092775, 6240.906386404298, 6244.906326405016], "unit": "ms", "name": "mootools.html", "value": 4396.987519710901}, {"lowerIsBetter": false, "replicates": [320.87165133946417, 328.35478285169637, 334.11126403765985, 340.5929913753066, 347.05427709491624, 6335.683215839207, 6357.3642635736405, 6376.968115159418, 6404.487640988721, 6528.183977002875, 6279.497640188785, 6315.336889626592, 6323.24121105468, 6329.430351268385, 6343.777967771129, 4769.070031343889, 4772.498887616785, 4775.283707443877, 4775.426948766136, 4783.139034973703, 4771.165046116933, 4779.6176305895615, 4781.976090119544, 4786.37777088978, 4790.23356262998, 4647.14027904837, 4731.550502702255, 4733.952660473386, 4739.028499157665, 4746.193147164973, 4677.695949763254, 4695.859124226278, 4713.293006049086, 4717.433907931053, 4722.315264286659, 4064.512258528966, 4070.979645101785, 4071.694622903294, 4076.9388459172837, 4085.9182816343805, 5968.46283834457, 6003.339632640406, 6034.758609655652, 6046.576739628228, 6047.334793172748, 5383.78464861409, 5437.510624043815, 5497.532709719679, 5501.559875210014, 5502.779888804443, 6604.405603495708, 6618.338166183391, 6645.3354664533645, 6685.565438246498, 6689.096971908779, 4498.392716983198, 4522.276435770261, 4546.022605139878, 4549.294859296814, 4558.840440584564, 6737.225219099768, 6814.0, 6926.792196234071, 6937.924621683647, 6944.097267355262, 4528.773561321921, 4531.161735079021, 4532.252178390529, 4535.909281814345, 4545.749983750859, 4590.540945905383, 4613.561711637389, 4618.630509559294, 4620.0990806793025, 4630.490646028934, 5438.5377242934, 5442.047641662693, 5444.50999410055, 5445.237666726662, 5447.237386765856, 6534.379233972765, 6621.966890165615, 6686.231083425371, 6725.19297684281, 6740.460763138937, 1600.7198740220415, 1621.4324986254717, 1625.8780591455688, 1627.4059968111553, 1636.0347395036986, 1057.862477877871, 1084.1272775415866, 1105.7125147461718, 1111.2721167635211, 1121.4448847820381, 6307.211598550181, 6344.58760180596, 6369.777057802955, 6398.648074355955, 6403.0, 6843.076184715099, 6852.554583952027, 6858.794236172923, 6859.279775623588, 6862.622555759481, 6394.424501794861, 6415.0, 6422.165118534654, 6422.8715425691225, 6426.6144031357335, 3765.548134223911, 3769.9246015079543, 3780.716446266541, 3801.2967600993907, 3826.311263972512, 7305.159906610807, 7337.19290878003, 7341.669624866894, 7341.70633174667, 7344.96327518359, 6997.405220556309, 7116.893246601305, 7137.10786151731, 7188.245234250433, 7209.0988626421695, 7231.63841807918, 7247.456440766963, 7270.745523906638, 7278.0, 7284.0, 6972.965135174291, 6976.7558135465015, 6981.232064473005, 7020.0, 7025.473089518205, 6678.0, 6807.978803179364, 6850.6574671267235, 6865.965670171817, 6921.446284297345, 7210.521843022273, 7258.818529536804, 7277.3086556777025, 7295.343419092307, 7296.96351518239, 4681.812727490998, 4722.716637001791, 4727.929081063856, 4729.763511824326, 4736.8105275788585, 6678.265390806911, 6697.732090716317, 6772.492063095189, 6937.549059311129, 6942.375186233263, 6550.115734375989, 6677.866442671217, 6690.899636505554, 6723.0, 6725.293844146294, 6757.493188010821, 6779.864402712017, 6781.525293229427, 6797.864042719217, 6801.387875091265, 6539.509536784665, 6593.0769692244085, 6637.103990961158, 6637.1703537057865, 6649.800505984828, 6730.764423245163, 6749.493787965824, 6756.358145976124, 6794.456443484608, 6816.454683625398, 6616.106825578485, 6622.10601568782, 6635.800925972036, 6640.90038649411, 6664.333566643297], "unit": "ms", "name": "prototype.html", "value": 5009.190444575255}, {"lowerIsBetter": false, "replicates": [765.1736124985017, 779.2635959018729, 822.4284122534841, 861.1345597674338, 867.8437881181387, 13458.59624211274, 13709.177449353047, 13772.931135344323, 13818.30908454577, 13830.446782128703, 12628.558000469986, 12818.0, 12888.097833151684, 12954.028447866423, 13127.868721312809, 809.7044578728766, 831.4886344897905, 840.7687885831384, 840.8990921089478, 841.6675413211777, 821.109096630157, 833.0794472108324, 838.4172999765166, 841.5287439034161, 843.6625349860044, 867.4361664917791, 873.3755364914085, 877.2806298834957, 879.0813599788205, 882.867569864519, 854.7435769269194, 870.0299166429448, 871.5598622695561, 871.904090550039, 872.289084396215, 631.1794666933015, 633.7496688807942, 634.3181080338654, 639.229728177545, 639.6545865232769, 12205.45075471606, 12313.0, 12414.317212553306, 12489.18820276679, 12506.062045346636, 10719.98160174782, 10974.122070234362, 11063.778724425467, 11124.110071194285, 11306.547738090549, 9417.717468475888, 9729.311063888967, 9846.90153098467, 9878.654247101316, 9918.702438926844, 3614.3855544557227, 3644.125409901631, 3652.0, 3671.889843304705, 3796.2597293527774, 45440.54559454396, 45624.0, 46448.07103857938, 46582.301265481045, 46779.766101169276, 10277.691669249934, 10319.649682636802, 10391.792164156675, 10504.527296271686, 10825.945870270598, 18385.356512521998, 18407.0, 18465.261389544536, 18493.260269589067, 18512.907435462737, 7287.3441390274065, 7602.847943041108, 7721.189275126031, 7800.843983120306, 7804.219578042151, 4002.699797515198, 4029.979850100731, 4188.350805625133, 4214.241436541452, 4215.262329092397, 3104.2084268511385, 3113.252819323346, 3115.610548681415, 3144.402563512925, 3150.291184483473, 531.0812294730061, 547.0426753181931, 552.2268823646926, 552.5496720173127, 553.8670719027485, 650.4796163069525, 705.5308220033722, 712.8752468318023, 719.6890625155282, 734.4931996922106, 8595.613197406132, 8686.86969695455, 8742.606582703793, 8742.694005709769, 8758.124187581318, 679.2935347238915, 713.8929160625844, 714.9428045756327, 718.2171433137905, 742.2354974376401, 3983.4821473208876, 4505.5719706627815, 4562.315652652129, 4579.358889755437, 4591.586757191869, 56548.43451565514, 56826.0, 56865.71567142138, 57326.426735732945, 57454.425455745746, 49748.75125624421, 51592.74203628958, 51976.0, 51995.220071698954, 52449.2132618011, 41880.1623967519, 46335.99999999932, 49064.26403603949, 51527.484725153015, 51562.0, 8748.600223964135, 9076.455412675261, 9121.680741174026, 9161.679341223025, 9230.861537077084, 35144.47283290701, 35920.4611930816, 35943.64056359403, 36138.09654758547, 36936.26127477489, 40375.798121009204, 40840.183196336504, 43354.0, 45417.0, 45526.54473455223, 11688.298702077902, 11749.29504229749, 11822.645320640395, 11918.36897105704, 12196.268223906594, 12329.321887296284, 12449.93775031119, 12575.371231438208, 12658.936705316783, 12777.616671499869, 11477.885221147682, 11812.232204906653, 11824.881751182722, 12170.574029909265, 12235.510579576718, 11438.17747382387, 11685.415729213675, 11937.0, 12022.819657704966, 12032.699182520508, 11689.240199387013, 11837.526498939946, 11872.287662740264, 12253.387330633612, 12264.632061038183, 9763.658271960447, 10017.499125043865, 10102.39385636864, 10229.590816367261, 10451.0, 9534.332596718163, 9851.408915465096, 9908.35595686278, 9944.701658950244, 10095.091441770275], "unit": "ms", "name": "yui.html", "value": 6412.07425613766}], "name": "dromaeo_css", "value": 7112.093845932803}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 111.0, 110.0, 114.0, 124.0, 110.0, 113.0, 113.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 154.0, 180.0, 125.0, 151.0, 152.0, 125.0, 164.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 160.0, 161.0, 162.0, 163.0, 160.0, 162.0, 172.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 73.0, 73.0, 72.0, 124.0, 72.0, 73.0, 73.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 77.7}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 130.0, 91.0, 91.0, 90.0, 130.0, 91.0, 91.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 102.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 111.0, 111.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 145.0, 147.0, 147.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 101.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 61.0, 61.0, 63.0, 61.0, 63.0, 63.0, 60.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 61.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 70.0, 69.0, 69.0, 70.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [93.0, 88.0, 85.0, 85.0, 87.0, 87.0, 85.0, 86.0, 88.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [132.0, 129.0, 123.0, 118.0, 125.0, 119.0, 124.0, 123.0, 115.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [144.0, 150.0, 151.0, 154.0, 151.0, 153.0, 151.0, 148.0, 152.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 68.0, 66.0, 68.0, 68.0, 66.0, 70.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1511.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.82130584192439], "unit": "score", "name": "Richards", "value": 205.45764000000003}, {"lowerIsBetter": false, "replicates": [186.56716417910448], "unit": "score", "name": "DeltaBlue", "value": 354.39248}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"lowerIsBetter": false, "replicates": [5102.040816326531], "unit": "score", "name": "Decrypt", "value": 52.17147600000001}, {"lowerIsBetter": false, "replicates": [1059.322033898305], "unit": "score", "name": "RayTrace", "value": 698.549616}, {"lowerIsBetter": false, "replicates": [697.350069735007], "unit": "score", "name": "Earley", "value": 955.7079420000003}, {"lowerIsBetter": false, "replicates": [12084.33734939759], "unit": "score", "name": "Boyer", "value": 55.150976071784655}, {"lowerIsBetter": false, "replicates": [25425.0], "unit": "score", "name": "RegExp", "value": 35.83028515240902}, {"lowerIsBetter": false, "replicates": [619.8142414860681], "unit": "score", "name": "Splay", "value": 131.47648851148847}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21366.388079545308}]} 13:13:34 INFO - RETURN: dromaeo_css: 7112.09 13:13:34 INFO - RETURN: kraken: 1511.70 13:13:34 INFO - RETURN: v8_7: 21366.39 13:13:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21366.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1511.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7112.09"}}} 13:13:34 INFO - Return code: 0 13:13:34 INFO - # TBPL SUCCESS # 13:13:34 INFO - Running post-action listener: _resource_record_post_action 13:13:34 INFO - Running post-run listener: _resource_record_post_run 13:13:35 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 589824; Write bytes: 343359488; Read time: 76; Write time: 219592 13:13:35 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 57847808; Read time: 0; Write time: 34768 13:13:35 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 589824; Write bytes: 285511680; Read time: 76; Write time: 184824 13:13:35 INFO - Running post-run listener: _upload_blobber_files 13:13:35 INFO - Blob upload gear active. 13:13:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:13:35 INFO - Copying logs to upload dir... 13:13:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.736712 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-20 13:13:35.997595) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 13:13:36.001517) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009960 build_url: 'https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/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 13:13:36.052179) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 13:13:36.052524) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1448051802.237151-1795116589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004748 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 13:13:36.102237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 13:13:36.102600) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 13:13:36.102913) ========= ========= Total master_lag: 0.21 =========