builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1447740058.35 results: success (0) buildid: 20151116203312 builduid: 3e17d0660b86454890afa588d6fea284 revision: ffdc7f22130425020f5d648ef99c10b947541659 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.347603) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.348300) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.348632) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006709 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.370270) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.370553) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.384493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.384838) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.434893) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.435223) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.435606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.435908) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 22:00:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.4M=0s 2015-11-16 22:00:59 (47.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.640200) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.640768) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018583 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.693694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.694031) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ffdc7f22130425020f5d648ef99c10b947541659 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ffdc7f22130425020f5d648ef99c10b947541659 --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=7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 22:00:59,372 truncating revision to first 12 chars 2015-11-16 22:00:59,373 Setting DEBUG logging. 2015-11-16 22:00:59,373 attempt 1/10 2015-11-16 22:00:59,373 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ffdc7f221304?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 22:00:59,605 unpacking tar archive at: fx-team-ffdc7f221304/testing/mozharness/ program finished with exit code 0 elapsedTime=0.493824 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:59.202315) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:59.202818) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:59.216182) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:59.216629) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:59.217252) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-16 22:00:59.218022) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:00:59 INFO - MultiFileLogger online at 20151116 22:00:59 in /builds/slave/test-pgo 22:00:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:00:59 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:00:59 INFO - {'append_to_log': False, 22:00:59 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:00:59 INFO - 'blob_upload_branch': 'Fx-Team', 22:00:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:00:59 INFO - 'branch': 'Fx-Team', 22:00:59 INFO - 'buildbot_json_path': 'buildprops.json', 22:00:59 INFO - 'config_files': ('talos/linux_config.py',), 22:00:59 INFO - 'default_actions': ('clobber', 22:00:59 INFO - 'read-buildbot-config', 22:00:59 INFO - 'download-and-extract', 22:00:59 INFO - 'populate-webroot', 22:00:59 INFO - 'create-virtualenv', 22:00:59 INFO - 'install', 22:00:59 INFO - 'run-tests'), 22:00:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:00:59 INFO - 'download_minidump_stackwalk': True, 22:00:59 INFO - 'download_symbols': 'ondemand', 22:00:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:00:59 INFO - 'tooltool.py': '/tools/tooltool.py', 22:00:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:00:59 INFO - '/tools/misc-python/virtualenv.py')}, 22:00:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:00:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:00:59 INFO - 'installer_path': 'installer.exe', 22:00:59 INFO - 'log_level': 'info', 22:00:59 INFO - 'log_name': 'talos', 22:00:59 INFO - 'log_to_console': True, 22:00:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:00:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:00:59 INFO - 'opt_config_files': (), 22:00:59 INFO - 'pip_index': False, 22:00:59 INFO - 'sps_profile': False, 22:00:59 INFO - 'sps_profile_interval': 0, 22:00:59 INFO - 'suite': 'dromaeojs', 22:00:59 INFO - 'system_bits': '64', 22:00:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:00:59 INFO - 'title': 'talos-linux64-ix-041', 22:00:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:00:59 INFO - 'use_talos_json': True, 22:00:59 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:00:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:00:59 INFO - 'work_dir': 'build'} 22:00:59 INFO - ##### 22:00:59 INFO - ##### Running clobber step. 22:00:59 INFO - ##### 22:00:59 INFO - Running pre-action listener: _resource_record_pre_action 22:00:59 INFO - Running main action method: clobber 22:00:59 INFO - rmtree: /builds/slave/test-pgo/build 22:00:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:01:00 INFO - Running post-action listener: _resource_record_post_action 22:01:00 INFO - ##### 22:01:00 INFO - ##### Running read-buildbot-config step. 22:01:00 INFO - ##### 22:01:00 INFO - Running pre-action listener: _resource_record_pre_action 22:01:00 INFO - Running main action method: read_buildbot_config 22:01:00 INFO - Using buildbot properties: 22:01:00 INFO - { 22:01:00 INFO - "properties": { 22:01:00 INFO - "buildnumber": 492, 22:01:00 INFO - "product": "firefox", 22:01:00 INFO - "script_repo_revision": "production", 22:01:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:01:00 INFO - "repository": "", 22:01:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:01:00 INFO - "buildid": "20151116203312", 22:01:00 INFO - "slavename": "talos-linux64-ix-041", 22:01:00 INFO - "pgo_build": "True", 22:01:00 INFO - "basedir": "/builds/slave/test-pgo", 22:01:00 INFO - "project": "", 22:01:00 INFO - "platform": "ubuntu64_hw", 22:01:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:01:00 INFO - "slavebuilddir": "test", 22:01:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:01:00 INFO - "branch": "fx-team", 22:01:00 INFO - "repo_path": "integration/fx-team", 22:01:00 INFO - "stage_platform": "linux64-pgo", 22:01:00 INFO - "builduid": "3e17d0660b86454890afa588d6fea284", 22:01:00 INFO - "revision": "ffdc7f22130425020f5d648ef99c10b947541659" 22:01:00 INFO - }, 22:01:00 INFO - "sourcestamp": { 22:01:00 INFO - "repository": "", 22:01:00 INFO - "hasPatch": false, 22:01:00 INFO - "project": "", 22:01:00 INFO - "branch": "fx-team-linux64-pgo-talos", 22:01:00 INFO - "changes": [ 22:01:00 INFO - { 22:01:00 INFO - "category": null, 22:01:00 INFO - "files": [ 22:01:00 INFO - { 22:01:00 INFO - "url": null, 22:01:00 INFO - "name": "https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:01:00 INFO - } 22:01:00 INFO - ], 22:01:00 INFO - "repository": "", 22:01:00 INFO - "rev": "ffdc7f22130425020f5d648ef99c10b947541659", 22:01:00 INFO - "who": "sendchange", 22:01:00 INFO - "when": 1447739973, 22:01:00 INFO - "number": 6670193, 22:01:00 INFO - "comments": "", 22:01:00 INFO - "project": "", 22:01:00 INFO - "at": "Mon 16 Nov 2015 21:59:33", 22:01:00 INFO - "branch": "fx-team-linux64-pgo-talos", 22:01:00 INFO - "revlink": "", 22:01:00 INFO - "properties": [ 22:01:00 INFO - [ 22:01:00 INFO - "buildid", 22:01:00 INFO - "20151116203312", 22:01:00 INFO - "Change" 22:01:00 INFO - ], 22:01:00 INFO - [ 22:01:00 INFO - "builduid", 22:01:00 INFO - "3e17d0660b86454890afa588d6fea284", 22:01:00 INFO - "Change" 22:01:00 INFO - ], 22:01:00 INFO - [ 22:01:00 INFO - "pgo_build", 22:01:00 INFO - "True", 22:01:00 INFO - "Change" 22:01:00 INFO - ] 22:01:00 INFO - ], 22:01:00 INFO - "revision": "ffdc7f22130425020f5d648ef99c10b947541659" 22:01:00 INFO - } 22:01:00 INFO - ], 22:01:00 INFO - "revision": "ffdc7f22130425020f5d648ef99c10b947541659" 22:01:00 INFO - } 22:01:00 INFO - } 22:01:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:01:00 INFO - Running post-action listener: _resource_record_post_action 22:01:00 INFO - ##### 22:01:00 INFO - ##### Running download-and-extract step. 22:01:00 INFO - ##### 22:01:00 INFO - Running pre-action listener: _resource_record_pre_action 22:01:00 INFO - Running main action method: download_and_extract 22:01:00 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:00 INFO - https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:01:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/test_packages.json 22:01:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/test_packages.json 22:01:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:01:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:01:01 INFO - Downloaded 1302 bytes. 22:01:01 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:01:01 INFO - Using the following test package requirements: 22:01:01 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:01 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:01:01 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:01 INFO - u'jsshell-linux-x86_64.zip'], 22:01:01 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:01:01 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:01 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:01:01 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:01:01 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:01:01 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:01 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:01:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:01 INFO - https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:02 INFO - Downloaded 22458461 bytes. 22:01:02 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 22:01:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:02 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 22:01:03 INFO - Return code: 0 22:01:03 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 22:01: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')]} 22:01:03 INFO - https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:05 INFO - Downloaded 22458461 bytes. 22:01:05 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 22:01:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:05 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 22:01:06 INFO - Return code: 0 22:01: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')]} 22:01:06 INFO - https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:01:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:07 INFO - Downloaded 11131693 bytes. 22:01:07 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 22:01:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:07 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 22:01:08 INFO - Return code: 0 22:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:08 INFO - https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:01:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:10 INFO - Downloaded 57165258 bytes. 22:01:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:10 INFO - mkdir: /builds/slave/test-pgo/properties 22:01:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:01:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:01:10 INFO - Contents: 22:01:10 INFO - build_url:https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:10 INFO - Running post-action listener: _resource_record_post_action 22:01:10 INFO - Running post-action listener: set_extra_try_arguments 22:01:10 INFO - ##### 22:01:10 INFO - ##### Running populate-webroot step. 22:01:10 INFO - ##### 22:01:10 INFO - Running pre-action listener: _resource_record_pre_action 22:01:10 INFO - Running main action method: populate_webroot 22:01:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:01:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:01:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:01:10 INFO - '../fennec_ids.txt'], 22:01:10 INFO - 'tests': ['tcheck2']}, 22:01:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:01:10 INFO - '--tppagecycles', 22:01:10 INFO - '7'], 22:01:10 INFO - 'tests': ['tsvgm']}}, 22:01:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:01:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:01:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:01:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:01:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:01:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:01:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:10 INFO - 'talos_options': ['--e10s'], 22:01:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:10 INFO - 'tests': ['damp', 'tps']}, 22:01:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:10 INFO - 'talos_options': ['--e10s'], 22:01:10 INFO - 'tests': ['damp', 'tps']}, 22:01:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:01:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:01:10 INFO - 'other': {'tests': ['a11yr', 22:01:10 INFO - 'ts_paint', 22:01:10 INFO - 'tpaint', 22:01:10 INFO - 'sessionrestore', 22:01:10 INFO - 'sessionrestore_no_auto_restore']}, 22:01:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:01:10 INFO - 'tests': ['a11yr', 22:01:10 INFO - 'ts_paint', 22:01:10 INFO - 'tpaint', 22:01:10 INFO - 'sessionrestore', 22:01:10 INFO - 'sessionrestore_no_auto_restore']}, 22:01:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:01:10 INFO - 'tests': ['a11yr', 22:01:10 INFO - 'ts_paint', 22:01:10 INFO - 'tpaint', 22:01:10 INFO - 'sessionrestore', 22:01:10 INFO - 'sessionrestore_no_auto_restore']}, 22:01:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:01:10 INFO - 'tests': ['a11yr', 22:01:10 INFO - 'ts_paint', 22:01:10 INFO - 'tpaint', 22:01:10 INFO - 'sessionrestore', 22:01:10 INFO - 'sessionrestore_no_auto_restore']}, 22:01:10 INFO - 'other_l64': {'tests': ['a11yr', 22:01:10 INFO - 'ts_paint', 22:01:10 INFO - 'tpaint', 22:01:10 INFO - 'sessionrestore', 22:01:10 INFO - 'sessionrestore_no_auto_restore']}, 22:01:10 INFO - 'other_nol64': {'tests': ['a11yr', 22:01:10 INFO - 'ts_paint', 22:01:10 INFO - 'tpaint', 22:01:10 INFO - 'sessionrestore', 22:01:10 INFO - 'sessionrestore_no_auto_restore']}, 22:01:10 INFO - 'svgr': {'tests': ['tsvgx', 22:01:10 INFO - 'tsvgr_opacity', 22:01:10 INFO - 'tart', 22:01:10 INFO - 'tscrollx', 22:01:10 INFO - 'cart']}, 22:01:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:01:10 INFO - 'tests': ['tsvgx', 22:01:10 INFO - 'tsvgr_opacity', 22:01:10 INFO - 'tart', 22:01:10 INFO - 'tscrollx', 22:01:10 INFO - 'cart']}, 22:01:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:10 INFO - 'tests': ['tp5o']}, 22:01:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:10 INFO - 'talos_options': ['--e10s'], 22:01:10 INFO - 'tests': ['tp5o']}, 22:01:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:10 INFO - 'talos_options': ['--xperf_path', 22:01:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:10 INFO - 'tests': ['tp5n']}, 22:01:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:10 INFO - 'talos_options': ['--e10s', 22:01:10 INFO - '--xperf_path', 22:01:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:10 INFO - 'tests': ['tp5n']}}, 22:01:10 INFO - 'talos.zip': {'path': '', 22:01:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:01:10 INFO - Running post-action listener: _resource_record_post_action 22:01:10 INFO - ##### 22:01:10 INFO - ##### Running create-virtualenv step. 22:01:10 INFO - ##### 22:01:10 INFO - Running pre-action listener: _resource_record_pre_action 22:01:10 INFO - Running main action method: create_virtualenv 22:01:10 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:01:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:01:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:01:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:01:10 INFO - Using real prefix '/usr' 22:01:10 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:01:11 INFO - Installing distribute.............................................................................................................................................................................................done. 22:01:13 INFO - Installing pip.................done. 22:01:13 INFO - Return code: 0 22:01:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dfd342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060a90>, '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 0x20b2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b32e0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', '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 22:01:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:01:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:01:13 INFO - Using env: {'DISPLAY': ':0', 22:01:13 INFO - 'HOME': '/home/cltbld', 22:01:13 INFO - 'LANG': 'en_US.UTF-8', 22:01:13 INFO - 'LANGUAGE': 'en_US:en', 22:01:13 INFO - 'LOGNAME': 'cltbld', 22:01:13 INFO - 'MAIL': '/var/mail/cltbld', 22:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:13 INFO - 'MOZ_NO_REMOTE': '1', 22:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:13 INFO - 'NO_EM_RESTART': '1', 22:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:13 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:13 INFO - 'SHELL': '/bin/bash', 22:01:13 INFO - 'SHLVL': '1', 22:01:13 INFO - 'TERM': 'linux', 22:01:13 INFO - 'TMOUT': '86400', 22:01:13 INFO - 'USER': 'cltbld', 22:01:13 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', 22:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:13 INFO - '_': '/tools/buildbot/bin/python'} 22:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:01:13 INFO - Cleaning up... 22:01:13 INFO - Return code: 0 22:01:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dfd342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060a90>, '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 0x20b2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b32e0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', '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 22:01:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:01:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:01:13 INFO - Using env: {'DISPLAY': ':0', 22:01:13 INFO - 'HOME': '/home/cltbld', 22:01:13 INFO - 'LANG': 'en_US.UTF-8', 22:01:13 INFO - 'LANGUAGE': 'en_US:en', 22:01:13 INFO - 'LOGNAME': 'cltbld', 22:01:13 INFO - 'MAIL': '/var/mail/cltbld', 22:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:13 INFO - 'MOZ_NO_REMOTE': '1', 22:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:13 INFO - 'NO_EM_RESTART': '1', 22:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:13 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:13 INFO - 'SHELL': '/bin/bash', 22:01:13 INFO - 'SHLVL': '1', 22:01:13 INFO - 'TERM': 'linux', 22:01:13 INFO - 'TMOUT': '86400', 22:01:13 INFO - 'USER': 'cltbld', 22:01:13 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', 22:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:13 INFO - '_': '/tools/buildbot/bin/python'} 22:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:13 INFO - Downloading/unpacking psutil>=0.7.1 22:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:15 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:01:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:01:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:01:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:15 INFO - Installing collected packages: psutil 22:01:15 INFO - Running setup.py install for psutil 22:01:15 INFO - building 'psutil._psutil_linux' extension 22:01:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:01:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:01:15 INFO - building 'psutil._psutil_posix' extension 22:01:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:01:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:01:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:15 INFO - Successfully installed psutil 22:01:15 INFO - Cleaning up... 22:01:15 INFO - Return code: 0 22:01:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:01:15 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')]} 22:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:15 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')]} 22:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:15 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 0x7f2dfd342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060a90>, '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 0x20b2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b32e0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', '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 22:01:15 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 22:01:15 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 22:01:15 INFO - Using env: {'DISPLAY': ':0', 22:01:15 INFO - 'HOME': '/home/cltbld', 22:01:15 INFO - 'LANG': 'en_US.UTF-8', 22:01:15 INFO - 'LANGUAGE': 'en_US:en', 22:01:15 INFO - 'LOGNAME': 'cltbld', 22:01:15 INFO - 'MAIL': '/var/mail/cltbld', 22:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:15 INFO - 'MOZ_NO_REMOTE': '1', 22:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:15 INFO - 'NO_EM_RESTART': '1', 22:01:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:15 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:15 INFO - 'SHELL': '/bin/bash', 22:01:15 INFO - 'SHLVL': '1', 22:01:15 INFO - 'TERM': 'linux', 22:01:15 INFO - 'TMOUT': '86400', 22:01:15 INFO - 'USER': 'cltbld', 22:01:15 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', 22:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:15 INFO - '_': '/tools/buildbot/bin/python'} 22:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:01:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:01:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:01:17 INFO - Installing collected packages: mozsystemmonitor 22:01:17 INFO - Running setup.py install for mozsystemmonitor 22:01:17 INFO - Successfully installed mozsystemmonitor 22:01:17 INFO - Cleaning up... 22:01:17 INFO - Return code: 0 22:01:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:01:17 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')]} 22:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:17 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')]} 22:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:17 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 0x7f2dfd342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060a90>, '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 0x20b2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b32e0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', '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 22:01:17 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 22:01:17 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 22:01:17 INFO - Using env: {'DISPLAY': ':0', 22:01:17 INFO - 'HOME': '/home/cltbld', 22:01:17 INFO - 'LANG': 'en_US.UTF-8', 22:01:17 INFO - 'LANGUAGE': 'en_US:en', 22:01:17 INFO - 'LOGNAME': 'cltbld', 22:01:17 INFO - 'MAIL': '/var/mail/cltbld', 22:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:17 INFO - 'MOZ_NO_REMOTE': '1', 22:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:17 INFO - 'NO_EM_RESTART': '1', 22:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:17 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:17 INFO - 'SHELL': '/bin/bash', 22:01:17 INFO - 'SHLVL': '1', 22:01:17 INFO - 'TERM': 'linux', 22:01:17 INFO - 'TMOUT': '86400', 22:01:17 INFO - 'USER': 'cltbld', 22:01:17 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', 22:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:17 INFO - '_': '/tools/buildbot/bin/python'} 22:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:18 INFO - Downloading/unpacking blobuploader==1.2.4 22:01:18 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 22:01:18 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 22:01:18 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 22:01:18 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 22:01:18 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 22:01:18 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 22:01:19 INFO - Downloading blobuploader-1.2.4.tar.gz 22:01:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:01:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:01:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:01:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:01:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:20 INFO - Downloading docopt-0.6.1.tar.gz 22:01:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:01:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:01:20 INFO - Installing collected packages: blobuploader, requests, docopt 22:01:20 INFO - Running setup.py install for blobuploader 22:01:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:01:20 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:01:20 INFO - Running setup.py install for requests 22:01:20 INFO - Running setup.py install for docopt 22:01:21 INFO - Successfully installed blobuploader requests docopt 22:01:21 INFO - Cleaning up... 22:01:21 INFO - Return code: 0 22:01:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:01:21 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')]} 22:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:21 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')]} 22:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:21 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 0x7f2dfd342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060a90>, '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 0x20b2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b32e0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', '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 22:01:21 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 22:01:21 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 22:01:21 INFO - Using env: {'DISPLAY': ':0', 22:01:21 INFO - 'HOME': '/home/cltbld', 22:01:21 INFO - 'LANG': 'en_US.UTF-8', 22:01:21 INFO - 'LANGUAGE': 'en_US:en', 22:01:21 INFO - 'LOGNAME': 'cltbld', 22:01:21 INFO - 'MAIL': '/var/mail/cltbld', 22:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:21 INFO - 'MOZ_NO_REMOTE': '1', 22:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:21 INFO - 'NO_EM_RESTART': '1', 22:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:21 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:21 INFO - 'SHELL': '/bin/bash', 22:01:21 INFO - 'SHLVL': '1', 22:01:21 INFO - 'TERM': 'linux', 22:01:21 INFO - 'TMOUT': '86400', 22:01:21 INFO - 'USER': 'cltbld', 22:01:21 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', 22:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:21 INFO - '_': '/tools/buildbot/bin/python'} 22:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:01:21 INFO - Running setup.py (path:/tmp/pip-i62I2Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:01:21 INFO - Running setup.py (path:/tmp/pip-JDOiAC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:01:21 INFO - Running setup.py (path:/tmp/pip-IJFGk8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:01:21 INFO - Running setup.py (path:/tmp/pip-Plhv8b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:01:21 INFO - Running setup.py (path:/tmp/pip-lOpxqy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:01:21 INFO - Running setup.py (path:/tmp/pip-W4gPbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:01:21 INFO - Running setup.py (path:/tmp/pip-Gkn_Z6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:01:21 INFO - Running setup.py (path:/tmp/pip-pRxGqC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:01:21 INFO - Running setup.py (path:/tmp/pip-LLI1Dk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:01:21 INFO - Running setup.py (path:/tmp/pip-7m029R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:01:21 INFO - Running setup.py (path:/tmp/pip-4hO5Vg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:01:22 INFO - Running setup.py (path:/tmp/pip-1PILHj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:01:22 INFO - Running setup.py (path:/tmp/pip-uI_yDr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:01:22 INFO - Running setup.py (path:/tmp/pip-zSWTqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:01:22 INFO - Running setup.py (path:/tmp/pip-Kh35Km-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:01:22 INFO - Running setup.py (path:/tmp/pip-v2jrDZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:01:22 INFO - Running setup.py (path:/tmp/pip-iHTwJd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:01:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:01:22 INFO - Running setup.py install for manifestparser 22:01:22 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:01:22 INFO - Running setup.py install for mozcrash 22:01:22 INFO - Running setup.py install for mozdebug 22:01:22 INFO - Running setup.py install for mozdevice 22:01:22 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:01:22 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:01:22 INFO - Running setup.py install for mozfile 22:01:23 INFO - Running setup.py install for mozhttpd 22:01:23 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:01:23 INFO - Running setup.py install for mozinfo 22:01:23 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:01:23 INFO - Running setup.py install for mozInstall 22:01:23 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:01:23 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:01:23 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:01:23 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:01:23 INFO - Running setup.py install for mozleak 22:01:23 INFO - Running setup.py install for mozlog 22:01:23 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:01:23 INFO - Running setup.py install for moznetwork 22:01:23 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:01:23 INFO - Running setup.py install for mozprocess 22:01:23 INFO - Running setup.py install for mozprofile 22:01:23 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:01:23 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:01:23 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:01:23 INFO - Running setup.py install for mozrunner 22:01:23 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:01:23 INFO - Running setup.py install for mozscreenshot 22:01:24 INFO - Running setup.py install for moztest 22:01:24 INFO - Running setup.py install for mozversion 22:01:24 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:01:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:01:24 INFO - Cleaning up... 22:01:24 INFO - Return code: 0 22:01:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:01: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')]} 22:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:24 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 0x7f2dfd342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060a90>, '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 0x20b2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b32e0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', '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 22:01:24 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 22:01:24 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 22:01:24 INFO - Using env: {'DISPLAY': ':0', 22:01:24 INFO - 'HOME': '/home/cltbld', 22:01:24 INFO - 'LANG': 'en_US.UTF-8', 22:01:24 INFO - 'LANGUAGE': 'en_US:en', 22:01:24 INFO - 'LOGNAME': 'cltbld', 22:01:24 INFO - 'MAIL': '/var/mail/cltbld', 22:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:24 INFO - 'MOZ_NO_REMOTE': '1', 22:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:24 INFO - 'NO_EM_RESTART': '1', 22:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:24 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:24 INFO - 'SHELL': '/bin/bash', 22:01:24 INFO - 'SHLVL': '1', 22:01:24 INFO - 'TERM': 'linux', 22:01:24 INFO - 'TMOUT': '86400', 22:01:24 INFO - 'USER': 'cltbld', 22:01:24 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', 22:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:24 INFO - '_': '/tools/buildbot/bin/python'} 22:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:01:24 INFO - Running setup.py (path:/tmp/pip-4EaECu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:01:24 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)) 22:01:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:01:24 INFO - Running setup.py (path:/tmp/pip-RCDlrO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:01:24 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)) 22:01:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:01:24 INFO - Running setup.py (path:/tmp/pip-ol4v8y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:01:24 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)) 22:01:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:01:24 INFO - Running setup.py (path:/tmp/pip-QKTmLM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:01:24 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)) 22:01:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:01:24 INFO - Running setup.py (path:/tmp/pip-4ulh1E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:01:24 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)) 22:01:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:01:24 INFO - Running setup.py (path:/tmp/pip-QG8aPy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:01:24 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)) 22:01:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:01:24 INFO - Running setup.py (path:/tmp/pip-JnSsnD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:01:25 INFO - Running setup.py (path:/tmp/pip-ljKwOF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:01:25 INFO - Running setup.py (path:/tmp/pip-F11ObA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:01:25 INFO - Running setup.py (path:/tmp/pip-VvuliT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:01:25 INFO - Running setup.py (path:/tmp/pip-BANs5M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:01:25 INFO - Running setup.py (path:/tmp/pip-lBr_MJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:01:25 INFO - Running setup.py (path:/tmp/pip-q0AYyh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:01:25 INFO - Running setup.py (path:/tmp/pip-JnXVTL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:01:25 INFO - Running setup.py (path:/tmp/pip-Owx2kh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:01:25 INFO - Running setup.py (path:/tmp/pip-HgPtUJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:01:25 INFO - Running setup.py (path:/tmp/pip-gK2CCP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:01:25 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)) 22:01:25 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)) 22:01:25 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)) 22:01:25 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)) 22:01:25 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)) 22:01:25 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)) 22:01:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:01:25 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 22:01:25 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 22:01:25 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 22:01:25 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 22:01:25 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 22:01:25 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 22:01:27 INFO - Downloading blessings-1.5.1.tar.gz 22:01:27 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 22:01:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:01:27 INFO - Installing collected packages: blessings 22:01:27 INFO - Running setup.py install for blessings 22:01:27 INFO - Successfully installed blessings 22:01:27 INFO - Cleaning up... 22:01:27 INFO - Return code: 0 22:01:27 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:01:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:01:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:01:27 INFO - Reading from file tmpfile_stdout 22:01:27 INFO - Current package versions: 22:01:27 INFO - argparse == 1.2.1 22:01:27 INFO - blessings == 1.5.1 22:01:27 INFO - blobuploader == 1.2.4 22:01:27 INFO - docopt == 0.6.1 22:01:27 INFO - manifestparser == 1.1 22:01:27 INFO - mozInstall == 1.12 22:01:27 INFO - mozcrash == 0.16 22:01:27 INFO - mozdebug == 0.1 22:01:27 INFO - mozdevice == 0.47 22:01:27 INFO - mozfile == 1.2 22:01:27 INFO - mozhttpd == 0.7 22:01:27 INFO - mozinfo == 0.9 22:01:27 INFO - mozleak == 0.1 22:01:27 INFO - mozlog == 3.0 22:01:27 INFO - moznetwork == 0.27 22:01:27 INFO - mozprocess == 0.22 22:01:27 INFO - mozprofile == 0.27 22:01:27 INFO - mozrunner == 6.11 22:01:27 INFO - mozscreenshot == 0.1 22:01:27 INFO - mozsystemmonitor == 0.0 22:01:27 INFO - moztest == 0.7 22:01:27 INFO - mozversion == 1.4 22:01:27 INFO - psutil == 3.1.1 22:01:27 INFO - requests == 1.2.3 22:01:27 INFO - wsgiref == 0.1.2 22:01:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:01:27 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')]} 22:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:27 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')]} 22:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:27 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 0x7f2dfd342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060a90>, '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 0x20b2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b32e0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', '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 22:01:27 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 22:01:27 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 22:01:27 INFO - Using env: {'DISPLAY': ':0', 22:01:27 INFO - 'HOME': '/home/cltbld', 22:01:27 INFO - 'LANG': 'en_US.UTF-8', 22:01:27 INFO - 'LANGUAGE': 'en_US:en', 22:01:27 INFO - 'LOGNAME': 'cltbld', 22:01:27 INFO - 'MAIL': '/var/mail/cltbld', 22:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:27 INFO - 'MOZ_NO_REMOTE': '1', 22:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:27 INFO - 'NO_EM_RESTART': '1', 22:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:27 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:27 INFO - 'SHELL': '/bin/bash', 22:01:27 INFO - 'SHLVL': '1', 22:01:27 INFO - 'TERM': 'linux', 22:01:27 INFO - 'TMOUT': '86400', 22:01:27 INFO - 'USER': 'cltbld', 22:01:27 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', 22:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:27 INFO - '_': '/tools/buildbot/bin/python'} 22:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 INFO - Cleaning up... 22:01:28 INFO - Return code: 0 22:01:28 INFO - Running post-action listener: _resource_record_post_action 22:01:28 INFO - Running post-action listener: _start_resource_monitoring 22:01:28 INFO - Starting resource monitoring. 22:01:28 INFO - ##### 22:01:28 INFO - ##### Running install step. 22:01:28 INFO - ##### 22:01:28 INFO - Running pre-action listener: _resource_record_pre_action 22:01:28 INFO - Running main action method: install 22:01:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:01:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:01:28 INFO - Reading from file tmpfile_stdout 22:01:28 INFO - Detecting whether we're running mozinstall >=1.0... 22:01:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:01:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:01:28 INFO - Reading from file tmpfile_stdout 22:01:28 INFO - Output received: 22:01:28 INFO - Usage: mozinstall [options] installer 22:01:28 INFO - Options: 22:01:28 INFO - -h, --help show this help message and exit 22:01:28 INFO - -d DEST, --destination=DEST 22:01:28 INFO - Directory to install application into. [default: 22:01:28 INFO - "/builds/slave/test-pgo"] 22:01:28 INFO - --app=APP Application being installed. [default: firefox] 22:01:28 INFO - mkdir: /builds/slave/test-pgo/build/application 22:01:28 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'] 22:01:28 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 22:01:42 INFO - Reading from file tmpfile_stdout 22:01:42 INFO - Output received: 22:01:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:01:42 INFO - Running post-action listener: _resource_record_post_action 22:01:42 INFO - ##### 22:01:42 INFO - ##### Running run-tests step. 22:01:42 INFO - ##### 22:01:42 INFO - Running pre-action listener: _resource_record_pre_action 22:01:42 INFO - Running main action method: run_tests 22:01:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:01:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:01:42 INFO - Python 2.7.3 22:01:42 INFO - Return code: 0 22:01:42 INFO - grabbing minidump binary from tooltool 22:01:42 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')]} 22:01:42 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 0x2060a90>, '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 0x20b2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b32e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:01:42 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 22:01:42 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 22:01:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:01:42 INFO - Return code: 0 22:01:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:01:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:01:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:01:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:01:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:01:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 22:01:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 22:01:42 INFO - Using env: {'DISPLAY': ':0', 22:01:42 INFO - 'HOME': '/home/cltbld', 22:01:42 INFO - 'LANG': 'en_US.UTF-8', 22:01:42 INFO - 'LANGUAGE': 'en_US:en', 22:01:42 INFO - 'LOGNAME': 'cltbld', 22:01:42 INFO - 'MAIL': '/var/mail/cltbld', 22:01:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:01:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:42 INFO - 'MOZ_NO_REMOTE': '1', 22:01:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:42 INFO - 'NO_EM_RESTART': '1', 22:01:42 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:42 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:42 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:01:42 INFO - 'SHELL': '/bin/bash', 22:01:42 INFO - 'SHLVL': '1', 22:01:42 INFO - 'TERM': 'linux', 22:01:42 INFO - 'TMOUT': '86400', 22:01:42 INFO - 'USER': 'cltbld', 22:01:42 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163', 22:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:42 INFO - '_': '/tools/buildbot/bin/python'} 22:01:42 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 22:01:43 INFO - mozversion INFO | application_buildid: 20151116203312 22:01:43 INFO - mozversion INFO | application_changeset: ffdc7f22130425020f5d648ef99c10b947541659 22:01:43 INFO - mozversion INFO | application_display_name: Nightly 22:01:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:01:43 INFO - mozversion INFO | application_name: Firefox 22:01:43 INFO - mozversion INFO | application_remotingname: firefox 22:01:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:01:43 INFO - mozversion INFO | application_vendor: Mozilla 22:01:43 INFO - mozversion INFO | application_version: 45.0a1 22:01:43 INFO - mozversion INFO | platform_buildid: 20151116203312 22:01:43 INFO - mozversion INFO | platform_changeset: ffdc7f22130425020f5d648ef99c10b947541659 22:01:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:01:43 INFO - mozversion INFO | platform_version: 45.0a1 22:01:43 INFO - 2015-11-16 22:01:43,046 DEBUG : using testdate: 1447740103 22:01:43 INFO - 2015-11-16 22:01:43,046 DEBUG : actual date: 1447740103 22:01:43 INFO - 2015-11-16 22:01:43,057 INFO : starting webserver on 'localhost:38611' 22:01:43 INFO - 2015-11-16 22:01:43,058 INFO : Starting test suite talos-linux64-ix-041 22:01:43 INFO - 2015-11-16 22:01:43,058 INFO : Starting test dromaeo_css 22:01:43 INFO - 2015-11-16 22:01:43,058 DEBUG : operating with platform_type : linux_ 22:01:43 INFO - 2015-11-16 22:01:43,059 INFO : Initialising browser for dromaeo_css test... 22:01:43 INFO - 2015-11-16 22:01:43,071 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH4O86p/profile http://localhost:38611/getInfo.html 22:01:47 INFO - 2015-11-16 22:01:47,109 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:01:47 INFO - 2015-11-16 22:01:47,109 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:01:47 INFO - 2015-11-16 22:01:47,109 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:01:47 INFO - 2015-11-16 22:01:47,109 DEBUG : BROWSER_OUTPUT: __metrics 22:01:47 INFO - 2015-11-16 22:01:47,171 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:01:48 INFO - 2015-11-16 22:01:48,742 INFO : Browser initialized. 22:01:48 INFO - 2015-11-16 22:01:48,742 INFO : Running cycle 1/1 for dromaeo_css test... 22:01:48 INFO - 2015-11-16 22:01:48,742 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH4O86p/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:02:00 INFO - 2015-11-16 22:02:00,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 141950976 22:02:00 INFO - 2015-11-16 22:02:00,525 DEBUG : BROWSER_OUTPUT: 22:02:52 INFO - 2015-11-16 22:02:52,066 DEBUG : BROWSER_OUTPUT: 1447740172062 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] 22:05:00 INFO - 2015-11-16 22:05:00,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38611/tests/dromaeo/cssquery-ext.html) 22:05:01 INFO - 2015-11-16 22:05:01,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 255827968 22:05:01 INFO - 2015-11-16 22:05:01,698 DEBUG : BROWSER_OUTPUT: 22:08:04 INFO - 2015-11-16 22:08:04,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/dromaeo/cssquery-ext.html (next: http://localhost:38611/tests/dromaeo/cssquery-jquery.html) 22:08:04 INFO - 2015-11-16 22:08:04,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 217796608 22:08:04 INFO - 2015-11-16 22:08:04,675 DEBUG : BROWSER_OUTPUT: 22:11:06 INFO - 2015-11-16 22:11:06,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38611/tests/dromaeo/cssquery-mootools.html) 22:11:07 INFO - 2015-11-16 22:11:07,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 208568320 22:11:07 INFO - 2015-11-16 22:11:07,238 DEBUG : BROWSER_OUTPUT: 22:14:09 INFO - 2015-11-16 22:14:09,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38611/tests/dromaeo/cssquery-prototype.html) 22:14:09 INFO - 2015-11-16 22:14:09,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 201203712 22:14:09 INFO - 2015-11-16 22:14:09,626 DEBUG : BROWSER_OUTPUT: 22:17:12 INFO - 2015-11-16 22:17:12,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38611/tests/dromaeo/cssquery-yui.html) 22:17:12 INFO - 2015-11-16 22:17:12,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 202481664 22:17:12 INFO - 2015-11-16 22:17:12,662 DEBUG : BROWSER_OUTPUT: 22:20:15 INFO - 2015-11-16 22:20:15,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/dromaeo/cssquery-yui.html (next: http://localhost:38611/tests/dromaeo/cssquery-dojo.html) 22:20:15 INFO - 2015-11-16 22:20:15,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 287449088 22:20:15 INFO - 2015-11-16 22:20:15,473 DEBUG : BROWSER_OUTPUT: 22:20:15 INFO - 2015-11-16 22:20:15,474 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:20:15 INFO - 2015-11-16 22:20:15,474 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:20:15 INFO - 2015-11-16 22:20:15,475 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:20:15 INFO - 2015-11-16 22:20:15,475 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:20:15 INFO - 2015-11-16 22:20:15,476 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3161.7944833585816;3197.632272288685;3240.5625240592512;3243.3351163011585;3250.561174241478;5239.842804715855;5299.655522391046;5334;5336.17289320155;5352.571794256465;5293.285406470135;5346.839594812152;5358.758855851486;5422.810201642943;5451.400345961951;4839.128956787768;4840.685355451902;4874.561289483946;4911.140550403683;5007.724575148365;5020.924686129711;5030.57240134589;5036.471170527097;5085.618578606601;5085.821996230133;4802.375691160144;4893.559579637814;4904.828331008398;5027.09512287788;5054.1660625996665;4935.851924442272;4937.950620493785;4947.9505204947845;4959.231319145538;4989.476105008995;4926.729029903354;4938.4320803107385;4943.431505376891;4953.9504604953845;4954.950450495485;5132.666376685504;5214.478552144793;5233.162693968947;5258.368995720538;5269.868253293698;5726.770929162829;5750.482456578886;5803.216565763652;5887.1463637772285;5927.881442371128;5808.8838223235725;5815.273090863642;5827.825165245049;5862.032764593837;5921.200637913913;5370.677759334452;5424.186372044225;5428.864278393033;5431.565474762009;5458.235846981386;5838.649681019152;5862.501687356537;5997.760089596367;6006;6023.759049637965;5758.280214973129;5766.798162064308;5773.5958482906635;5774.797882074107;5833.82498525045;5612.270404847343;5737.254156959569;5806.79676211339;5843.065109582446;5845.123231515222;5761.85595360111;5767.36558978512;5841.4450627190345;5844.8538786529825;5882.911756323659;5865.384134665798;5866.70666466675;5889.263842019747;5889.617174883619;5891.998360278762;4402.361657559636;4497.100579883971;4506.3916371290115;4552.1806074906835;4553.544645535486;4021.095253567924;4033.5966403360017;4036.253293140778;4053.43251944728;4058.776767277828;5470.753816078286;5473.562115030868;5515;5518.724063796794;5530.225768392428;5600.27196464457;5725.198472213893;5750.683712395775;5860.179574859523;5888.587798854039;5435.673859568438;5552.056150454432;5583.302087239095;5590.804321848797;5597.384287728347;5143.97428012865;5169.715665638426;5178.585713143015;5188.792448302026;5216.347956505437;5755.280589926259;5840.620359676607;5891.116332550066;5897.9115313271195;5973.940260597426;5749.540036796962;5753.654780713171;5754.136879468113;5769.769209231752;5875.6474611523445;5903.616264942765;5940.049592065248;5943.1679564861815;5950.315713692808;5966.880662386641;5569.860753481195;5592.972035139798;5685.061964775766;5689.231953686365;5731.369549349485;5890.322612899571;5941.673207973603;5942.168096466412;5949.524038076857;5956;5524.447555244444;5677.602567820378;5785.30576330843;5811.94188058114;5816.94183058164;5474.5894057945015;5555.749991250323;5556.805511807067;5564.777408903598;5571.582131340085;5519.034169020486;5549.278593782782;5551.944480555143;5554.166874968625;5555.666660000413;5532.751026203911;5619.522340601095;5663.490285874291;5672.688002159921;5676.716164191691;5391.029614669397;5472.671639701631;5475.890482190413;5485.122380419114;5520.1443776214755 22:20:15 INFO - 2015-11-16 22:20:15,480 DEBUG : BROWSER_OUTPUT: |1;ext.html;584.3251045042975;591.352469046394;593.9465448109669;594.9970250148747;619.5384438593246;31974.20064498389;32649.83675081624;32675.183120422;32694.182645433877;39743.80128099355;43228.567714322846;43723;43761.343579846325;43855.78072109643;43859.342109868376;8751.518666473341;8931.50876701781;8931.821363572724;8940.552972351388;8941.329400294971;7735.071791385014;7916.485428447132;8653.69712060075;10429.895701042968;10747.5163617637;10471.895281047167;10563.947180264087;10574.629887953923;10580.78838423231;10585.735356616107;7835.333996610295;10439.79120417595;10512.474376281156;10556.366618002945;10557.73605659857;7625.923740762577;10504;10801.40592267425;10808.351498910011;10810.783784324269;39854.402183967264;40175.99560010994;40351;40529.79735101335;40564.79717601393;3243.108145260049;3302.3725492156655;3395.8471868765964;3438.3639026780124;3647.1611529348397;29064.273393165127;29464.26339341512;29465.705342946512;29556.408871822445;30011.399772004657;3520.102373894666;3586.444101164324;3590.0845284452557;3605.963940360589;3651.233241019389;276624;277550;277552;277740;278355.6082219596;51251.7437412818;52301.7384913073;57218.42781572131;57645.711771440874;57761;59889.700551496964;60644.39355606476;61001;61001.69499152476;61195.694021529605;15436.073835569901;15634;15657.29542170605;15664.608384790472;15676.921615392079;11895.524179032915;11989.88010119905;12007.339596322112;12008.979236764799;12010.33943133136;17873.195706192993;18544.536386590175;18625.7206141908;18712.53218669517;18720.53198670017;7289.307515785992;7359.705611775469;7407.8888816667795;7469.887951680729;7502.587357695379;961.5576834656136;1000.6297669862198;1004.6182450668699;1014.5383850348074;1120.1207052463776;28745.42509149805;28797.712022879503;29054.418911621648;29090;33763.49354759681;1038.85456036155;1058.708855064848;1113.337564149346;1148.5944175519624;1149.5861489863642;15414.922925385301;15422;15491.380344786308;15650.139242341553;15986.60033499172;371391;374381;375107;375382;377715;55649.443505565236;55847.16229256564;55937;55970.44029559652;56158;1324.298121995344;1334.2261488336742;1354.4785257676062;1356.3828458051562;1361.6187467509114;30264.243393914447;30810.845945771023;30998;31283.53074703927;31662;46342;46839.765801170775;46897.53102469068;46946;46949;309994;311321;312996;313106;313443;27162.270183852444;32448.51327230046;32715.672843271263;32966.83516582402;33059;39325.80337098296;39524.40713389359;39668.40497392484;39808.60191398049;40632.39051414172;34362.65637343695;34560.82719586386;34842.82578587091;34871.82564087163;41961.160776784905;34738.82630586831;37265.81367093147;37834.243315134096;40689;40999.18001639891;37683.246335072596;37818.43272350972;41345.379819303336;42018.57981420147;42093;32259.838700806347;34327.31345373028;34600.653993459746;34719.305613887074;34847.47728784121;26302;26365.604515931893;26367.472650547264;26518;26870.596941045507 22:20:15 INFO - 2015-11-16 22:20:15,480 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.40259344849784;344.98574191875883;349.9492573576831;351.31318272776724;351.3640311037025;14402;14786.630334241623;16827;17581.472555823315;18974.335898243546;15586.84413155868;16371.508854734348;16587;16992.915035424838;17003.064831434298;5228.032813929426;5327.7336133193185;5333.066713325172;5335.7865685372735;5340.67955922644;3861.7876016819064;3975.2248311579256;5274.709890955995;5288.391834938992;5911.793087241947;6137.294211165706;6141.815745527641;6144.262688477366;6152.415520525543;6175.320714721377;6007.789727359544;6149.907751383733;6153.569250152491;6163.291221509539;6168.599041062362;5372.301600791911;5374.086405311106;5381.48875856793;5381.515663590257;5387.811426600089;20740.274090406914;20956.476088097766;21070.683939740917;21078.894605526875;21454.356369308945;2161.3515945216373;2162.4377661808044;2185.661222510513;2279.190887235024;2280.350100221429;9630.951845240728;9949.403035817802;9950.850737238947;13142.474301027947;13704.588862334145;1681.151018735543;1695.389659722499;1701.8298170183007;1722.0614764953132;1742.0766993493469;58150.41849581535;61170;62168.37831621671;62350.68824655893;62396.37603623951;6742.426893713991;6767.154105736783;7059.152901651834;7149;7197.388222001084;8601.5699215039;8608.870866937;8612.48325100496;8616.267617252604;8618.956905215433;5697.658140511499;5781.942180578225;5871.236739223874;5898.793542226002;5914.822555323347;6132.478739307209;6151.84620384494;6186.226721659793;6189.81430557084;6192.8761424771255;3280.8851690190727;3282.163048422637;3304.5373647689344;3313.188268874141;3336.115929278743;1066.3921564708041;1123.5618108937522;1137.5734099712608;1154.9364784936909;1183.46743965216;467.18942634529066;472.17605278788733;474.95013023632714;488.9927047842964;501.25063030768507;12138;12260.693482663004;12588.496460141492;12612.306323152132;12646.620601381974;482.11050611621505;513.5506431872112;525.306595294208;535.1491129104742;546.9771527244079;6456.7740129095255;6582.473402127818;6752.797416077526;6774.051632771416;6793;417540;423242;423379;423521;509283;67219.66390168018;69520.6523967377;70986.29013709797;71001.2899871005;72143.63928180326;557.2338035201598;570.3839852958795;571.8856228754266;572.0332637842033;572.1046562130252;11172.329660220088;11377.08983281319;11614.825777613512;11643.12676549279;11721.179517433698;36373.636263637025;36493.45259821052;36662.26675466529;37569.2486150281;37680.24639507249;50467.747661261456;51173.488265116874;51272;51462.48537514577;51677.48322516877;6506.837329066811;6623.337666233531;6636.734530618721;6640.634765087966;6641.169853768279;12126.27242365461;12614.306213157997;12753.171043882117;12763.680907977376;12765.170263932814;10334.638287659896;10470.319429237075;10777.137828973506;11017.889821102008;11121.443927803739;10532.788729295922;10684.519196636014;10872.836907446554;10932.945335273273;11090.5563777448;10883.238173328107;11136.554537818396;11227.38249396291;11737.589184378507;11758.294502329887;6859.382655561023;7009.12385951756;7012.929870701228;7014.929850701427;7019.684114214975;10380.948095259475;10901.400422976812;11021.228514003942;11028.944855275673;11052.392118433563 22:20:15 INFO - 2015-11-16 22:20:15,481 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1330.348129416585;1717.8883372580785;1739.530326811761;1770.814064523225;1771.3180425536166;6743.999999999994;6937.757178498754;7168.24733402993;7169.354758071772;7175.42596592272;7051.1186101737285;7105.502614816952;7151.427885769139;7155.034070400495;7166.104236970379;1974.7334109895123;2022.9089690963867;2023.6155130525226;2216.2353987874158;2250.437390652337;2001.179516398277;2010.8089731475486;2222.6332655111887;2233.4416395901026;2271.965920511194;2218.101668824129;2232.520008198237;2273.022600281878;2285.2801367569245;2288.5766133265397;1927.8939658318786;1990.99004504978;2259.7062381890332;2284.4288927768057;2286.542691461714;1999.1303782854504;2295.908163673451;2340.648902664614;2342.0865862313713;2342.1334106380577;7089.361957423805;7164.892526612105;7166.355028047448;7171.354578087997;7171.89242161368;4527.4340707411575;4536.659750518725;4564.269716845322;4582.221022426195;4594.724316541018;3165.6042994625673;3193.5688682028094;3200.2799370141765;3233.1270556949494;3241.2383089973837;1014.7818219082859;1035.7307100154014;1047.0210353319594;1070.49151652965;1093.8906109389077;10316.587336506605;10468.42423666698;10471.790564188674;10476.057154856024;10482.528286227061;4251.086016506466;4320.049589090395;4358.411614432074;4371.737695738266;4378.343248512749;9126.954365228265;9138.68014619485;9149.313801464918;9155.54222288883;9156.6795162169;4647.442306923123;4688.4373875134515;4688.929666055012;4693.06138772247;4708.223143181337;4210.936835947463;4214.768187749642;4220.620144187038;4221.6200541951375;4229.365595160689;3613.850263374733;3639.9808053744996;3672.761270517408;3678.779273243614;3679.6136405677553;1142.1205671632963;1163.761428907072;1165.4405885175163;1166.807476766341;1167.3521195736448;1056.8731752189633;1326.681596416853;1347.7169794343297;1353.0596235616151;1353.1069494134022;7134.03690501786;7163.283671632795;7167.641617919083;7174.820629484305;7183.209846916835;1162.9242950270966;1181.5864447443325;1193.9820902686467;1217.6407959651924;1232.8240655243503;5160.40655324635;5281.762320695578;5287.048331300402;5550.389457159709;5591.916121258185;7530.623468826537;8268.421210515206;8361.790955226046;8368.58157092143;8391.244787969112;8101.311388532041;8198.590070496452;8950.14973577509;8998;9183.265338772882;7094.964525177445;7182.892256616155;7255.310745479171;7256.7822965311125;7260;7159.176694680178;7219.422446204396;7228.421726261991;7228.530145540523;7254.202037775735;8069.193080691884;8112;8185.222403871623;8240.670373185005;8257.00915890097;8296;8430.325573953945;8453.535055572003;8540.14598540141;8540.615672294885;6688.83277918056;6758.966205168943;6760.560563563549;6766.05275261454;6770.492213084137;7493.775186744407;7537.773866784005;7589.6584653691825;7594.772156835304;7602;7086.149662040588;7119.537230080028;7191.2449192834;7209.423246140401;7250.347468727839;6871.278515755774;6971.093757811452;6980;7026.473014523829;7096.680649370894;7118.466115041496;7149.785506434815;7154.105736782903;7154.678039488132;7159.498835081495;6368.522360822864;6460.580062295936;6561.835954101186;6585.835354115994;6592;6614.735410583523;6633.1045308882685;6637;6643.368879956396;6646.567973081927 22:20:15 INFO - 2015-11-16 22:20:15,483 DEBUG : BROWSER_OUTPUT: |4;prototype.html;335.26075004614825;336.85346874109763;337.93072420153874;345.07691924103017;349.81285012518293;5824.039033559468;5926.911096333559;6000.069989151678;6003.639781613096;6021.0667346561295;5781.479666829984;5913.85215369616;5917.053271476565;5936.347001829795;5940.88118237635;4606.930896036553;4607.193741095311;4612.4465064192345;4616.930746038812;4621.884452888671;4400.053988392495;4469.642428605704;4529.660275479336;4608.746518941457;4631.258998560231;4550.044490656966;4572.15415148197;4574.954250457503;4583.747893865852;4593.4947155813;4577.359169716243;4581.65637577183;4582.679212455129;4584.770761461914;4592.714040068753;4041.9191616167514;4045.7572545647354;4052.1693052924375;4054.108096218827;4054.16889537647;5573.637713548647;5619.971900140473;5657.519110875581;5668.886622267572;5670.518005969498;5339.3058902342445;5358.2498450217;5358.812441564565;5359.490848369399;5364.302640656729;6051.062085376773;6291.370862913718;6295.590786598902;6298.401651843067;6302.842428939267;4332.696711230215;4360.454943132108;4401.339799030139;4422;4436.622887054604;6431.163948686688;6453.064305675698;6453.386928241856;6455.257645370749;6458.61248325102;4515.81936722534;4536.410266665378;4546.909061818745;4548.727076375362;4549.02196027849;4454.621357184611;4582.862514124582;4598.632109431237;4599.080183963154;4601.44782626087;5233.973830130901;5242.501962313574;5243.318368612056;5246.396664383568;5249.816256431007;6241.313455519889;6252.030935205051;6253;6253.5622506424115;6262.780802671976;1627.26772952172;1627.7395616701272;1633.2568681250002;1648.7279598866292;1649.5463747469303;1122.7417693930443;1123.2586492914636;1134.2173900008968;1135.2280449294394;1157.8205378166397;5986.3714309997695;5995.100734889801;6002.699865006733;6004.519638428916;6010.338862725097;6553.475721942234;6559.245686746085;6563.540552161303;6566.737330506726;6566.967165164144;5956.880862382728;6062.818115456544;6095.390460953958;6095.451409373089;6098.048624440136;3529.770564913272;3553.9644603553634;3555.839987200582;3566.375884220251;3570.91072723184;6729.831754206184;6763.695633696496;6766.391024807791;6773.45812335012;6784.355486228899;6606.636634985026;6701.229358623723;6718.361755633207;6718.697658605374;6725.730970761115;6776.322367763283;6778.661066946633;6791.864162716817;6792;6797.694103765342;6407.775727849503;6549.574277671936;6551.246606640298;6564.343565643398;6572.244191917991;6379.298277189599;6445.16212892321;6536.084948107174;6568.540202185993;6587.209534855848;6751.797446076625;6757;6813.318668133147;6867.038614593861;6867.141607299088;4517.796699148612;4591.632669386374;4619.792109355019;4622.121796858586;4648.814047438064;6547.345265473605;6552.27924928248;6555.475561955128;6556.442702370352;6565.96717016431;6407.743690252338;6408.455281301141;6409.8718025640155;6412.1023056771155;6414.518911081781;6247.219097612799;6384.297727249906;6392.904106438315;6395.232572091379;6426.228852537725;6342.080398342307;6349.206349206349;6357.427831495188;6363.236411630634;6368.52236082305;6497.772577959938;6515.0553169791065;6519.445847103049;6522.5760325578685;6526.184226971629;6198.907016394667;6333.65164915934;6341.302456729663;6349.365063493614;6357.268914074755 22:20:15 INFO - 2015-11-16 22:20:15,483 DEBUG : BROWSER_OUTPUT: |5;yui.html;775.7440044785221;857.2242120880601;862.0689655172413;866.6490071521032;887.7603047177266;12423.503059877605;12716.809247861289;12751.808722869153;12770.297633630158;12951.870481295207;11016.283941543794;13190.34048297586;13291.93354033231;13295.601131966032;13296.601101966933;671.0605152786114;815.902091748988;817.0562999735315;817.889584906039;818.1491249100928;809.3323008517967;810.623060276971;813.3168138763438;813.6948644258404;814.2020819596798;709.978700638979;713.2012146396017;852.5311078906608;853.0914575976597;853.3557164340914;840.9495430274203;841.0748177005306;842.5281842168405;844.7254642241265;851.7402192331336;623.1276213301369;625.7528276330869;628.0046126888886;630.8927482328015;632.993670063298;12400.62798116058;12674.80987785184;12685.302308373035;12705.682357941034;12708.745825083539;11922.701932451671;12576.685582860502;13393.933030334883;13407;13512.05415620907;10070.194384449227;10232.795344093076;10303.845442318372;10401.323913945569;10483.895161048367;3644.4168932970597;3647.726420518445;3659.9817000914827;3717.925641487155;3793.089658481972;47970;48097.27854082191;48205.75897120492;48597.51402485965;49001.26498102567;8192.057913340042;8272.917270827335;10155.187584993182;10213.08082272599;10383.532741026673;12717.728227177207;12777.041721870897;12793.808092878615;12809.935950320189;12848.871511284955;6676.46588272937;6865.725370985205;7109.502334836615;7131.857362852714;7172.354488096096;4287.506936702257;4329.826806927687;4364.825406983685;4387.100644367897;4524.47968483622;2742.6297449844415;2750.7386798254133;2754.9724502755116;2761.2268564801484;2764.4609301186074;427.9315309550457;429.2616699277238;429.9312110062375;439.49458123157984;440.9052053808447;654.4077609763171;662.3872917551342;667.1760375935716;671.5903298987614;676.9570779346867;8090.231428014447;8104.756857294173;8256.20288552741;8854.422011261217;8895.688650897187;550.7934524553292;592.0763608770332;647.1651569475324;697.2539382860392;718.3104219948907;4008.198360327946;4133.21468920904;4211.494620645542;4223.092035212444;4253.808578613908;56951.43048569544;57505.71247143738;57613;58120;58228;51515.87872970154;51819.481805181465;52184.73907630437;52313.215301770506;52701.7364913173;45763.54236457659;46678;46939;48270.5172948273;48907.755461223176;8463.830723385621;8526.68386813968;8608.354373422144;8695.087015863242;8795.612112315552;35288.29423411569;35403;35528.38131042948;35873.46189807103;36845.63154368529;46074.769626151654;46121.53878461172;46558.30162547497;46958.530414695415;46997;7948.721794737156;8170.091964405462;8252.33981281508;8261.17388261193;8302.87545686803;12040.578579749666;12236.629652009278;12241;12515.812262815884;12669.303188324731;11572.132090093444;11633.59282425111;11882.762344752884;12238.938805305916;12286.631401057624;10633.468326583485;10715.196360273167;10726.73183170427;11748.530058797553;12175;11352.489137988645;11442.771144577227;11644.2431241969;11758.529658813552;11946.880531194576;9784.920119560637;9814.509274536387;9969.252306077218;10107.292489525662;10147.391156530632;8986.640534378552;9927.007299270015;10102.242331824995;10119.797604048024;10136.695899123039 22:20:15 INFO - 2015-11-16 22:20:15,483 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:20:15 INFO - 2015-11-16 22:20:15,483 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:20:15 INFO - 2015-11-16 22:20:15,483 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,958 22:20:15 INFO - 2015-11-16 22:20:15,483 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:20:15 INFO - 2015-11-16 22:20:15,484 DEBUG : BROWSER_OUTPUT: __startTimestamp1447741215473__endTimestamp 22:20:15 INFO - 2015-11-16 22:20:15,485 DEBUG : BROWSER_OUTPUT: 22:20:15 INFO - 2015-11-16 22:20:15,485 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:20:15 INFO - 2015-11-16 22:20:15,485 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:20:15 INFO - 2015-11-16 22:20:15,485 DEBUG : BROWSER_OUTPUT: 22:20:15 INFO - 2015-11-16 22:20:15,485 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5388.88 Median:5552.06 stddev:587.94 (10.6%) stddev-sans-first:563.19 22:20:15 INFO - 2015-11-16 22:20:15,485 DEBUG : BROWSER_OUTPUT: Values: 3161.8 3197.6 3240.6 3243.3 3250.6 5239.8 5299.7 5334.0 5336.2 5352.6 5293.3 5346.8 5358.8 5422.8 5451.4 4839.1 4840.7 4874.6 4911.1 5007.7 5020.9 5030.6 5036.5 5085.6 5085.8 4802.4 4893.6 4904.8 5027.1 5054.2 4935.9 4938.0 4948.0 4959.2 4989.5 4926.7 4938.4 4943.4 4954.0 4955.0 5132.7 5214.5 5233.2 5258.4 5269.9 5726.8 5750.5 5803.2 5887.1 5927.9 5808.9 5815.3 5827.8 5862.0 5921.2 5370.7 5424.2 5428.9 5431.6 5458.2 5838.6 5862.5 5997.8 6006.0 6023.8 5758.3 5766.8 5773.6 5774.8 5833.8 5612.3 5737.3 5806.8 5843.1 5845.1 5761.9 5767.4 5841.4 5844.9 5882.9 5865.4 5866.7 5889.3 5889.6 5892.0 4402.4 4497.1 4506.4 4552.2 4553.5 4021.1 4033.6 4036.3 4053.4 4058.8 5470.8 5473.6 5515.0 5518.7 5530.2 5600.3 5725.2 5750.7 5860.2 5888.6 5435.7 5552.1 5583.3 5590.8 5597.4 5144.0 5169.7 5178.6 5188.8 5216.3 5755.3 5840.6 5891.1 5897.9 5973.9 5749.5 5753.7 5754.1 5769.8 5875.6 5903.6 5940.0 5943.2 5950.3 5966.9 5569.9 5593.0 5685.1 5689.2 5731.4 5890.3 5941.7 5942.2 5949.5 5956.0 5524.4 5677.6 5785.3 5811.9 5816.9 5474.6 5555.7 5556.8 5564.8 5571.6 5519.0 5549.3 5551.9 5554.2 5555.7 5532.8 5619.5 5663.5 5672.7 5676.7 5391.0 5472.7 5475.9 5485.1 5520.1 22:20:15 INFO - 2015-11-16 22:20:15,485 DEBUG : BROWSER_OUTPUT: 22:20:15 INFO - 2015-11-16 22:20:15,485 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49085.11 Median:18579.67 stddev:84912.80 (457.0%) stddev-sans-first:85072.91 22:20:15 INFO - 2015-11-16 22:20:15,485 DEBUG : BROWSER_OUTPUT: Values: 584.3 591.4 593.9 595.0 619.5 31974.2 32649.8 32675.2 32694.2 39743.8 43228.6 43723.0 43761.3 43855.8 43859.3 8751.5 8931.5 8931.8 8940.6 8941.3 7735.1 7916.5 8653.7 10429.9 10747.5 10471.9 10563.9 10574.6 10580.8 10585.7 7835.3 10439.8 10512.5 10556.4 10557.7 7625.9 10504.0 10801.4 10808.4 10810.8 39854.4 40176.0 40351.0 40529.8 40564.8 3243.1 3302.4 3395.8 3438.4 3647.2 29064.3 29464.3 29465.7 29556.4 30011.4 3520.1 3586.4 3590.1 3606.0 3651.2 276624.0 277550.0 277552.0 277740.0 278355.6 51251.7 52301.7 57218.4 57645.7 57761.0 59889.7 60644.4 61001.0 61001.7 61195.7 15436.1 15634.0 15657.3 15664.6 15676.9 11895.5 11989.9 12007.3 12009.0 12010.3 17873.2 18544.5 18625.7 18712.5 18720.5 7289.3 7359.7 7407.9 7469.9 7502.6 961.6 1000.6 1004.6 1014.5 1120.1 28745.4 28797.7 29054.4 29090.0 33763.5 1038.9 1058.7 1113.3 1148.6 1149.6 15414.9 15422.0 15491.4 15650.1 15986.6 371391.0 374381.0 375107.0 375382.0 377715.0 55649.4 55847.2 55937.0 55970.4 56158.0 1324.3 1334.2 1354.5 1356.4 1361.6 30264.2 30810.8 30998.0 31283.5 31662.0 46342.0 46839.8 46897.5 46946.0 46949.0 309994.0 311321.0 312996.0 313106.0 313443.0 27162.3 32448.5 32715.7 32966.8 33059.0 39325.8 39524.4 39668.4 39808.6 40632.4 34362.7 34560.8 34842.8 34871.8 41961.2 34738.8 37265.8 37834.2 40689.0 40999.2 37683.2 37818.4 41345.4 42018.6 42093.0 32259.8 34327.3 34600.7 34719.3 34847.5 26302.0 26365.6 26367.5 26518.0 26870.6 22:20:15 INFO - 2015-11-16 22:20:15,486 DEBUG : BROWSER_OUTPUT: 22:20:15 INFO - 2015-11-16 22:20:15,486 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24740.69 Median:478.53 stddev:72367.24 (15122.8%) stddev-sans-first:72547.06 22:20:15 INFO - 2015-11-16 22:20:15,486 DEBUG : BROWSER_OUTPUT: Values: 340.4 345.0 349.9 351.3 351.4 14402.0 14786.6 16827.0 17581.5 18974.3 15586.8 16371.5 16587.0 16992.9 17003.1 5228.0 5327.7 5333.1 5335.8 5340.7 3861.8 3975.2 5274.7 5288.4 5911.8 6137.3 6141.8 6144.3 6152.4 6175.3 6007.8 6149.9 6153.6 6163.3 6168.6 5372.3 5374.1 5381.5 5381.5 5387.8 20740.3 20956.5 21070.7 21078.9 21454.4 2161.4 2162.4 2185.7 2279.2 2280.4 9631.0 9949.4 9950.9 13142.5 13704.6 1681.2 1695.4 1701.8 1722.1 1742.1 58150.4 61170.0 62168.4 62350.7 62396.4 6742.4 6767.2 7059.2 7149.0 7197.4 8601.6 8608.9 8612.5 8616.3 8619.0 5697.7 5781.9 5871.2 5898.8 5914.8 6132.5 6151.8 6186.2 6189.8 6192.9 3280.9 3282.2 3304.5 3313.2 3336.1 1066.4 1123.6 1137.6 1154.9 1183.5 467.2 472.2 475.0 489.0 501.3 12138.0 12260.7 12588.5 12612.3 12646.6 482.1 513.6 525.3 535.1 547.0 6456.8 6582.5 6752.8 6774.1 6793.0 417540.0 423242.0 423379.0 423521.0 509283.0 67219.7 69520.7 70986.3 71001.3 72143.6 557.2 570.4 571.9 572.0 572.1 11172.3 11377.1 11614.8 11643.1 11721.2 36373.6 36493.5 36662.3 37569.2 37680.2 50467.7 51173.5 51272.0 51462.5 51677.5 6506.8 6623.3 6636.7 6640.6 6641.2 12126.3 12614.3 12753.2 12763.7 12765.2 10334.6 10470.3 10777.1 11017.9 11121.4 10532.8 10684.5 10872.8 10932.9 11090.6 10883.2 11136.6 11227.4 11737.6 11758.3 6859.4 7009.1 7012.9 7014.9 7019.7 10380.9 10901.4 11021.2 11028.9 11052.4 22:20:15 INFO - 2015-11-16 22:20:15,486 DEBUG : BROWSER_OUTPUT: 22:20:15 INFO - 2015-11-16 22:20:15,488 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5335.73 Median:6414.55 stddev:2697.64 (42.1%) stddev-sans-first:2688.40 22:20:15 INFO - 2015-11-16 22:20:15,488 DEBUG : BROWSER_OUTPUT: Values: 1330.3 1717.9 1739.5 1770.8 1771.3 6744.0 6937.8 7168.2 7169.4 7175.4 7051.1 7105.5 7151.4 7155.0 7166.1 1974.7 2022.9 2023.6 2216.2 2250.4 2001.2 2010.8 2222.6 2233.4 2272.0 2218.1 2232.5 2273.0 2285.3 2288.6 1927.9 1991.0 2259.7 2284.4 2286.5 1999.1 2295.9 2340.6 2342.1 2342.1 7089.4 7164.9 7166.4 7171.4 7171.9 4527.4 4536.7 4564.3 4582.2 4594.7 3165.6 3193.6 3200.3 3233.1 3241.2 1014.8 1035.7 1047.0 1070.5 1093.9 10316.6 10468.4 10471.8 10476.1 10482.5 4251.1 4320.0 4358.4 4371.7 4378.3 9127.0 9138.7 9149.3 9155.5 9156.7 4647.4 4688.4 4688.9 4693.1 4708.2 4210.9 4214.8 4220.6 4221.6 4229.4 3613.9 3640.0 3672.8 3678.8 3679.6 1142.1 1163.8 1165.4 1166.8 1167.4 1056.9 1326.7 1347.7 1353.1 1353.1 7134.0 7163.3 7167.6 7174.8 7183.2 1162.9 1181.6 1194.0 1217.6 1232.8 5160.4 5281.8 5287.0 5550.4 5591.9 7530.6 8268.4 8361.8 8368.6 8391.2 8101.3 8198.6 8950.1 8998.0 9183.3 7095.0 7182.9 7255.3 7256.8 7260.0 7159.2 7219.4 7228.4 7228.5 7254.2 8069.2 8112.0 8185.2 8240.7 8257.0 8296.0 8430.3 8453.5 8540.1 8540.6 6688.8 6759.0 6760.6 6766.1 6770.5 7493.8 7537.8 7589.7 7594.8 7602.0 7086.1 7119.5 7191.2 7209.4 7250.3 6871.3 6971.1 6980.0 7026.5 7096.7 7118.5 7149.8 7154.1 7154.7 7159.5 6368.5 6460.6 6561.8 6585.8 6592.0 6614.7 6633.1 6637.0 6643.4 6646.6 22:20:15 INFO - 2015-11-16 22:20:15,488 DEBUG : BROWSER_OUTPUT: 22:20:15 INFO - 2015-11-16 22:20:15,488 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5316.44 Median:6001.38 stddev:1588.83 (26.5%) stddev-sans-first:1548.68 22:20:15 INFO - 2015-11-16 22:20:15,488 DEBUG : BROWSER_OUTPUT: Values: 335.3 336.9 337.9 345.1 349.8 5824.0 5926.9 6000.1 6003.6 6021.1 5781.5 5913.9 5917.1 5936.3 5940.9 4606.9 4607.2 4612.4 4616.9 4621.9 4400.1 4469.6 4529.7 4608.7 4631.3 4550.0 4572.2 4575.0 4583.7 4593.5 4577.4 4581.7 4582.7 4584.8 4592.7 4041.9 4045.8 4052.2 4054.1 4054.2 5573.6 5620.0 5657.5 5668.9 5670.5 5339.3 5358.2 5358.8 5359.5 5364.3 6051.1 6291.4 6295.6 6298.4 6302.8 4332.7 4360.5 4401.3 4422.0 4436.6 6431.2 6453.1 6453.4 6455.3 6458.6 4515.8 4536.4 4546.9 4548.7 4549.0 4454.6 4582.9 4598.6 4599.1 4601.4 5234.0 5242.5 5243.3 5246.4 5249.8 6241.3 6252.0 6253.0 6253.6 6262.8 1627.3 1627.7 1633.3 1648.7 1649.5 1122.7 1123.3 1134.2 1135.2 1157.8 5986.4 5995.1 6002.7 6004.5 6010.3 6553.5 6559.2 6563.5 6566.7 6567.0 5956.9 6062.8 6095.4 6095.5 6098.0 3529.8 3554.0 3555.8 3566.4 3570.9 6729.8 6763.7 6766.4 6773.5 6784.4 6606.6 6701.2 6718.4 6718.7 6725.7 6776.3 6778.7 6791.9 6792.0 6797.7 6407.8 6549.6 6551.2 6564.3 6572.2 6379.3 6445.2 6536.1 6568.5 6587.2 6751.8 6757.0 6813.3 6867.0 6867.1 4517.8 4591.6 4619.8 4622.1 4648.8 6547.3 6552.3 6555.5 6556.4 6566.0 6407.7 6408.5 6409.9 6412.1 6414.5 6247.2 6384.3 6392.9 6395.2 6426.2 6342.1 6349.2 6357.4 6363.2 6368.5 6497.8 6515.1 6519.4 6522.6 6526.2 6198.9 6333.7 6341.3 6349.4 6357.3 22:20:15 INFO - 2015-11-16 22:20:15,488 DEBUG : BROWSER_OUTPUT: 22:20:15 INFO - 2015-11-16 22:20:15,488 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13668.79 Median:46339.92 stddev:16234.61 (35.0%) stddev-sans-first:16251.28 22:20:15 INFO - 2015-11-16 22:20:15,488 DEBUG : BROWSER_OUTPUT: Values: 775.7 857.2 862.1 866.6 887.8 12423.5 12716.8 12751.8 12770.3 12951.9 11016.3 13190.3 13291.9 13295.6 13296.6 671.1 815.9 817.1 817.9 818.1 809.3 810.6 813.3 813.7 814.2 710.0 713.2 852.5 853.1 853.4 840.9 841.1 842.5 844.7 851.7 623.1 625.8 628.0 630.9 633.0 12400.6 12674.8 12685.3 12705.7 12708.7 11922.7 12576.7 13393.9 13407.0 13512.1 10070.2 10232.8 10303.8 10401.3 10483.9 3644.4 3647.7 3660.0 3717.9 3793.1 47970.0 48097.3 48205.8 48597.5 49001.3 8192.1 8272.9 10155.2 10213.1 10383.5 12717.7 12777.0 12793.8 12809.9 12848.9 6676.5 6865.7 7109.5 7131.9 7172.4 4287.5 4329.8 4364.8 4387.1 4524.5 2742.6 2750.7 2755.0 2761.2 2764.5 427.9 429.3 429.9 439.5 440.9 654.4 662.4 667.2 671.6 677.0 8090.2 8104.8 8256.2 8854.4 8895.7 550.8 592.1 647.2 697.3 718.3 4008.2 4133.2 4211.5 4223.1 4253.8 56951.4 57505.7 57613.0 58120.0 58228.0 51515.9 51819.5 52184.7 52313.2 52701.7 45763.5 46678.0 46939.0 48270.5 48907.8 8463.8 8526.7 8608.4 8695.1 8795.6 35288.3 35403.0 35528.4 35873.5 36845.6 46074.8 46121.5 46558.3 46958.5 46997.0 7948.7 8170.1 8252.3 8261.2 8302.9 12040.6 12236.6 12241.0 12515.8 12669.3 11572.1 11633.6 11882.8 12238.9 12286.6 10633.5 10715.2 10726.7 11748.5 12175.0 11352.5 11442.8 11644.2 11758.5 11946.9 9784.9 9814.5 9969.3 10107.3 10147.4 8986.6 9927.0 10102.2 10119.8 10136.7 22:20:15 INFO - 2015-11-16 22:20:15,488 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:20:15 INFO - 2015-11-16 22:20:15,488 DEBUG : BROWSER_OUTPUT: 22:20:16 INFO - 2015-11-16 22:20:16,276 INFO : Browser exited with error code: 0 22:20:16 INFO - 2015-11-16 22:20:16,300 INFO : Completed test dromaeo_css (00:18:33) 22:20:16 INFO - 2015-11-16 22:20:16,300 INFO : Starting test kraken 22:20:16 INFO - 2015-11-16 22:20:16,300 DEBUG : operating with platform_type : linux_ 22:20:16 INFO - 2015-11-16 22:20:16,300 INFO : Initialising browser for kraken test... 22:20:16 INFO - 2015-11-16 22:20:16,306 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpisQdBo/profile http://localhost:38611/getInfo.html 22:20:20 INFO - 2015-11-16 22:20:20,395 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:20:20 INFO - 2015-11-16 22:20:20,396 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:20:20 INFO - 2015-11-16 22:20:20,396 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:20:20 INFO - 2015-11-16 22:20:20,396 DEBUG : BROWSER_OUTPUT: __metrics 22:20:20 INFO - 2015-11-16 22:20:20,500 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:20:21 INFO - 2015-11-16 22:20:21,877 INFO : Browser initialized. 22:20:21 INFO - 2015-11-16 22:20:21,877 INFO : Running cycle 1/1 for kraken test... 22:20:21 INFO - 2015-11-16 22:20:21,878 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpisQdBo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:20:33 INFO - 2015-11-16 22:20:33,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 141836288 22:20:33 INFO - 2015-11-16 22:20:33,601 DEBUG : BROWSER_OUTPUT: 22:20:36 INFO - 2015-11-16 22:20:36,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38611/tests/kraken/driver.html?testName=audio-beat-detection) 22:20:36 INFO - 2015-11-16 22:20:36,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 181248000 22:20:36 INFO - 2015-11-16 22:20:36,705 DEBUG : BROWSER_OUTPUT: 22:20:39 INFO - 2015-11-16 22:20:39,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38611/tests/kraken/driver.html?testName=audio-dft) 22:20:39 INFO - 2015-11-16 22:20:39,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 168534016 22:20:39 INFO - 2015-11-16 22:20:39,895 DEBUG : BROWSER_OUTPUT: 22:20:42 INFO - 2015-11-16 22:20:42,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38611/tests/kraken/driver.html?testName=audio-fft) 22:20:43 INFO - 2015-11-16 22:20:43,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 151179264 22:20:43 INFO - 2015-11-16 22:20:43,307 DEBUG : BROWSER_OUTPUT: 22:20:45 INFO - 2015-11-16 22:20:45,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38611/tests/kraken/driver.html?testName=audio-oscillator) 22:20:45 INFO - 2015-11-16 22:20:45,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 155344896 22:20:45 INFO - 2015-11-16 22:20:45,840 DEBUG : BROWSER_OUTPUT: 22:20:48 INFO - 2015-11-16 22:20:48,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38611/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:20:48 INFO - 2015-11-16 22:20:48,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 156405760 22:20:48 INFO - 2015-11-16 22:20:48,581 DEBUG : BROWSER_OUTPUT: 22:20:51 INFO - 2015-11-16 22:20:51,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38611/tests/kraken/driver.html?testName=imaging-darkroom) 22:20:52 INFO - 2015-11-16 22:20:52,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 156758016 22:20:52 INFO - 2015-11-16 22:20:52,040 DEBUG : BROWSER_OUTPUT: 22:20:55 INFO - 2015-11-16 22:20:55,403 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38611/tests/kraken/driver.html?testName=imaging-desaturate) 22:20:55 INFO - 2015-11-16 22:20:55,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 156995584 22:20:55 INFO - 2015-11-16 22:20:55,977 DEBUG : BROWSER_OUTPUT: 22:20:58 INFO - 2015-11-16 22:20:58,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38611/tests/kraken/driver.html?testName=json-parse-financial) 22:20:59 INFO - 2015-11-16 22:20:59,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 155594752 22:20:59 INFO - 2015-11-16 22:20:59,308 DEBUG : BROWSER_OUTPUT: 22:21:00 INFO - 2015-11-16 22:21:00,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38611/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:21:01 INFO - 2015-11-16 22:21:01,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 167399424 22:21:01 INFO - 2015-11-16 22:21:01,443 DEBUG : BROWSER_OUTPUT: 22:21:03 INFO - 2015-11-16 22:21:03,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38611/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:21:03 INFO - 2015-11-16 22:21:03,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 167854080 22:21:03 INFO - 2015-11-16 22:21:03,833 DEBUG : BROWSER_OUTPUT: 22:21:05 INFO - 2015-11-16 22:21:05,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38611/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:21:06 INFO - 2015-11-16 22:21:06,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 174075904 22:21:06 INFO - 2015-11-16 22:21:06,443 DEBUG : BROWSER_OUTPUT: 22:21:08 INFO - 2015-11-16 22:21:08,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:21:09 INFO - 2015-11-16 22:21:09,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 182247424 22:21:09 INFO - 2015-11-16 22:21:09,446 DEBUG : BROWSER_OUTPUT: 22:21:12 INFO - 2015-11-16 22:21:12,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:21:12 INFO - 2015-11-16 22:21:12,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 179322880 22:21:12 INFO - 2015-11-16 22:21:12,631 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38611/tests/kraken/driver.html?testName=ai-astar) 22:21:14 INFO - 2015-11-16 22:21:14,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 238219264 22:21:14 INFO - 2015-11-16 22:21:14,531 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,531 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:21:14 INFO - 2015-11-16 22:21:14,532 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:21:14 INFO - 2015-11-16 22:21:14,532 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:21:14 INFO - 2015-11-16 22:21:14,532 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:21:14 INFO - 2015-11-16 22:21:14,532 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;105;112;111;111;100;114;109;107 22:21:14 INFO - 2015-11-16 22:21:14,532 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;124;155;166;125;154;157;123;173;123 22:21:14 INFO - 2015-11-16 22:21:14,532 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;163;159;162;161;160;164;161;162 22:21:14 INFO - 2015-11-16 22:21:14,532 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;85;90;72;71;71;120;98;72 22:21:14 INFO - 2015-11-16 22:21:14,532 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;138;90;91;90;139;89;91;142 22:21:14 INFO - 2015-11-16 22:21:14,533 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;110;109;109;109;109 22:21:14 INFO - 2015-11-16 22:21:14,533 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;144;147;144;146;144;146;145;144;145;144 22:21:14 INFO - 2015-11-16 22:21:14,533 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;96;96;96;95;96;95 22:21:14 INFO - 2015-11-16 22:21:14,533 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;61;57;57;58;58;65;66;54;56 22:21:14 INFO - 2015-11-16 22:21:14,534 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;70;69;69;69;69;68 22:21:14 INFO - 2015-11-16 22:21:14,534 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;84;84;91;83;84;86;85;86 22:21:14 INFO - 2015-11-16 22:21:14,534 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;117;117;113;115;122;129;128;115;124 22:21:14 INFO - 2015-11-16 22:21:14,534 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;152;150;154;150;140;153;150;147;144 22:21:14 INFO - 2015-11-16 22:21:14,534 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;67;65;65;65;65;66;66;65 22:21:14 INFO - 2015-11-16 22:21:14,534 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:21:14 INFO - 2015-11-16 22:21:14,534 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:21:14 INFO - 2015-11-16 22:21:14,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,957 22:21:14 INFO - 2015-11-16 22:21:14,534 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:21:14 INFO - 2015-11-16 22:21:14,535 DEBUG : BROWSER_OUTPUT: __startTimestamp1447741274530__endTimestamp 22:21:14 INFO - 2015-11-16 22:21:14,535 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,536 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:21:14 INFO - 2015-11-16 22:21:14,536 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:21:14 INFO - 2015-11-16 22:21:14,536 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,536 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:4.12 (3.7%) stddev-sans-first:4.36 22:21:14 INFO - 2015-11-16 22:21:14,536 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 105.0 112.0 111.0 111.0 100.0 114.0 109.0 107.0 22:21:14 INFO - 2015-11-16 22:21:14,536 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,536 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.60 Median:155.50 stddev:19.65 (12.6%) stddev-sans-first:20.48 22:21:14 INFO - 2015-11-16 22:21:14,536 DEBUG : BROWSER_OUTPUT: Values: 156.0 124.0 155.0 166.0 125.0 154.0 157.0 123.0 173.0 123.0 22:21:14 INFO - 2015-11-16 22:21:14,537 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,537 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.49 (0.9%) stddev-sans-first:1.51 22:21:14 INFO - 2015-11-16 22:21:14,537 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 163.0 159.0 162.0 161.0 160.0 164.0 161.0 162.0 22:21:14 INFO - 2015-11-16 22:21:14,537 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,537 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.30 Median:72.00 stddev:16.38 (22.7%) stddev-sans-first:16.94 22:21:14 INFO - 2015-11-16 22:21:14,537 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 85.0 90.0 72.0 71.0 71.0 120.0 98.0 72.0 22:21:14 INFO - 2015-11-16 22:21:14,537 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,537 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:90.00 stddev:23.88 (26.5%) stddev-sans-first:24.70 22:21:14 INFO - 2015-11-16 22:21:14,537 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 138.0 90.0 91.0 90.0 139.0 89.0 91.0 142.0 22:21:14 INFO - 2015-11-16 22:21:14,537 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,538 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:21:14 INFO - 2015-11-16 22:21:14,538 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 22:21:14 INFO - 2015-11-16 22:21:14,538 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,538 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:1.10 (0.8%) stddev-sans-first:1.12 22:21:14 INFO - 2015-11-16 22:21:14,538 DEBUG : BROWSER_OUTPUT: Values: 144.0 147.0 144.0 146.0 144.0 146.0 145.0 144.0 145.0 144.0 22:21:14 INFO - 2015-11-16 22:21:14,538 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,538 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:21:14 INFO - 2015-11-16 22:21:14,538 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 22:21:14 INFO - 2015-11-16 22:21:14,538 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,538 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.30 Median:59.50 stddev:3.89 (6.5%) stddev-sans-first:4.08 22:21:14 INFO - 2015-11-16 22:21:14,538 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 57.0 57.0 58.0 58.0 65.0 66.0 54.0 56.0 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 69.0 68.0 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:2.36 (2.8%) stddev-sans-first:2.39 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 84.0 84.0 91.0 83.0 84.0 86.0 85.0 86.0 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:121.50 stddev:5.61 (4.6%) stddev-sans-first:5.94 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: Values: 121.0 117.0 117.0 113.0 115.0 122.0 129.0 128.0 115.0 124.0 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:151.00 stddev:4.45 (2.9%) stddev-sans-first:4.51 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: Values: 153.0 152.0 150.0 154.0 150.0 140.0 153.0 150.0 147.0 144.0 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 22:21:14 INFO - 2015-11-16 22:21:14,539 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 67.0 65.0 65.0 65.0 65.0 66.0 66.0 65.0 22:21:14 INFO - 2015-11-16 22:21:14,540 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:21:14 INFO - 2015-11-16 22:21:14,540 DEBUG : BROWSER_OUTPUT: 22:21:15 INFO - 2015-11-16 22:21:15,368 INFO : Browser exited with error code: 0 22:21:15 INFO - 2015-11-16 22:21:15,424 INFO : Completed test kraken (00:00:59) 22:21:15 INFO - 2015-11-16 22:21:15,425 INFO : Starting test v8_7 22:21:15 INFO - 2015-11-16 22:21:15,425 DEBUG : operating with platform_type : linux_ 22:21:15 INFO - 2015-11-16 22:21:15,425 INFO : Initialising browser for v8_7 test... 22:21:15 INFO - 2015-11-16 22:21:15,431 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmL1X53/profile http://localhost:38611/getInfo.html 22:21:19 INFO - 2015-11-16 22:21:19,534 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:21:19 INFO - 2015-11-16 22:21:19,534 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:21:19 INFO - 2015-11-16 22:21:19,534 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:21:19 INFO - 2015-11-16 22:21:19,534 DEBUG : BROWSER_OUTPUT: __metrics 22:21:19 INFO - 2015-11-16 22:21:19,711 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:21:21 INFO - 2015-11-16 22:21:21,051 INFO : Browser initialized. 22:21:21 INFO - 2015-11-16 22:21:21,051 INFO : Running cycle 1/1 for v8_7 test... 22:21:21 INFO - 2015-11-16 22:21:21,051 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmL1X53/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:21:32 INFO - 2015-11-16 22:21:32,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 141283328 22:21:32 INFO - 2015-11-16 22:21:32,881 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38611/tests/v8_7/run.html (next: http://localhost:38611/tests/v8_7/run.html) 22:21:54 INFO - 2015-11-16 22:21:54,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 590725120 22:21:54 INFO - 2015-11-16 22:21:54,579 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,579 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:21:54 INFO - 2015-11-16 22:21:54,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:21:54 INFO - 2015-11-16 22:21:54,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:21:54 INFO - 2015-11-16 22:21:54,579 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:21:54 INFO - 2015-11-16 22:21:54,580 DEBUG : BROWSER_OUTPUT: |0;Richards;162.86644951140065 22:21:54 INFO - 2015-11-16 22:21:54,580 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.39487565938205 22:21:54 INFO - 2015-11-16 22:21:54,580 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.29395218002816 22:21:54 INFO - 2015-11-16 22:21:54,580 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 22:21:54 INFO - 2015-11-16 22:21:54,580 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1939.922480620155 22:21:54 INFO - 2015-11-16 22:21:54,580 DEBUG : BROWSER_OUTPUT: |5;Earley;814.4833197721725 22:21:54 INFO - 2015-11-16 22:21:54,580 DEBUG : BROWSER_OUTPUT: |6;Boyer;12144.578313253012 22:21:54 INFO - 2015-11-16 22:21:54,580 DEBUG : BROWSER_OUTPUT: |7;RegExp;25425 22:21:54 INFO - 2015-11-16 22:21:54,580 DEBUG : BROWSER_OUTPUT: |8;Splay;619.2519926425506 22:21:54 INFO - 2015-11-16 22:21:54,580 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 22:21:54 INFO - 2015-11-16 22:21:54,580 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:21:54 INFO - 2015-11-16 22:21:54,580 DEBUG : BROWSER_OUTPUT: __startTimestamp1447741314577__endTimestamp 22:21:54 INFO - 2015-11-16 22:21:54,581 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,581 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:21:54 INFO - 2015-11-16 22:21:54,581 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:21:54 INFO - 2015-11-16 22:21:54,581 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,581 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.87 Median:162.87 stddev:0.00 (0.0%) 22:21:54 INFO - 2015-11-16 22:21:54,581 DEBUG : BROWSER_OUTPUT: Values: 162.9 22:21:54 INFO - 2015-11-16 22:21:54,581 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,581 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.39 Median:188.39 stddev:0.00 (0.0%) 22:21:54 INFO - 2015-11-16 22:21:54,581 DEBUG : BROWSER_OUTPUT: Values: 188.4 22:21:54 INFO - 2015-11-16 22:21:54,581 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,581 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.29 Median:281.29 stddev:0.00 (0.0%) 22:21:54 INFO - 2015-11-16 22:21:54,582 DEBUG : BROWSER_OUTPUT: Values: 281.3 22:21:54 INFO - 2015-11-16 22:21:54,582 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,582 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 22:21:54 INFO - 2015-11-16 22:21:54,582 DEBUG : BROWSER_OUTPUT: Values: 5035.2 22:21:54 INFO - 2015-11-16 22:21:54,582 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,582 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1939.92 Median:1939.92 stddev:0.00 (0.0%) 22:21:54 INFO - 2015-11-16 22:21:54,582 DEBUG : BROWSER_OUTPUT: Values: 1939.9 22:21:54 INFO - 2015-11-16 22:21:54,582 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,583 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:814.48 Median:814.48 stddev:0.00 (0.0%) 22:21:54 INFO - 2015-11-16 22:21:54,584 DEBUG : BROWSER_OUTPUT: Values: 814.5 22:21:54 INFO - 2015-11-16 22:21:54,584 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,584 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 22:21:54 INFO - 2015-11-16 22:21:54,584 DEBUG : BROWSER_OUTPUT: Values: 12144.6 22:21:54 INFO - 2015-11-16 22:21:54,584 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,584 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25425.00 Median:25425.00 stddev:0.00 (0.0%) 22:21:54 INFO - 2015-11-16 22:21:54,584 DEBUG : BROWSER_OUTPUT: Values: 25425.0 22:21:54 INFO - 2015-11-16 22:21:54,584 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,584 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.25 Median:619.25 stddev:0.00 (0.0%) 22:21:54 INFO - 2015-11-16 22:21:54,584 DEBUG : BROWSER_OUTPUT: Values: 619.3 22:21:54 INFO - 2015-11-16 22:21:54,585 DEBUG : BROWSER_OUTPUT: 22:21:54 INFO - 2015-11-16 22:21:54,585 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 22:21:54 INFO - 2015-11-16 22:21:54,585 DEBUG : BROWSER_OUTPUT: Values: 4830.9 22:21:54 INFO - 2015-11-16 22:21:54,585 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:21:54 INFO - 2015-11-16 22:21:54,585 DEBUG : BROWSER_OUTPUT: 22:21:55 INFO - 2015-11-16 22:21:55,460 INFO : Browser exited with error code: 0 22:21:55 INFO - 2015-11-16 22:21:55,477 INFO : Completed test v8_7 (00:00:40) 22:21:55 INFO - 2015-11-16 22:21:55,542 INFO : Completed test suite (00:20:12) 22:21:55 INFO - 2015-11-16 22:21:55,543 DEBUG : Working with test: dromaeo_css 22:21:55 INFO - 2015-11-16 22:21:55,543 DEBUG : Generating results file: dromaeo_css 22:21:55 INFO - 2015-11-16 22:21:55,544 DEBUG : Working with test: kraken 22:21:55 INFO - 2015-11-16 22:21:55,544 DEBUG : Generating results file: kraken 22:21:55 INFO - 2015-11-16 22:21:55,545 INFO : javascript benchmark 22:21:55 INFO - 2015-11-16 22:21:55,545 DEBUG : Working with test: v8_7 22:21:55 INFO - 2015-11-16 22:21:55,545 DEBUG : Generating results file: v8_7 22:21:55 INFO - 2015-11-16 22:21:55,545 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:55 INFO - 2015-11-16 22:21:55,606 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 22:21:55 INFO - 2015-11-16 22:21:55,607 DEBUG : process_Request line: dromaeo_css 6787.39 graph.html#tests=[[72,64,35]] 22:21:55 INFO - 2015-11-16 22:21:55,607 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:55 INFO - 2015-11-16 22:21:55,638 DEBUG : process_Request line: kraken 1501.30 graph.html#tests=[[232,64,35]] 22:21:55 INFO - 2015-11-16 22:21:55,639 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:55 INFO - 2015-11-16 22:21:55,744 DEBUG : process_Request line: v8_7 19912.52 graph.html#tests=[[230,64,35]] 22:21:55 INFO - 2015-11-16 22:21:55,745 INFO : javascript benchmark 22:21:55 INFO - 2015-11-16 22:21:55,749 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [340.40259344849784, 344.98574191875883, 349.9492573576831, 351.31318272776724, 351.3640311037025, 14402.0, 14786.630334241623, 16827.0, 17581.472555823315, 18974.335898243546, 15586.84413155868, 16371.508854734348, 16587.0, 16992.915035424838, 17003.064831434298, 5228.032813929426, 5327.7336133193185, 5333.066713325172, 5335.7865685372735, 5340.67955922644, 3861.7876016819064, 3975.2248311579256, 5274.709890955995, 5288.391834938992, 5911.793087241947, 6137.294211165706, 6141.815745527641, 6144.262688477366, 6152.415520525543, 6175.320714721377, 6007.789727359544, 6149.907751383733, 6153.569250152491, 6163.291221509539, 6168.599041062362, 5372.301600791911, 5374.086405311106, 5381.48875856793, 5381.515663590257, 5387.811426600089, 20740.274090406914, 20956.476088097766, 21070.683939740917, 21078.894605526875, 21454.356369308945, 2161.3515945216373, 2162.4377661808044, 2185.661222510513, 2279.190887235024, 2280.350100221429, 9630.951845240728, 9949.403035817802, 9950.850737238947, 13142.474301027947, 13704.588862334145, 1681.151018735543, 1695.389659722499, 1701.8298170183007, 1722.0614764953132, 1742.0766993493469, 58150.41849581535, 61170.0, 62168.37831621671, 62350.68824655893, 62396.37603623951, 6742.426893713991, 6767.154105736783, 7059.152901651834, 7149.0, 7197.388222001084, 8601.5699215039, 8608.870866937, 8612.48325100496, 8616.267617252604, 8618.956905215433, 5697.658140511499, 5781.942180578225, 5871.236739223874, 5898.793542226002, 5914.822555323347, 6132.478739307209, 6151.84620384494, 6186.226721659793, 6189.81430557084, 6192.8761424771255, 3280.8851690190727, 3282.163048422637, 3304.5373647689344, 3313.188268874141, 3336.115929278743, 1066.3921564708041, 1123.5618108937522, 1137.5734099712608, 1154.9364784936909, 1183.46743965216, 467.18942634529066, 472.17605278788733, 474.95013023632714, 488.9927047842964, 501.25063030768507, 12138.0, 12260.693482663004, 12588.496460141492, 12612.306323152132, 12646.620601381974, 482.11050611621505, 513.5506431872112, 525.306595294208, 535.1491129104742, 546.9771527244079, 6456.7740129095255, 6582.473402127818, 6752.797416077526, 6774.051632771416, 6793.0, 417540.0, 423242.0, 423379.0, 423521.0, 509283.0, 67219.66390168018, 69520.6523967377, 70986.29013709797, 71001.2899871005, 72143.63928180326, 557.2338035201598, 570.3839852958795, 571.8856228754266, 572.0332637842033, 572.1046562130252, 11172.329660220088, 11377.08983281319, 11614.825777613512, 11643.12676549279, 11721.179517433698, 36373.636263637025, 36493.45259821052, 36662.26675466529, 37569.2486150281, 37680.24639507249, 50467.747661261456, 51173.488265116874, 51272.0, 51462.48537514577, 51677.48322516877, 6506.837329066811, 6623.337666233531, 6636.734530618721, 6640.634765087966, 6641.169853768279, 12126.27242365461, 12614.306213157997, 12753.171043882117, 12763.680907977376, 12765.170263932814, 10334.638287659896, 10470.319429237075, 10777.137828973506, 11017.889821102008, 11121.443927803739, 10532.788729295922, 10684.519196636014, 10872.836907446554, 10932.945335273273, 11090.5563777448, 10883.238173328107, 11136.554537818396, 11227.38249396291, 11737.589184378507, 11758.294502329887, 6859.382655561023, 7009.12385951756, 7012.929870701228, 7014.929850701427, 7019.684114214975, 10380.948095259475, 10901.400422976812, 11021.228514003942, 11028.944855275673, 11052.392118433563], "dojo.html": [3161.7944833585816, 3197.632272288685, 3240.5625240592512, 3243.3351163011585, 3250.561174241478, 5239.842804715855, 5299.655522391046, 5334.0, 5336.17289320155, 5352.571794256465, 5293.285406470135, 5346.839594812152, 5358.758855851486, 5422.810201642943, 5451.400345961951, 4839.128956787768, 4840.685355451902, 4874.561289483946, 4911.140550403683, 5007.724575148365, 5020.924686129711, 5030.57240134589, 5036.471170527097, 5085.618578606601, 5085.821996230133, 4802.375691160144, 4893.559579637814, 4904.828331008398, 5027.09512287788, 5054.1660625996665, 4935.851924442272, 4937.950620493785, 4947.9505204947845, 4959.231319145538, 4989.476105008995, 4926.729029903354, 4938.4320803107385, 4943.431505376891, 4953.9504604953845, 4954.950450495485, 5132.666376685504, 5214.478552144793, 5233.162693968947, 5258.368995720538, 5269.868253293698, 5726.770929162829, 5750.482456578886, 5803.216565763652, 5887.1463637772285, 5927.881442371128, 5808.8838223235725, 5815.273090863642, 5827.825165245049, 5862.032764593837, 5921.200637913913, 5370.677759334452, 5424.186372044225, 5428.864278393033, 5431.565474762009, 5458.235846981386, 5838.649681019152, 5862.501687356537, 5997.760089596367, 6006.0, 6023.759049637965, 5758.280214973129, 5766.798162064308, 5773.5958482906635, 5774.797882074107, 5833.82498525045, 5612.270404847343, 5737.254156959569, 5806.79676211339, 5843.065109582446, 5845.123231515222, 5761.85595360111, 5767.36558978512, 5841.4450627190345, 5844.8538786529825, 5882.911756323659, 5865.384134665798, 5866.70666466675, 5889.263842019747, 5889.617174883619, 5891.998360278762, 4402.361657559636, 4497.100579883971, 4506.3916371290115, 4552.1806074906835, 4553.544645535486, 4021.095253567924, 4033.5966403360017, 4036.253293140778, 4053.43251944728, 4058.776767277828, 5470.753816078286, 5473.562115030868, 5515.0, 5518.724063796794, 5530.225768392428, 5600.27196464457, 5725.198472213893, 5750.683712395775, 5860.179574859523, 5888.587798854039, 5435.673859568438, 5552.056150454432, 5583.302087239095, 5590.804321848797, 5597.384287728347, 5143.97428012865, 5169.715665638426, 5178.585713143015, 5188.792448302026, 5216.347956505437, 5755.280589926259, 5840.620359676607, 5891.116332550066, 5897.9115313271195, 5973.940260597426, 5749.540036796962, 5753.654780713171, 5754.136879468113, 5769.769209231752, 5875.6474611523445, 5903.616264942765, 5940.049592065248, 5943.1679564861815, 5950.315713692808, 5966.880662386641, 5569.860753481195, 5592.972035139798, 5685.061964775766, 5689.231953686365, 5731.369549349485, 5890.322612899571, 5941.673207973603, 5942.168096466412, 5949.524038076857, 5956.0, 5524.447555244444, 5677.602567820378, 5785.30576330843, 5811.94188058114, 5816.94183058164, 5474.5894057945015, 5555.749991250323, 5556.805511807067, 5564.777408903598, 5571.582131340085, 5519.034169020486, 5549.278593782782, 5551.944480555143, 5554.166874968625, 5555.666660000413, 5532.751026203911, 5619.522340601095, 5663.490285874291, 5672.688002159921, 5676.716164191691, 5391.029614669397, 5472.671639701631, 5475.890482190413, 5485.122380419114, 5520.1443776214755], "mootools.html": [1330.348129416585, 1717.8883372580785, 1739.530326811761, 1770.814064523225, 1771.3180425536166, 6743.999999999994, 6937.757178498754, 7168.24733402993, 7169.354758071772, 7175.42596592272, 7051.1186101737285, 7105.502614816952, 7151.427885769139, 7155.034070400495, 7166.104236970379, 1974.7334109895123, 2022.9089690963867, 2023.6155130525226, 2216.2353987874158, 2250.437390652337, 2001.179516398277, 2010.8089731475486, 2222.6332655111887, 2233.4416395901026, 2271.965920511194, 2218.101668824129, 2232.520008198237, 2273.022600281878, 2285.2801367569245, 2288.5766133265397, 1927.8939658318786, 1990.99004504978, 2259.7062381890332, 2284.4288927768057, 2286.542691461714, 1999.1303782854504, 2295.908163673451, 2340.648902664614, 2342.0865862313713, 2342.1334106380577, 7089.361957423805, 7164.892526612105, 7166.355028047448, 7171.354578087997, 7171.89242161368, 4527.4340707411575, 4536.659750518725, 4564.269716845322, 4582.221022426195, 4594.724316541018, 3165.6042994625673, 3193.5688682028094, 3200.2799370141765, 3233.1270556949494, 3241.2383089973837, 1014.7818219082859, 1035.7307100154014, 1047.0210353319594, 1070.49151652965, 1093.8906109389077, 10316.587336506605, 10468.42423666698, 10471.790564188674, 10476.057154856024, 10482.528286227061, 4251.086016506466, 4320.049589090395, 4358.411614432074, 4371.737695738266, 4378.343248512749, 9126.954365228265, 9138.68014619485, 9149.313801464918, 9155.54222288883, 9156.6795162169, 4647.442306923123, 4688.4373875134515, 4688.929666055012, 4693.06138772247, 4708.223143181337, 4210.936835947463, 4214.768187749642, 4220.620144187038, 4221.6200541951375, 4229.365595160689, 3613.850263374733, 3639.9808053744996, 3672.761270517408, 3678.779273243614, 3679.6136405677553, 1142.1205671632963, 1163.761428907072, 1165.4405885175163, 1166.807476766341, 1167.3521195736448, 1056.8731752189633, 1326.681596416853, 1347.7169794343297, 1353.0596235616151, 1353.1069494134022, 7134.03690501786, 7163.283671632795, 7167.641617919083, 7174.820629484305, 7183.209846916835, 1162.9242950270966, 1181.5864447443325, 1193.9820902686467, 1217.6407959651924, 1232.8240655243503, 5160.40655324635, 5281.762320695578, 5287.048331300402, 5550.389457159709, 5591.916121258185, 7530.623468826537, 8268.421210515206, 8361.790955226046, 8368.58157092143, 8391.244787969112, 8101.311388532041, 8198.590070496452, 8950.14973577509, 8998.0, 9183.265338772882, 7094.964525177445, 7182.892256616155, 7255.310745479171, 7256.7822965311125, 7260.0, 7159.176694680178, 7219.422446204396, 7228.421726261991, 7228.530145540523, 7254.202037775735, 8069.193080691884, 8112.0, 8185.222403871623, 8240.670373185005, 8257.00915890097, 8296.0, 8430.325573953945, 8453.535055572003, 8540.14598540141, 8540.615672294885, 6688.83277918056, 6758.966205168943, 6760.560563563549, 6766.05275261454, 6770.492213084137, 7493.775186744407, 7537.773866784005, 7589.6584653691825, 7594.772156835304, 7602.0, 7086.149662040588, 7119.537230080028, 7191.2449192834, 7209.423246140401, 7250.347468727839, 6871.278515755774, 6971.093757811452, 6980.0, 7026.473014523829, 7096.680649370894, 7118.466115041496, 7149.785506434815, 7154.105736782903, 7154.678039488132, 7159.498835081495, 6368.522360822864, 6460.580062295936, 6561.835954101186, 6585.835354115994, 6592.0, 6614.735410583523, 6633.1045308882685, 6637.0, 6643.368879956396, 6646.567973081927], "ext.html": [584.3251045042975, 591.352469046394, 593.9465448109669, 594.9970250148747, 619.5384438593246, 31974.20064498389, 32649.83675081624, 32675.183120422, 32694.182645433877, 39743.80128099355, 43228.567714322846, 43723.0, 43761.343579846325, 43855.78072109643, 43859.342109868376, 8751.518666473341, 8931.50876701781, 8931.821363572724, 8940.552972351388, 8941.329400294971, 7735.071791385014, 7916.485428447132, 8653.69712060075, 10429.895701042968, 10747.5163617637, 10471.895281047167, 10563.947180264087, 10574.629887953923, 10580.78838423231, 10585.735356616107, 7835.333996610295, 10439.79120417595, 10512.474376281156, 10556.366618002945, 10557.73605659857, 7625.923740762577, 10504.0, 10801.40592267425, 10808.351498910011, 10810.783784324269, 39854.402183967264, 40175.99560010994, 40351.0, 40529.79735101335, 40564.79717601393, 3243.108145260049, 3302.3725492156655, 3395.8471868765964, 3438.3639026780124, 3647.1611529348397, 29064.273393165127, 29464.26339341512, 29465.705342946512, 29556.408871822445, 30011.399772004657, 3520.102373894666, 3586.444101164324, 3590.0845284452557, 3605.963940360589, 3651.233241019389, 276624.0, 277550.0, 277552.0, 277740.0, 278355.6082219596, 51251.7437412818, 52301.7384913073, 57218.42781572131, 57645.711771440874, 57761.0, 59889.700551496964, 60644.39355606476, 61001.0, 61001.69499152476, 61195.694021529605, 15436.073835569901, 15634.0, 15657.29542170605, 15664.608384790472, 15676.921615392079, 11895.524179032915, 11989.88010119905, 12007.339596322112, 12008.979236764799, 12010.33943133136, 17873.195706192993, 18544.536386590175, 18625.7206141908, 18712.53218669517, 18720.53198670017, 7289.307515785992, 7359.705611775469, 7407.8888816667795, 7469.887951680729, 7502.587357695379, 961.5576834656136, 1000.6297669862198, 1004.6182450668699, 1014.5383850348074, 1120.1207052463776, 28745.42509149805, 28797.712022879503, 29054.418911621648, 29090.0, 33763.49354759681, 1038.85456036155, 1058.708855064848, 1113.337564149346, 1148.5944175519624, 1149.5861489863642, 15414.922925385301, 15422.0, 15491.380344786308, 15650.139242341553, 15986.60033499172, 371391.0, 374381.0, 375107.0, 375382.0, 377715.0, 55649.443505565236, 55847.16229256564, 55937.0, 55970.44029559652, 56158.0, 1324.298121995344, 1334.2261488336742, 1354.4785257676062, 1356.3828458051562, 1361.6187467509114, 30264.243393914447, 30810.845945771023, 30998.0, 31283.53074703927, 31662.0, 46342.0, 46839.765801170775, 46897.53102469068, 46946.0, 46949.0, 309994.0, 311321.0, 312996.0, 313106.0, 313443.0, 27162.270183852444, 32448.51327230046, 32715.672843271263, 32966.83516582402, 33059.0, 39325.80337098296, 39524.40713389359, 39668.40497392484, 39808.60191398049, 40632.39051414172, 34362.65637343695, 34560.82719586386, 34842.82578587091, 34871.82564087163, 41961.160776784905, 34738.82630586831, 37265.81367093147, 37834.243315134096, 40689.0, 40999.18001639891, 37683.246335072596, 37818.43272350972, 41345.379819303336, 42018.57981420147, 42093.0, 32259.838700806347, 34327.31345373028, 34600.653993459746, 34719.305613887074, 34847.47728784121, 26302.0, 26365.604515931893, 26367.472650547264, 26518.0, 26870.596941045507], "prototype.html": [335.26075004614825, 336.85346874109763, 337.93072420153874, 345.07691924103017, 349.81285012518293, 5824.039033559468, 5926.911096333559, 6000.069989151678, 6003.639781613096, 6021.0667346561295, 5781.479666829984, 5913.85215369616, 5917.053271476565, 5936.347001829795, 5940.88118237635, 4606.930896036553, 4607.193741095311, 4612.4465064192345, 4616.930746038812, 4621.884452888671, 4400.053988392495, 4469.642428605704, 4529.660275479336, 4608.746518941457, 4631.258998560231, 4550.044490656966, 4572.15415148197, 4574.954250457503, 4583.747893865852, 4593.4947155813, 4577.359169716243, 4581.65637577183, 4582.679212455129, 4584.770761461914, 4592.714040068753, 4041.9191616167514, 4045.7572545647354, 4052.1693052924375, 4054.108096218827, 4054.16889537647, 5573.637713548647, 5619.971900140473, 5657.519110875581, 5668.886622267572, 5670.518005969498, 5339.3058902342445, 5358.2498450217, 5358.812441564565, 5359.490848369399, 5364.302640656729, 6051.062085376773, 6291.370862913718, 6295.590786598902, 6298.401651843067, 6302.842428939267, 4332.696711230215, 4360.454943132108, 4401.339799030139, 4422.0, 4436.622887054604, 6431.163948686688, 6453.064305675698, 6453.386928241856, 6455.257645370749, 6458.61248325102, 4515.81936722534, 4536.410266665378, 4546.909061818745, 4548.727076375362, 4549.02196027849, 4454.621357184611, 4582.862514124582, 4598.632109431237, 4599.080183963154, 4601.44782626087, 5233.973830130901, 5242.501962313574, 5243.318368612056, 5246.396664383568, 5249.816256431007, 6241.313455519889, 6252.030935205051, 6253.0, 6253.5622506424115, 6262.780802671976, 1627.26772952172, 1627.7395616701272, 1633.2568681250002, 1648.7279598866292, 1649.5463747469303, 1122.7417693930443, 1123.2586492914636, 1134.2173900008968, 1135.2280449294394, 1157.8205378166397, 5986.3714309997695, 5995.100734889801, 6002.699865006733, 6004.519638428916, 6010.338862725097, 6553.475721942234, 6559.245686746085, 6563.540552161303, 6566.737330506726, 6566.967165164144, 5956.880862382728, 6062.818115456544, 6095.390460953958, 6095.451409373089, 6098.048624440136, 3529.770564913272, 3553.9644603553634, 3555.839987200582, 3566.375884220251, 3570.91072723184, 6729.831754206184, 6763.695633696496, 6766.391024807791, 6773.45812335012, 6784.355486228899, 6606.636634985026, 6701.229358623723, 6718.361755633207, 6718.697658605374, 6725.730970761115, 6776.322367763283, 6778.661066946633, 6791.864162716817, 6792.0, 6797.694103765342, 6407.775727849503, 6549.574277671936, 6551.246606640298, 6564.343565643398, 6572.244191917991, 6379.298277189599, 6445.16212892321, 6536.084948107174, 6568.540202185993, 6587.209534855848, 6751.797446076625, 6757.0, 6813.318668133147, 6867.038614593861, 6867.141607299088, 4517.796699148612, 4591.632669386374, 4619.792109355019, 4622.121796858586, 4648.814047438064, 6547.345265473605, 6552.27924928248, 6555.475561955128, 6556.442702370352, 6565.96717016431, 6407.743690252338, 6408.455281301141, 6409.8718025640155, 6412.1023056771155, 6414.518911081781, 6247.219097612799, 6384.297727249906, 6392.904106438315, 6395.232572091379, 6426.228852537725, 6342.080398342307, 6349.206349206349, 6357.427831495188, 6363.236411630634, 6368.52236082305, 6497.772577959938, 6515.0553169791065, 6519.445847103049, 6522.5760325578685, 6526.184226971629, 6198.907016394667, 6333.65164915934, 6341.302456729663, 6349.365063493614, 6357.268914074755], "yui.html": [775.7440044785221, 857.2242120880601, 862.0689655172413, 866.6490071521032, 887.7603047177266, 12423.503059877605, 12716.809247861289, 12751.808722869153, 12770.297633630158, 12951.870481295207, 11016.283941543794, 13190.34048297586, 13291.93354033231, 13295.601131966032, 13296.601101966933, 671.0605152786114, 815.902091748988, 817.0562999735315, 817.889584906039, 818.1491249100928, 809.3323008517967, 810.623060276971, 813.3168138763438, 813.6948644258404, 814.2020819596798, 709.978700638979, 713.2012146396017, 852.5311078906608, 853.0914575976597, 853.3557164340914, 840.9495430274203, 841.0748177005306, 842.5281842168405, 844.7254642241265, 851.7402192331336, 623.1276213301369, 625.7528276330869, 628.0046126888886, 630.8927482328015, 632.993670063298, 12400.62798116058, 12674.80987785184, 12685.302308373035, 12705.682357941034, 12708.745825083539, 11922.701932451671, 12576.685582860502, 13393.933030334883, 13407.0, 13512.05415620907, 10070.194384449227, 10232.795344093076, 10303.845442318372, 10401.323913945569, 10483.895161048367, 3644.4168932970597, 3647.726420518445, 3659.9817000914827, 3717.925641487155, 3793.089658481972, 47970.0, 48097.27854082191, 48205.75897120492, 48597.51402485965, 49001.26498102567, 8192.057913340042, 8272.917270827335, 10155.187584993182, 10213.08082272599, 10383.532741026673, 12717.728227177207, 12777.041721870897, 12793.808092878615, 12809.935950320189, 12848.871511284955, 6676.46588272937, 6865.725370985205, 7109.502334836615, 7131.857362852714, 7172.354488096096, 4287.506936702257, 4329.826806927687, 4364.825406983685, 4387.100644367897, 4524.47968483622, 2742.6297449844415, 2750.7386798254133, 2754.9724502755116, 2761.2268564801484, 2764.4609301186074, 427.9315309550457, 429.2616699277238, 429.9312110062375, 439.49458123157984, 440.9052053808447, 654.4077609763171, 662.3872917551342, 667.1760375935716, 671.5903298987614, 676.9570779346867, 8090.231428014447, 8104.756857294173, 8256.20288552741, 8854.422011261217, 8895.688650897187, 550.7934524553292, 592.0763608770332, 647.1651569475324, 697.2539382860392, 718.3104219948907, 4008.198360327946, 4133.21468920904, 4211.494620645542, 4223.092035212444, 4253.808578613908, 56951.43048569544, 57505.71247143738, 57613.0, 58120.0, 58228.0, 51515.87872970154, 51819.481805181465, 52184.73907630437, 52313.215301770506, 52701.7364913173, 45763.54236457659, 46678.0, 46939.0, 48270.5172948273, 48907.755461223176, 8463.830723385621, 8526.68386813968, 8608.354373422144, 8695.087015863242, 8795.612112315552, 35288.29423411569, 35403.0, 35528.38131042948, 35873.46189807103, 36845.63154368529, 46074.769626151654, 46121.53878461172, 46558.30162547497, 46958.530414695415, 46997.0, 7948.721794737156, 8170.091964405462, 8252.33981281508, 8261.17388261193, 8302.87545686803, 12040.578579749666, 12236.629652009278, 12241.0, 12515.812262815884, 12669.303188324731, 11572.132090093444, 11633.59282425111, 11882.762344752884, 12238.938805305916, 12286.631401057624, 10633.468326583485, 10715.196360273167, 10726.73183170427, 11748.530058797553, 12175.0, 11352.489137988645, 11442.771144577227, 11644.2431241969, 11758.529658813552, 11946.880531194576, 9784.920119560637, 9814.509274536387, 9969.252306077218, 10107.292489525662, 10147.391156530632, 8986.640534378552, 9927.007299270015, 10102.242331824995, 10119.797604048024, 10136.695899123039]}, "summary": {"lowerIsBetter": false, "suite": 6787.392316676036, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7342.465144582676, "unit": "ms", "value": 7342.465144582676}, "dojo.html": {"lowerIsBetter": false, "filtered": 5351.194378380629, "unit": "ms", "value": 5351.194378380629}, "mootools.html": {"lowerIsBetter": false, "filtered": 4432.660441966083, "unit": "ms", "value": 4432.660441966083}, "ext.html": {"lowerIsBetter": false, "filtered": 19021.251103436807, "unit": "ms", "value": 19021.251103436807}, "prototype.html": {"lowerIsBetter": false, "filtered": 4805.6329553756095, "unit": "ms", "value": 4805.6329553756095}, "yui.html": {"lowerIsBetter": false, "filtered": 6140.909105432102, "unit": "ms", "value": 6140.909105432102}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-041"}, "testrun": {"date": 1447740103, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116203312", "branch": "Fx-Team", "revision": "ffdc7f22130425020f5d648ef99c10b947541659"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 161.0, 163.0, 159.0, 162.0, 161.0, 160.0, 164.0, 161.0, 162.0], "ai-astar": [110.0, 112.0, 105.0, 112.0, 111.0, 111.0, 100.0, 114.0, 109.0, 107.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "audio-beat-detection": [156.0, 124.0, 155.0, 166.0, 125.0, 154.0, 157.0, 123.0, 173.0, 123.0], "json-stringify-tinderbox": [68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0], "stanford-crypto-pbkdf2": [153.0, 152.0, 150.0, 154.0, 150.0, 140.0, 153.0, 150.0, 147.0, 144.0], "json-parse-financial": [61.0, 61.0, 57.0, 57.0, 58.0, 58.0, 65.0, 66.0, 54.0, 56.0], "stanford-crypto-sha256-iterative": [66.0, 66.0, 67.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0], "audio-fft": [72.0, 72.0, 85.0, 90.0, 72.0, 71.0, 71.0, 120.0, 98.0, 72.0], "imaging-darkroom": [144.0, 147.0, 144.0, 146.0, 144.0, 146.0, 145.0, 144.0, 145.0, 144.0], "stanford-crypto-ccm": [121.0, 117.0, 117.0, 113.0, 115.0, 122.0, 129.0, 128.0, 115.0, 124.0], "audio-oscillator": [90.0, 91.0, 138.0, 90.0, 91.0, 90.0, 139.0, 89.0, 91.0, 142.0], "stanford-crypto-aes": [83.0, 84.0, 84.0, 84.0, 91.0, 83.0, 84.0, 86.0, 85.0, 86.0], "imaging-desaturate": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1501.2999999999997, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 82.3, "unit": "ms", "value": 82.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.3, "unit": "ms", "value": 149.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.6, "unit": "ms", "value": 145.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 120.1, "unit": "ms", "value": 120.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 144.9, "unit": "ms", "value": 144.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 59.3, "unit": "ms", "value": 59.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 105.1, "unit": "ms", "value": 105.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.1, "unit": "ms", "value": 109.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.3, "unit": "ms", "value": 161.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 65.6, "unit": "ms", "value": 65.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.9, "unit": "ms", "value": 68.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.0, "unit": "ms", "value": 85.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.6, "unit": "ms", "value": 95.6}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-041"}, "testrun": {"date": 1447740103, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116203312", "branch": "Fx-Team", "revision": "ffdc7f22130425020f5d648ef99c10b947541659"}}, {"talos_counters": {}, "results": {"DeltaBlue": [188.39487565938205], "Encrypt": [281.29395218002816], "NavierStokes": [4830.917874396136], "Decrypt": [5035.175879396985], "Splay": [619.2519926425506], "Richards": [162.86644951140065], "RegExp": [25425.0], "Earley": [814.4833197721725], "Boyer": [12144.578313253012], "RayTrace": [1939.922480620155]}, "summary": {"lowerIsBetter": false, "suite": 19912.523665820692, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 350.95434399999994, "unit": "score", "value": 350.95434399999994}, "Encrypt": {"lowerIsBetter": false, "filtered": 946.2734550000002, "unit": "score", "value": 946.2734550000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 131.59586237623762, "unit": "score", "value": 131.59586237623762}, "RegExp": {"lowerIsBetter": false, "filtered": 35.83028515240902, "unit": "score", "value": 35.83028515240902}, "Richards": {"lowerIsBetter": false, "filtered": 216.75427999999994, "unit": "score", "value": 216.75427999999994}, "Earley": {"lowerIsBetter": false, "filtered": 818.2647622377618, "unit": "score", "value": 818.2647622377618}, "Boyer": {"lowerIsBetter": false, "filtered": 54.87740972222223, "unit": "score", "value": 54.87740972222223}, "RayTrace": {"lowerIsBetter": false, "filtered": 381.452871128871, "unit": "score", "value": 381.452871128871}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-041"}, "testrun": {"date": 1447740103, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116203312", "branch": "Fx-Team", "revision": "ffdc7f22130425020f5d648ef99c10b947541659"}}] 22:21:55 INFO - RETURN: dromaeo_css: 6787.39 22:21:55 INFO - RETURN: kraken: 1501.30 22:21:55 INFO - RETURN: v8_7: 19912.52 22:21:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19912.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1501.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6787.39"}}} 22:21:55 INFO - Return code: 0 22:21:55 INFO - # TBPL SUCCESS # 22:21:55 INFO - Running post-action listener: _resource_record_post_action 22:21:55 INFO - Running post-run listener: _resource_record_post_run 22:21:56 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 518205440; Read time: 0; Write time: 597812 22:21:56 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 228560896; Read time: 0; Write time: 384100 22:21:56 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 280125440; Read time: 0; Write time: 168148 22:21:56 INFO - Running post-run listener: _upload_blobber_files 22:21:56 INFO - Blob upload gear active. 22:21:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:21:56 INFO - Copying logs to upload dir... 22:21:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.110551 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-16 22:21:56.345317) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 22:21:56.348666) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010043 build_url: 'https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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-16 22:21:56.400160) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:21:56.400481) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447739625.433335-1142997163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:21:56.450448) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 22:21:56.450879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 22:21:56.451199) ========= ========= Total master_lag: 0.23 =========