builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1448354916.81 results: success (0) buildid: 20151123233007 builduid: 9fdcbe9d33cd44f6a0456fb8cd41c599 revision: 4dca10306d58d2e87cbed46a72472b62c17b0ec9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:36.809440) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:36.809822) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:36.810111) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006436 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:36.835996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:36.836274) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:36.858431) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:36.858705) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004613 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:36.916727) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:36.920007) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:36.920389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:36.920662) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 00:48:37-- 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% 18.2M=0.001s 2015-11-24 00:48:37 (18.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192561 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:37.126972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:37.127430) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020104 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:37.176923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:37.177294) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4dca10306d58d2e87cbed46a72472b62c17b0ec9 --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 4dca10306d58d2e87cbed46a72472b62c17b0ec9 --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=6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 00:48:37,449 truncating revision to first 12 chars 2015-11-24 00:48:37,450 Setting DEBUG logging. 2015-11-24 00:48:37,450 attempt 1/10 2015-11-24 00:48:37,450 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4dca10306d58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 00:48:37,702 unpacking tar archive at: fx-team-4dca10306d58/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545027 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:37.734473) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:37.734753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:37.747977) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:37.748625) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:37.749383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-24 00:48:37.749904) ========= /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=6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:48:38 INFO - MultiFileLogger online at 20151124 00:48:38 in /builds/slave/test-pgo 00:48:38 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 00:48:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:48:38 INFO - {'append_to_log': False, 00:48:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:48:38 INFO - 'blob_upload_branch': 'Fx-Team', 00:48:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:48:38 INFO - 'branch': 'Fx-Team', 00:48:38 INFO - 'buildbot_json_path': 'buildprops.json', 00:48:38 INFO - 'config_files': ('talos/linux_config.py',), 00:48:38 INFO - 'default_actions': ('clobber', 00:48:38 INFO - 'read-buildbot-config', 00:48:38 INFO - 'download-and-extract', 00:48:38 INFO - 'populate-webroot', 00:48:38 INFO - 'create-virtualenv', 00:48:38 INFO - 'install', 00:48:38 INFO - 'run-tests'), 00:48:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:48:38 INFO - 'download_minidump_stackwalk': True, 00:48:38 INFO - 'download_symbols': 'ondemand', 00:48:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:48:38 INFO - 'tooltool.py': '/tools/tooltool.py', 00:48:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:48:38 INFO - '/tools/misc-python/virtualenv.py')}, 00:48:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:48:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:48:38 INFO - 'installer_path': 'installer.exe', 00:48:38 INFO - 'log_level': 'info', 00:48:38 INFO - 'log_name': 'talos', 00:48:38 INFO - 'log_to_console': True, 00:48:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:48:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:48:38 INFO - 'opt_config_files': (), 00:48:38 INFO - 'pip_index': False, 00:48:38 INFO - 'sps_profile': False, 00:48:38 INFO - 'sps_profile_interval': 0, 00:48:38 INFO - 'suite': 'dromaeojs', 00:48:38 INFO - 'system_bits': '64', 00:48:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:48:38 INFO - 'title': 'talos-linux64-ix-057', 00:48:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:48:38 INFO - 'use_talos_json': True, 00:48:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:48:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:48:38 INFO - 'work_dir': 'build'} 00:48:38 INFO - ##### 00:48:38 INFO - ##### Running clobber step. 00:48:38 INFO - ##### 00:48:38 INFO - Running pre-action listener: _resource_record_pre_action 00:48:38 INFO - Running main action method: clobber 00:48:38 INFO - rmtree: /builds/slave/test-pgo/build 00:48:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:48:38 INFO - Running post-action listener: _resource_record_post_action 00:48:38 INFO - ##### 00:48:38 INFO - ##### Running read-buildbot-config step. 00:48:38 INFO - ##### 00:48:38 INFO - Running pre-action listener: _resource_record_pre_action 00:48:38 INFO - Running main action method: read_buildbot_config 00:48:38 INFO - Using buildbot properties: 00:48:38 INFO - { 00:48:38 INFO - "properties": { 00:48:38 INFO - "buildnumber": 799, 00:48:38 INFO - "product": "firefox", 00:48:38 INFO - "script_repo_revision": "production", 00:48:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:48:38 INFO - "repository": "", 00:48:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:48:38 INFO - "buildid": "20151123233007", 00:48:38 INFO - "slavename": "talos-linux64-ix-057", 00:48:38 INFO - "pgo_build": "True", 00:48:38 INFO - "basedir": "/builds/slave/test-pgo", 00:48:38 INFO - "project": "", 00:48:38 INFO - "platform": "ubuntu64_hw", 00:48:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:48:38 INFO - "slavebuilddir": "test", 00:48:38 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:48:38 INFO - "branch": "fx-team", 00:48:38 INFO - "repo_path": "integration/fx-team", 00:48:38 INFO - "stage_platform": "linux64-pgo", 00:48:38 INFO - "builduid": "9fdcbe9d33cd44f6a0456fb8cd41c599", 00:48:38 INFO - "revision": "4dca10306d58d2e87cbed46a72472b62c17b0ec9" 00:48:38 INFO - }, 00:48:38 INFO - "sourcestamp": { 00:48:38 INFO - "repository": "", 00:48:38 INFO - "hasPatch": false, 00:48:38 INFO - "project": "", 00:48:38 INFO - "branch": "fx-team-linux64-pgo-talos", 00:48:38 INFO - "changes": [ 00:48:38 INFO - { 00:48:38 INFO - "category": null, 00:48:38 INFO - "files": [ 00:48:38 INFO - { 00:48:38 INFO - "url": null, 00:48:38 INFO - "name": "https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:48:38 INFO - } 00:48:38 INFO - ], 00:48:38 INFO - "repository": "", 00:48:38 INFO - "rev": "4dca10306d58d2e87cbed46a72472b62c17b0ec9", 00:48:38 INFO - "who": "sendchange", 00:48:38 INFO - "when": 1448354855, 00:48:38 INFO - "number": 6699375, 00:48:38 INFO - "comments": "", 00:48:38 INFO - "project": "", 00:48:38 INFO - "at": "Tue 24 Nov 2015 00:47:35", 00:48:38 INFO - "branch": "fx-team-linux64-pgo-talos", 00:48:38 INFO - "revlink": "", 00:48:38 INFO - "properties": [ 00:48:38 INFO - [ 00:48:38 INFO - "buildid", 00:48:38 INFO - "20151123233007", 00:48:38 INFO - "Change" 00:48:38 INFO - ], 00:48:38 INFO - [ 00:48:38 INFO - "builduid", 00:48:38 INFO - "9fdcbe9d33cd44f6a0456fb8cd41c599", 00:48:38 INFO - "Change" 00:48:38 INFO - ], 00:48:38 INFO - [ 00:48:38 INFO - "pgo_build", 00:48:38 INFO - "True", 00:48:38 INFO - "Change" 00:48:38 INFO - ] 00:48:38 INFO - ], 00:48:38 INFO - "revision": "4dca10306d58d2e87cbed46a72472b62c17b0ec9" 00:48:38 INFO - } 00:48:38 INFO - ], 00:48:38 INFO - "revision": "4dca10306d58d2e87cbed46a72472b62c17b0ec9" 00:48:38 INFO - } 00:48:38 INFO - } 00:48:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:48:38 INFO - Running post-action listener: _resource_record_post_action 00:48:38 INFO - ##### 00:48:38 INFO - ##### Running download-and-extract step. 00:48:38 INFO - ##### 00:48:38 INFO - Running pre-action listener: _resource_record_pre_action 00:48:38 INFO - Running main action method: download_and_extract 00:48:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:48:38 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')]} 00:48:38 INFO - https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/test_packages.json 00:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/test_packages.json 00:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:48:46 INFO - Downloaded 1302 bytes. 00:48:46 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:48:46 INFO - Using the following test package requirements: 00:48:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:48:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:46 INFO - u'jsshell-linux-x86_64.zip'], 00:48:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:48:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:48:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:48:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:48:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:48:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:48:46 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')]} 00:48:46 INFO - https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/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 00:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/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 00:48:54 INFO - Downloaded 22525990 bytes. 00:48:54 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 00:48:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:54 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 00:48:55 INFO - Return code: 0 00:48:55 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 00:48:55 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')]} 00:48:55 INFO - https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/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 00:48:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/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 00:48:59 INFO - Downloaded 22525990 bytes. 00:48:59 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 00:48:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:59 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 00:49:01 INFO - Return code: 0 00:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:01 INFO - https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:49:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/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 00:49:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/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 00:49:02 INFO - Downloaded 11130997 bytes. 00:49:02 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 00:49:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:02 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 00:49:02 INFO - Return code: 0 00:49:02 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')]} 00:49:02 INFO - https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:49:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:49:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:49:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/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 00:49:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/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 00:49:03 INFO - Downloaded 57588136 bytes. 00:49:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:49:03 INFO - mkdir: /builds/slave/test-pgo/properties 00:49:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:49:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:49:03 INFO - Contents: 00:49:03 INFO - build_url:https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:49:03 INFO - Running post-action listener: _resource_record_post_action 00:49:03 INFO - Running post-action listener: set_extra_try_arguments 00:49:03 INFO - ##### 00:49:03 INFO - ##### Running populate-webroot step. 00:49:03 INFO - ##### 00:49:03 INFO - Running pre-action listener: _resource_record_pre_action 00:49:03 INFO - Running main action method: populate_webroot 00:49:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:49:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:49:03 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:49:03 INFO - '../fennec_ids.txt'], 00:49:03 INFO - 'tests': ['tcheck2']}, 00:49:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:49:03 INFO - '--tppagecycles', 00:49:03 INFO - '7'], 00:49:03 INFO - 'tests': ['tsvgm']}}, 00:49:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:49:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:49:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:49:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:49:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:49:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:49:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:03 INFO - 'talos_options': ['--e10s'], 00:49:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:03 INFO - 'tests': ['damp', 'tps']}, 00:49:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:03 INFO - 'talos_options': ['--e10s'], 00:49:03 INFO - 'tests': ['damp', 'tps']}, 00:49:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:49:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:49:03 INFO - 'other': {'tests': ['a11yr', 00:49:03 INFO - 'ts_paint', 00:49:03 INFO - 'tpaint', 00:49:03 INFO - 'sessionrestore', 00:49:03 INFO - 'sessionrestore_no_auto_restore']}, 00:49:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:49:03 INFO - 'tests': ['a11yr', 00:49:03 INFO - 'ts_paint', 00:49:03 INFO - 'tpaint', 00:49:03 INFO - 'sessionrestore', 00:49:03 INFO - 'sessionrestore_no_auto_restore']}, 00:49:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:49:03 INFO - 'tests': ['a11yr', 00:49:03 INFO - 'ts_paint', 00:49:03 INFO - 'tpaint', 00:49:03 INFO - 'sessionrestore', 00:49:03 INFO - 'sessionrestore_no_auto_restore']}, 00:49:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:49:03 INFO - 'tests': ['a11yr', 00:49:03 INFO - 'ts_paint', 00:49:03 INFO - 'tpaint', 00:49:03 INFO - 'sessionrestore', 00:49:03 INFO - 'sessionrestore_no_auto_restore']}, 00:49:03 INFO - 'other_l64': {'tests': ['a11yr', 00:49:03 INFO - 'ts_paint', 00:49:03 INFO - 'tpaint', 00:49:03 INFO - 'sessionrestore', 00:49:03 INFO - 'sessionrestore_no_auto_restore']}, 00:49:03 INFO - 'other_nol64': {'tests': ['a11yr', 00:49:03 INFO - 'ts_paint', 00:49:03 INFO - 'tpaint', 00:49:03 INFO - 'sessionrestore', 00:49:03 INFO - 'sessionrestore_no_auto_restore']}, 00:49:03 INFO - 'svgr': {'tests': ['tsvgx', 00:49:03 INFO - 'tsvgr_opacity', 00:49:03 INFO - 'tart', 00:49:03 INFO - 'tscrollx', 00:49:03 INFO - 'cart']}, 00:49:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:49:03 INFO - 'tests': ['tsvgx', 00:49:03 INFO - 'tsvgr_opacity', 00:49:03 INFO - 'tart', 00:49:03 INFO - 'tscrollx', 00:49:03 INFO - 'cart']}, 00:49:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:03 INFO - 'tests': ['tp5o']}, 00:49:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:03 INFO - 'talos_options': ['--e10s'], 00:49:03 INFO - 'tests': ['tp5o']}, 00:49:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:03 INFO - 'talos_options': ['--xperf_path', 00:49:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:03 INFO - 'tests': ['tp5n']}, 00:49:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:03 INFO - 'talos_options': ['--e10s', 00:49:03 INFO - '--xperf_path', 00:49:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:03 INFO - 'tests': ['tp5n']}}, 00:49:03 INFO - 'talos.zip': {'path': '', 00:49:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:49:03 INFO - Running post-action listener: _resource_record_post_action 00:49:03 INFO - ##### 00:49:03 INFO - ##### Running create-virtualenv step. 00:49:03 INFO - ##### 00:49:03 INFO - Running pre-action listener: _resource_record_pre_action 00:49:03 INFO - Running main action method: create_virtualenv 00:49:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:49:03 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 00:49:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:49:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:49:03 INFO - Using real prefix '/usr' 00:49:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:49:04 INFO - Installing distribute.............................................................................................................................................................................................done. 00:49:06 INFO - Installing pip.................done. 00:49:06 INFO - Return code: 0 00:49:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:49: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')]} 00:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fb7eed49c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca90>, '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 0x24def70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24df2e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', '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 00:49:06 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 00:49:06 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 00:49:06 INFO - Using env: {'DISPLAY': ':0', 00:49:06 INFO - 'HOME': '/home/cltbld', 00:49:06 INFO - 'LANG': 'en_US.UTF-8', 00:49:06 INFO - 'LANGUAGE': 'en_US:en', 00:49:06 INFO - 'LOGNAME': 'cltbld', 00:49:06 INFO - 'MAIL': '/var/mail/cltbld', 00:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:06 INFO - 'MOZ_NO_REMOTE': '1', 00:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:06 INFO - 'NO_EM_RESTART': '1', 00:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:06 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:06 INFO - 'SHELL': '/bin/bash', 00:49:06 INFO - 'SHLVL': '1', 00:49:06 INFO - 'TERM': 'linux', 00:49:06 INFO - 'TMOUT': '86400', 00:49:06 INFO - 'USER': 'cltbld', 00:49:06 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', 00:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:06 INFO - '_': '/tools/buildbot/bin/python'} 00:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:06 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 00:49:06 INFO - Cleaning up... 00:49:06 INFO - Return code: 0 00:49:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:49: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')]} 00:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fb7eed49c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca90>, '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 0x24def70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24df2e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', '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 00:49:06 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 00:49:06 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 00:49:06 INFO - Using env: {'DISPLAY': ':0', 00:49:06 INFO - 'HOME': '/home/cltbld', 00:49:06 INFO - 'LANG': 'en_US.UTF-8', 00:49:06 INFO - 'LANGUAGE': 'en_US:en', 00:49:06 INFO - 'LOGNAME': 'cltbld', 00:49:06 INFO - 'MAIL': '/var/mail/cltbld', 00:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:06 INFO - 'MOZ_NO_REMOTE': '1', 00:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:06 INFO - 'NO_EM_RESTART': '1', 00:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:06 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:06 INFO - 'SHELL': '/bin/bash', 00:49:06 INFO - 'SHLVL': '1', 00:49:06 INFO - 'TERM': 'linux', 00:49:06 INFO - 'TMOUT': '86400', 00:49:06 INFO - 'USER': 'cltbld', 00:49:06 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', 00:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:06 INFO - '_': '/tools/buildbot/bin/python'} 00:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:06 INFO - Downloading/unpacking psutil>=0.7.1 00:49:06 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 00:49:06 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 00:49:06 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 00:49:06 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 00:49:06 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 00:49:06 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 00:49:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:49:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:49:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:49:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:08 INFO - Installing collected packages: psutil 00:49:08 INFO - Running setup.py install for psutil 00:49:08 INFO - building 'psutil._psutil_linux' extension 00:49:08 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 00:49:08 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 00:49:08 INFO - building 'psutil._psutil_posix' extension 00:49:08 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 00:49:09 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 00:49:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:09 INFO - Successfully installed psutil 00:49:09 INFO - Cleaning up... 00:49:09 INFO - Return code: 0 00:49:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fb7eed49c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca90>, '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 0x24def70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24df2e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', '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 00:49:09 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 00:49:09 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 00:49:09 INFO - Using env: {'DISPLAY': ':0', 00:49:09 INFO - 'HOME': '/home/cltbld', 00:49:09 INFO - 'LANG': 'en_US.UTF-8', 00:49:09 INFO - 'LANGUAGE': 'en_US:en', 00:49:09 INFO - 'LOGNAME': 'cltbld', 00:49:09 INFO - 'MAIL': '/var/mail/cltbld', 00:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:09 INFO - 'MOZ_NO_REMOTE': '1', 00:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:09 INFO - 'NO_EM_RESTART': '1', 00:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:09 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:09 INFO - 'SHELL': '/bin/bash', 00:49:09 INFO - 'SHLVL': '1', 00:49:09 INFO - 'TERM': 'linux', 00:49:09 INFO - 'TMOUT': '86400', 00:49:09 INFO - 'USER': 'cltbld', 00:49:09 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', 00:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:09 INFO - '_': '/tools/buildbot/bin/python'} 00:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:49:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:49:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:49:11 INFO - Installing collected packages: mozsystemmonitor 00:49:11 INFO - Running setup.py install for mozsystemmonitor 00:49:11 INFO - Successfully installed mozsystemmonitor 00:49:11 INFO - Cleaning up... 00:49:11 INFO - Return code: 0 00:49:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fb7eed49c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca90>, '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 0x24def70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24df2e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', '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 00:49:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 00:49:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --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 00:49:11 INFO - Using env: {'DISPLAY': ':0', 00:49:11 INFO - 'HOME': '/home/cltbld', 00:49:11 INFO - 'LANG': 'en_US.UTF-8', 00:49:11 INFO - 'LANGUAGE': 'en_US:en', 00:49:11 INFO - 'LOGNAME': 'cltbld', 00:49:11 INFO - 'MAIL': '/var/mail/cltbld', 00:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:11 INFO - 'MOZ_NO_REMOTE': '1', 00:49:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:11 INFO - 'NO_EM_RESTART': '1', 00:49:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:11 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:11 INFO - 'SHELL': '/bin/bash', 00:49:11 INFO - 'SHLVL': '1', 00:49:11 INFO - 'TERM': 'linux', 00:49:11 INFO - 'TMOUT': '86400', 00:49:11 INFO - 'USER': 'cltbld', 00:49:11 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', 00:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:11 INFO - '_': '/tools/buildbot/bin/python'} 00:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:11 INFO - Downloading/unpacking blobuploader==1.2.4 00:49:11 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 00:49:11 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 00:49:11 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 00:49:11 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 00:49:11 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 00:49:11 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 00:49:13 INFO - Downloading blobuploader-1.2.4.tar.gz 00:49:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:49:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:49:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:49:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:49:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:13 INFO - Downloading docopt-0.6.1.tar.gz 00:49:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:49:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:49:13 INFO - Installing collected packages: blobuploader, requests, docopt 00:49:13 INFO - Running setup.py install for blobuploader 00:49:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:49:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:49:13 INFO - Running setup.py install for requests 00:49:14 INFO - Running setup.py install for docopt 00:49:14 INFO - Successfully installed blobuploader requests docopt 00:49:14 INFO - Cleaning up... 00:49:14 INFO - Return code: 0 00:49:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:14 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')]} 00:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:14 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')]} 00:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:14 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 0x7fb7eed49c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca90>, '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 0x24def70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24df2e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', '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 00:49:14 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 00:49:14 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 00:49:14 INFO - Using env: {'DISPLAY': ':0', 00:49:14 INFO - 'HOME': '/home/cltbld', 00:49:14 INFO - 'LANG': 'en_US.UTF-8', 00:49:14 INFO - 'LANGUAGE': 'en_US:en', 00:49:14 INFO - 'LOGNAME': 'cltbld', 00:49:14 INFO - 'MAIL': '/var/mail/cltbld', 00:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:14 INFO - 'MOZ_NO_REMOTE': '1', 00:49:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:14 INFO - 'NO_EM_RESTART': '1', 00:49:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:14 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:14 INFO - 'SHELL': '/bin/bash', 00:49:14 INFO - 'SHLVL': '1', 00:49:14 INFO - 'TERM': 'linux', 00:49:14 INFO - 'TMOUT': '86400', 00:49:14 INFO - 'USER': 'cltbld', 00:49:14 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', 00:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:14 INFO - '_': '/tools/buildbot/bin/python'} 00:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:14 INFO - Running setup.py (path:/tmp/pip-O0se7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:14 INFO - Running setup.py (path:/tmp/pip-62zcvF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:14 INFO - Running setup.py (path:/tmp/pip-K258TQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:14 INFO - Running setup.py (path:/tmp/pip-Ags8iz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:14 INFO - Running setup.py (path:/tmp/pip-uGhk6Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:15 INFO - Running setup.py (path:/tmp/pip-u69n4e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:15 INFO - Running setup.py (path:/tmp/pip-63zRR4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:15 INFO - Running setup.py (path:/tmp/pip-jUzr_x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:15 INFO - Running setup.py (path:/tmp/pip-yvVkki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:15 INFO - Running setup.py (path:/tmp/pip-UD028f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:15 INFO - Running setup.py (path:/tmp/pip-WWL1o0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:15 INFO - Running setup.py (path:/tmp/pip-hACHAD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:15 INFO - Running setup.py (path:/tmp/pip-dAIPCs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:15 INFO - Running setup.py (path:/tmp/pip-jSo1fQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:15 INFO - Running setup.py (path:/tmp/pip-bWfmU4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:15 INFO - Running setup.py (path:/tmp/pip-ojWADZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:15 INFO - Running setup.py (path:/tmp/pip-H6AHoi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:49:15 INFO - Running setup.py install for manifestparser 00:49:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:49:16 INFO - Running setup.py install for mozcrash 00:49:16 INFO - Running setup.py install for mozdebug 00:49:16 INFO - Running setup.py install for mozdevice 00:49:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:49:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:49:16 INFO - Running setup.py install for mozfile 00:49:16 INFO - Running setup.py install for mozhttpd 00:49:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:49:16 INFO - Running setup.py install for mozinfo 00:49:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:49:16 INFO - Running setup.py install for mozInstall 00:49:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:49:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:49:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:49:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:49:16 INFO - Running setup.py install for mozleak 00:49:16 INFO - Running setup.py install for mozlog 00:49:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:49:16 INFO - Running setup.py install for moznetwork 00:49:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:49:17 INFO - Running setup.py install for mozprocess 00:49:17 INFO - Running setup.py install for mozprofile 00:49:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:49:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:49:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:49:17 INFO - Running setup.py install for mozrunner 00:49:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:49:17 INFO - Running setup.py install for mozscreenshot 00:49:17 INFO - Running setup.py install for moztest 00:49:17 INFO - Running setup.py install for mozversion 00:49:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:49:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:49:17 INFO - Cleaning up... 00:49:17 INFO - Return code: 0 00:49:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49: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')]} 00:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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', '-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 0x7fb7eed49c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca90>, '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 0x24def70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24df2e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', '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 00:49:17 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 00:49:17 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 00:49:17 INFO - Using env: {'DISPLAY': ':0', 00:49:17 INFO - 'HOME': '/home/cltbld', 00:49:17 INFO - 'LANG': 'en_US.UTF-8', 00:49:17 INFO - 'LANGUAGE': 'en_US:en', 00:49:17 INFO - 'LOGNAME': 'cltbld', 00:49:17 INFO - 'MAIL': '/var/mail/cltbld', 00:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:17 INFO - 'MOZ_NO_REMOTE': '1', 00:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:17 INFO - 'NO_EM_RESTART': '1', 00:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:17 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:17 INFO - 'SHELL': '/bin/bash', 00:49:17 INFO - 'SHLVL': '1', 00:49:17 INFO - 'TERM': 'linux', 00:49:17 INFO - 'TMOUT': '86400', 00:49:17 INFO - 'USER': 'cltbld', 00:49:17 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', 00:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:17 INFO - '_': '/tools/buildbot/bin/python'} 00:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:17 INFO - Running setup.py (path:/tmp/pip-F76GoJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:17 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)) 00:49:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:17 INFO - Running setup.py (path:/tmp/pip-64LJDH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:18 INFO - Running setup.py (path:/tmp/pip-3DzmuK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:18 INFO - Running setup.py (path:/tmp/pip-OSjbIn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:18 INFO - Running setup.py (path:/tmp/pip-uq7dlm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:18 INFO - Running setup.py (path:/tmp/pip-wrI1oL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:18 INFO - Running setup.py (path:/tmp/pip-40acNu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:18 INFO - Running setup.py (path:/tmp/pip-ziXBdm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:18 INFO - Running setup.py (path:/tmp/pip-1RqZLl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:18 INFO - Running setup.py (path:/tmp/pip-03ImeY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:18 INFO - Running setup.py (path:/tmp/pip-XL42Vz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:18 INFO - Running setup.py (path:/tmp/pip-_QdAI5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:18 INFO - Running setup.py (path:/tmp/pip-RTIfz2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:18 INFO - Running setup.py (path:/tmp/pip-e1gZSY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:18 INFO - Running setup.py (path:/tmp/pip-Gk26d2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:18 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)) 00:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:18 INFO - Running setup.py (path:/tmp/pip-YqtNFb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:19 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)) 00:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:19 INFO - Running setup.py (path:/tmp/pip-e_YU1w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:19 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)) 00:49:19 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)) 00:49:19 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)) 00:49:19 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)) 00:49:19 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)) 00:49:19 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)) 00:49:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:20 INFO - Downloading blessings-1.5.1.tar.gz 00:49:20 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 00:49:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:49:20 INFO - Installing collected packages: blessings 00:49:20 INFO - Running setup.py install for blessings 00:49:21 INFO - Successfully installed blessings 00:49:21 INFO - Cleaning up... 00:49:21 INFO - Return code: 0 00:49:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:49:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:49:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:49:21 INFO - Reading from file tmpfile_stdout 00:49:21 INFO - Current package versions: 00:49:21 INFO - argparse == 1.2.1 00:49:21 INFO - blessings == 1.5.1 00:49:21 INFO - blobuploader == 1.2.4 00:49:21 INFO - docopt == 0.6.1 00:49:21 INFO - manifestparser == 1.1 00:49:21 INFO - mozInstall == 1.12 00:49:21 INFO - mozcrash == 0.16 00:49:21 INFO - mozdebug == 0.1 00:49:21 INFO - mozdevice == 0.47 00:49:21 INFO - mozfile == 1.2 00:49:21 INFO - mozhttpd == 0.7 00:49:21 INFO - mozinfo == 0.9 00:49:21 INFO - mozleak == 0.1 00:49:21 INFO - mozlog == 3.1 00:49:21 INFO - moznetwork == 0.27 00:49:21 INFO - mozprocess == 0.22 00:49:21 INFO - mozprofile == 0.27 00:49:21 INFO - mozrunner == 6.11 00:49:21 INFO - mozscreenshot == 0.1 00:49:21 INFO - mozsystemmonitor == 0.0 00:49:21 INFO - moztest == 0.7 00:49:21 INFO - mozversion == 1.4 00:49:21 INFO - psutil == 3.1.1 00:49:21 INFO - requests == 1.2.3 00:49:21 INFO - wsgiref == 0.1.2 00:49:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49: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')]} 00:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:21 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 0x7fb7eed49c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca90>, '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 0x24def70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24df2e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', '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 00:49:21 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 00:49:21 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 00:49:21 INFO - Using env: {'DISPLAY': ':0', 00:49:21 INFO - 'HOME': '/home/cltbld', 00:49:21 INFO - 'LANG': 'en_US.UTF-8', 00:49:21 INFO - 'LANGUAGE': 'en_US:en', 00:49:21 INFO - 'LOGNAME': 'cltbld', 00:49:21 INFO - 'MAIL': '/var/mail/cltbld', 00:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:21 INFO - 'MOZ_NO_REMOTE': '1', 00:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:21 INFO - 'NO_EM_RESTART': '1', 00:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:21 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:21 INFO - 'SHELL': '/bin/bash', 00:49:21 INFO - 'SHLVL': '1', 00:49:21 INFO - 'TERM': 'linux', 00:49:21 INFO - 'TMOUT': '86400', 00:49:21 INFO - 'USER': 'cltbld', 00:49:21 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', 00:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:21 INFO - '_': '/tools/buildbot/bin/python'} 00:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 INFO - Cleaning up... 00:49:21 INFO - Return code: 0 00:49:21 INFO - Running post-action listener: _resource_record_post_action 00:49:21 INFO - Running post-action listener: _start_resource_monitoring 00:49:21 INFO - Starting resource monitoring. 00:49:21 INFO - ##### 00:49:21 INFO - ##### Running install step. 00:49:21 INFO - ##### 00:49:21 INFO - Running pre-action listener: _resource_record_pre_action 00:49:21 INFO - Running main action method: install 00:49:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:49:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:49:21 INFO - Reading from file tmpfile_stdout 00:49:21 INFO - Detecting whether we're running mozinstall >=1.0... 00:49:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:49:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:49:21 INFO - Reading from file tmpfile_stdout 00:49:21 INFO - Output received: 00:49:21 INFO - Usage: mozinstall [options] installer 00:49:21 INFO - Options: 00:49:21 INFO - -h, --help show this help message and exit 00:49:21 INFO - -d DEST, --destination=DEST 00:49:21 INFO - Directory to install application into. [default: 00:49:21 INFO - "/builds/slave/test-pgo"] 00:49:21 INFO - --app=APP Application being installed. [default: firefox] 00:49:21 INFO - mkdir: /builds/slave/test-pgo/build/application 00:49:21 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'] 00:49:21 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 00:49:36 INFO - Reading from file tmpfile_stdout 00:49:36 INFO - Output received: 00:49:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:49:36 INFO - Running post-action listener: _resource_record_post_action 00:49:36 INFO - ##### 00:49:36 INFO - ##### Running run-tests step. 00:49:36 INFO - ##### 00:49:36 INFO - Running pre-action listener: _resource_record_pre_action 00:49:36 INFO - Running main action method: run_tests 00:49:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:49:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:49:36 INFO - Python 2.7.3 00:49:36 INFO - Return code: 0 00:49:36 INFO - grabbing minidump binary from tooltool 00:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:36 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 0x248ca90>, '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 0x24def70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24df2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:49:36 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 00:49:36 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 00:49:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:49:36 INFO - Return code: 0 00:49:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:49:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:49:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:49:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:49:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:49:36 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/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 00:49:36 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/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost 00:49:36 INFO - Using env: {'DISPLAY': ':0', 00:49:36 INFO - 'HOME': '/home/cltbld', 00:49:36 INFO - 'LANG': 'en_US.UTF-8', 00:49:36 INFO - 'LANGUAGE': 'en_US:en', 00:49:36 INFO - 'LOGNAME': 'cltbld', 00:49:36 INFO - 'MAIL': '/var/mail/cltbld', 00:49:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:49:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:36 INFO - 'MOZ_NO_REMOTE': '1', 00:49:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:36 INFO - 'NO_EM_RESTART': '1', 00:49:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:36 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:49:36 INFO - 'SHELL': '/bin/bash', 00:49:36 INFO - 'SHLVL': '1', 00:49:36 INFO - 'TERM': 'linux', 00:49:36 INFO - 'TMOUT': '86400', 00:49:36 INFO - 'USER': 'cltbld', 00:49:36 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140', 00:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:36 INFO - '_': '/tools/buildbot/bin/python'} 00:49:36 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/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost'] with output_timeout 3600 00:49:36 INFO - mozversion INFO | application_buildid: 20151123233007 00:49:36 INFO - mozversion INFO | application_changeset: 4dca10306d58d2e87cbed46a72472b62c17b0ec9 00:49:36 INFO - mozversion INFO | application_display_name: Nightly 00:49:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:49:36 INFO - mozversion INFO | application_name: Firefox 00:49:36 INFO - mozversion INFO | application_remotingname: firefox 00:49:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 00:49:36 INFO - mozversion INFO | application_vendor: Mozilla 00:49:36 INFO - mozversion INFO | application_version: 45.0a1 00:49:36 INFO - mozversion INFO | platform_buildid: 20151123233007 00:49:36 INFO - mozversion INFO | platform_changeset: 4dca10306d58d2e87cbed46a72472b62c17b0ec9 00:49:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 00:49:36 INFO - mozversion INFO | platform_version: 45.0a1 00:49:36 INFO - 2015-11-24 00:49:36,551 DEBUG : using testdate: 1448354976 00:49:36 INFO - 2015-11-24 00:49:36,551 DEBUG : actual date: 1448354976 00:49:36 INFO - 2015-11-24 00:49:36,560 INFO : starting webserver on 'localhost:57702' 00:49:36 INFO - 2015-11-24 00:49:36,561 INFO : Starting test suite talos-linux64-ix-057 00:49:36 INFO - 2015-11-24 00:49:36,561 INFO : Starting test dromaeo_css 00:49:36 INFO - 2015-11-24 00:49:36,561 DEBUG : operating with platform_type : linux_ 00:49:36 INFO - 2015-11-24 00:49:36,562 INFO : Initialising browser for dromaeo_css test... 00:49:36 INFO - 2015-11-24 00:49:36,579 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUzAubA/profile http://localhost:57702/getInfo.html 00:49:41 INFO - 2015-11-24 00:49:41,364 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:49:41 INFO - 2015-11-24 00:49:41,364 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:49:41 INFO - 2015-11-24 00:49:41,364 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:49:41 INFO - 2015-11-24 00:49:41,364 DEBUG : BROWSER_OUTPUT: __metrics 00:49:41 INFO - 2015-11-24 00:49:41,465 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:49:42 INFO - 2015-11-24 00:49:42,616 INFO : Browser initialized. 00:49:42 INFO - 2015-11-24 00:49:42,616 INFO : Running cycle 1/1 for dromaeo_css test... 00:49:42 INFO - 2015-11-24 00:49:42,616 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUzAubA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:49:54 INFO - 2015-11-24 00:49:54,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 140378112 00:49:54 INFO - 2015-11-24 00:49:54,381 DEBUG : BROWSER_OUTPUT: 00:50:45 INFO - 2015-11-24 00:50:45,916 DEBUG : BROWSER_OUTPUT: 1448355045911 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] 00:52:54 INFO - 2015-11-24 00:52:54,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57702/tests/dromaeo/cssquery-ext.html) 00:52:55 INFO - 2015-11-24 00:52:55,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 224657408 00:52:55 INFO - 2015-11-24 00:52:55,731 DEBUG : BROWSER_OUTPUT: 00:55:58 INFO - 2015-11-24 00:55:58,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/dromaeo/cssquery-ext.html (next: http://localhost:57702/tests/dromaeo/cssquery-jquery.html) 00:55:58 INFO - 2015-11-24 00:55:58,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 220618752 00:55:58 INFO - 2015-11-24 00:55:58,645 DEBUG : BROWSER_OUTPUT: 00:59:00 INFO - 2015-11-24 00:59:00,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57702/tests/dromaeo/cssquery-mootools.html) 00:59:01 INFO - 2015-11-24 00:59:01,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 215695360 00:59:01 INFO - 2015-11-24 00:59:01,168 DEBUG : BROWSER_OUTPUT: 01:02:03 INFO - 2015-11-24 01:02:03,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57702/tests/dromaeo/cssquery-prototype.html) 01:02:03 INFO - 2015-11-24 01:02:03,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 201388032 01:02:03 INFO - 2015-11-24 01:02:03,682 DEBUG : BROWSER_OUTPUT: 01:05:06 INFO - 2015-11-24 01:05:06,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57702/tests/dromaeo/cssquery-yui.html) 01:05:06 INFO - 2015-11-24 01:05:06,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 204320768 01:05:06 INFO - 2015-11-24 01:05:06,756 DEBUG : BROWSER_OUTPUT: 01:08:09 INFO - 2015-11-24 01:08:09,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/dromaeo/cssquery-yui.html (next: http://localhost:57702/tests/dromaeo/cssquery-dojo.html) 01:08:09 INFO - 2015-11-24 01:08:09,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 266911744 01:08:09 INFO - 2015-11-24 01:08:09,626 DEBUG : BROWSER_OUTPUT: 01:08:09 INFO - 2015-11-24 01:08:09,627 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:08:09 INFO - 2015-11-24 01:08:09,627 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:08:09 INFO - 2015-11-24 01:08:09,628 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:08:09 INFO - 2015-11-24 01:08:09,628 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:08:09 INFO - 2015-11-24 01:08:09,630 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3155.952660710089;3219.0986523773354;3242.7243684286836;3256.1371236622285;3283.671632836716;5216.921746173811;5275.49882761138;5328.733563321833;5343.225232341309;5394.487523685249;5326.840194794153;5353.143497040474;5364;5382.300300960879;5399.163129714891;4923.163062279412;4926.334944782462;4953.4798846121;5015.348004759376;5046.899062018758;4808.374911261549;5028.899422011557;5035.043341765053;5045.268436076767;5099.6685215460875;4817.325574419584;4837.984023355065;4885.8778530536665;4893.119238537062;4926.064047830901;4920.581750551208;4928.8767780805765;4930.161872481651;4940.53064958832;4960.950390496085;4757.14371413149;4920.040592084545;4932;4940.2342636891335;4962.280469331927;5096.235564665293;5171.327727395452;5208;5238.004779091998;5264.184051472028;5873.119032145212;5928.49607783339;5931.911021334683;5939.227900372924;5946;5781.942180578182;5928.347881733006;5963.910541341883;5984.7606095756555;5999.880002399971;5425.891482170374;5449;5491.258680078218;5510.559155267569;5534.916976245359;5918.348981612019;5959.1657167995645;5960.85097872548;5966.701664916824;6013.218281623361;5506.724663766796;5584.497395234448;5737.713114344266;5740.368559458456;5767.106098554731;5726.9713651431475;5813.563982701315;5904.763809447574;5905;5958.791442299499;5741.770329186869;5785.768569257267;5797.043487824546;5798.739056742456;5801.6519008859605;5656.688882111441;5774.94225057744;5776.942230577724;5785.4214578541805;5796.652200867961;4397.714148580332;4467.195904737178;4470.776461176928;4472.508024117409;4505.549445055468;4025.838966441368;4025.8590949317218;4026.57720939303;4037.4953130858644;4074.8166332515107;5419.214213939035;5514.972425137848;5600.215969764236;5601.327840659147;5601.80393686219;5795.275590551181;5838.766449342063;5854.7072646367515;5859.824205273849;5909.202257695242;5488.780448782084;5504.422035686195;5504.944950550524;5507.256520369699;5516.558675305966;4899.995500922302;4912.484189160086;4936.284238785356;5025;5029.5724863386295;6066.939330606638;6146.069703123678;6214.596051256744;6216;6223.844403889939;5942.286925568959;5949.613275137102;5952.851178720393;6007.639541627516;6028.2766068072115;5881.588288819741;5961.105834124743;6094.146819445193;6106.175666284995;6165.0444181152;5831.1836342912875;5890.087036509348;5899.321578018411;5899.528037756883;5902.852428689317;5925.022371308686;6004.909926351195;6010.4891084258325;6011.398860113954;6012.6392416455155;5504.284443022381;5519.917201242065;5562.193481945014;5612.410696876769;5820.854478638068;5709.600327977002;5770.538356931519;5776.740046697824;5782.161586570008;5788.942110579009;5667.489925906688;5684.261046063985;5685.289338832646;5690.77236910519;5697.943020569741;5611.186377975089;5690.260266165537;5715.685637289989;5733.627314224562;5773.769049237983;5625.381208067191;5631.831045068655;5669.064604340238;5716.685582293014;5763.510101641407 01:08:09 INFO - 2015-11-24 01:08:09,633 DEBUG : BROWSER_OUTPUT: |1;ext.html;547.3978623514136;550.2489102375258;553.283497870258;578.6325683191175;585.0405335250188;31130.221744456372;31788.20529486761;31941.284990775814;39870;40923.79538102313;43113.35329970053;43461.34807977883;43509;43573.34639980403;43590;8627.87058194126;8750.124987501262;8784.64861405543;8787.209151176392;8797.208251257385;7646.579438130901;7864.803379915491;10480.31877927936;10686.893131068706;10690.144788416947;10363;10455.268131230818;10459.477026148701;10463.4768261587;10471.633492827752;7718.459707820455;7913.129555748863;10135.543900524493;10208.591656333774;10209.540570674337;10458;10759.51582178796;10762.139028877671;10766.300190487593;10769.62306319275;39717;40096;40113.58750537439;40172.799136004134;40263.7986810067;3434.7252219822353;3438.2951494943477;3626.6735993760426;3660.2862441823854;3936.1340505088833;30140.24649383761;30308;30445;30478.085657430314;31219.84390078035;3689.6679298862964;3767.321882061228;3776.546814382292;3872.1481274119647;3886.7667939923695;264528.9999999981;265238;265553;266222;266313;57686;58673;60142.69928650329;60257.698711506164;60628.39371606227;70449.64775176092;71182.64408677924;71422;71504;71626;13659.180449172884;13808.240546770025;13886.09740366873;13896.027278090436;13904.93047534776;10286.331388459726;10307.690769276935;10419.843702344471;10428.843567346496;10428.895711042944;20095;20286.49283767888;20304.49238769013;20448.897755511127;20472;8223.177682231848;8318.958405208055;8463.280621147149;8474;8482.279006284412;999.7050869993369;1004.6031817432073;1009.2430676992255;1009.6920439266095;1018.981018981019;28798.42403151925;29225;29394.752740994634;29473.557896631566;29703;1057.3708643357345;1063.3779239145033;1070.7002039428971;1080.6271836216492;1153.2676750263643;15071.924640376728;15179.696406072038;15330.156841373831;15740.92129539345;16405.507834764736;293731;298786;299098;299149;300011;53219.73390133025;53619.731901340245;53708.19437708437;53801.73099134479;53808.73095634575;1359.6736783172166;1364.7679894417972;1374.1754947031502;1374.4914381678843;1390.450771945076;28904.85547572333;29532.409351813272;29766;30102.548461772654;30318;45975.77012115052;46375.304370435144;46378.30432543582;46383.76808115938;46414.30378544257;258050;262964;263272;281048;400372;31119;31126.844365778026;31143.377132457677;31403.11581305129;31624.841875790473;42473;43431.34852977271;43465.56534434615;44013;44448.33327500025;36476.45285320775;36498.27003459863;37244.44133337948;37281.62718372782;38040;35813;36708.44937325996;36964.44553331648;37173;37596.24807503889;34038.48942265918;34047.65952340445;34478.82760586181;34485.827570861984;35312.82343588266;30091.398172036876;32348.191295217806;33146.94453727828;33299.334013319116;33711;25534.865293185274;25728.228153155436;25857.612135818355;26010.86994565015;26092.34769130787 01:08:09 INFO - 2015-11-24 01:08:09,633 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.8076681583067;359.95860476045254;360.9350316942951;363.351417719371;365.1400950760958;14154.221517816515;14433;16344.182790860468;16517.339306427744;17031.148442577884;15272.38910443581;15798.526044218663;15812.604684882883;16617;16621.335146594152;5311.814086506973;5446.891062178754;5455.536279416255;5460.645058071233;5466.125419932811;3970.3250447424007;4072.7963601819793;5331.2269720890445;5342.866428339303;5844;5939.227900372945;5964.403559644044;5972.134040564116;5979.52163826895;5989.43100405463;4946.554810067093;5062;5070.61970352225;5075.111855425323;5949.018411962021;4796.064767370364;4868.172410690191;4869.853904382839;4876.390451193601;4955.653104282702;11806.881931180664;11819.409029548488;14152.716945661132;19296.71054934177;19765.60468790616;2063.10255039057;2085.937421877346;2095.4551816527814;2110.5778844231213;2117.8729276243475;9419.340646154771;9482.146606805352;9619.51902404877;10506.947465262701;13314;1807.6565452564103;1874.175362840346;1880.5674694820132;1882.2471011595335;1890.1399863062275;58811;59328.40671593315;59656.40343596552;61024.69487652578;61441;9711.951440242894;10036.390538460053;10112.241581881388;10146.797064058677;10155.39067655943;13311.800322995163;13344.5329413472;13366.33168341579;13382.197068175941;13388.598342049754;6731;6891.517593768388;7011.614361210182;7049;7105.89341159883;6623.503237257225;6630.9336906630315;6677.632730199788;6680.3987641112535;6695.631740254333;3993.9600603994168;4102.733322334038;4350.282203436397;4369.4101296325225;4447.799849006802;1719.6130870554025;1740.895546267228;1742.7298768690873;1785.9464216073538;1836.4307064809684;842.3429724814654;872.4775267158849;904.2268860124631;920.9861852072224;1069.8823129455754;16589.83410165907;16882.324707011827;17200.31198752061;17338.91330543339;17417.82582174162;813.7070654564352;958.736347504428;961.4087336288272;967.6758285974278;975.9804803903883;9120.49837258957;9210.35527513081;9258.768530786649;9356.812863742824;9493.430394176234;337691;346454;349845;353649;365712;72693.63653181806;80153.59923200347;80820.19179808127;81859.5907020473;82999.17000830035;1149.4769879704882;1173.5833779008499;1179.991107602987;1182.92902425853;1185.7391373897728;15406.92296538555;15456.304466299269;15533;15679.216039197767;15917.28372223276;34280.48579271263;34769.13077173091;34811.30377392488;34934.475982860786;36055.63944360523;45718.771406142754;46549.30176047294;46779.766101169276;48366.27450588174;48993.75503122462;8510.404271700922;8936.195742383217;8992.055834137584;9069;9113.681021164228;10555.94722026385;10559.04968552834;10627.734306642396;10672;12410.5656302029;13637.590872273848;13640.863591364356;14188.929055354658;14295.428182872985;14542;13715.382807773474;14010.64973375633;14085.929570352082;14691.779623305445;14891.180985045927;12209.328486933304;12614.936925315682;12892.548760793703;13380.464781408635;15395.384184632489;9461.574229159567;9587.616495340108;9800.41197528122;9890.258230632588;9905.603775848886;13942.302884855513;13947.232902190071;14252.073615214978;14637;14902.77645835335 01:08:09 INFO - 2015-11-24 01:08:09,637 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1585.8414158584135;1697.711389063859;1739.5129363778146;1746.9301227950882;1774.1306759687748;6510;6663.933360666398;6934.895976560356;7057.435405167587;7058.082449281599;7263.309985551377;7324.633768311576;7341.229170937041;7342.8531429371515;7343.339099481059;1939.4181745476371;1977.6440240756658;2195.571863486625;2213.5683541709373;2216.656418255173;2163.459135216196;2195.890205489719;2216.445888527868;2220.7779222077825;2222.8999695013763;2169.5660867826496;2196.02276986741;2220.0897631970897;2220.1896307847683;2223.4107961390246;1940.1172466527767;1968.2323893681405;2130.5845360154776;2182.74898386686;2200.1529411176653;2189.9233526826642;2221.7222847144108;2222.2222222222094;2225.899834507451;2225.9666105008437;7539.886901696479;7608.277213664693;7609.847803043908;7615.80960475987;7625.313721765067;4406.647468202536;4487.259602165639;4506.301523263899;4507.616852567536;4507.819687212507;2935.2368384220044;2998.100569829064;3035.332226910098;3037.665856755755;3056.159556122062;916.2679662813399;926.2173463423396;930.4603330068544;973.445136272325;1004.3371374892608;9767.511624418821;9779.902200978042;9791.314607977445;9801.509924503818;9809.264305177068;4022.155347377025;4100.2619528484565;4123.381492776048;4158.480189976253;4178.895527611834;8436;8451.577421128919;8459.534725590029;8472;8478.74563763088;4583.931241031387;4615.561521655437;4633.4208223972;4634.884127896829;4635.513271106485;4222.303319952173;4225.598568136023;4226.028013556899;4226.957730422718;4227.640650544677;3570.7500474967023;3572.964270357315;3616.72874534411;3643.143861192618;3645.0522864055006;1176.9529218831321;1192.3680449361852;1199.7060720123625;1205.0600531585378;1207.9456424460745;1316.1445060710423;1342.328835582209;1356.504875720355;1357.0297237475252;1370.8286464191976;6543.411093001652;6734.932650673529;6743.5953842769595;7099.858002839915;7100.68046937889;610.5054905526538;627.9120923070774;628.2241431831684;628.434409031875;628.5129025005566;5456.890862182734;5493.285872836505;5501.779928802883;5518.19986102013;5543.722813859372;8630.870536941951;8710.608022638997;8756.4308319959;8803.559822008874;8817.515036672916;8525.957370213233;8694.695685650971;8708.738737837875;8722.171393717586;8727.60725767342;6858.177018757781;7002.439804815603;7007.089078419773;7054.047703559953;7055.435565154878;6613.908705063803;6672.332766723289;6697.598144111369;6708.698108585223;6714.429273511806;7598.278163574451;7848.803779905548;7862.135165131716;7962.522248665098;7969.8406031880195;7680;7765.301122898966;7873.685052598061;7882.408819338458;7889.842203156019;6461.676916154268;6472.255690595642;6572.34276572339;6601.966990165019;6604.471642268703;6889.827754306182;6926.134233220848;6930.306969303029;6932.757353492603;6933.410660093747;6489.059086432535;6556.541042127005;6591.835204119935;6691.832704182434;6733.360330768569;6534.346565343428;6585.5719378240265;6600.306967768507;6619.602823830585;6662.700178492077;6081.239845019372;6116.8776624468155;6760.898586521108;6807.489438292049;6807.965960170365;6047.848803779941;6135.447809697149;6183.783567575113;6183.81448556544;6188.350223226496;6145.692715364304;6342.90485642725;6364.809055728336;6376.52176086786;6407.103005579316 01:08:09 INFO - 2015-11-24 01:08:09,638 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.985690643921;318.99999999999994;320.4696227743086;321.4166288186939;326.5640370105908;5818.098194779805;5894.58737888348;5934.338385252131;5965.642061476315;5973;5726.570507211955;5890.558208134396;5910.46805787479;5914.852128696784;5917.970410147954;4307.332363483665;4386.144701783153;4528.524504926992;4537.61602711173;4539.341795439659;4411.42651455312;4499.6850220484575;4500.347449619803;4504.549545045502;4522.276435770277;4486.641068714495;4490.236659767831;4490.371348011265;4494.123645889053;4500.054988452429;4501.437320334958;4501.572350626701;4501.7524036178;4503.819847206124;4512.616427603658;3864.1937691373973;3930.233604447134;3940.6847452204042;3946.8223929923224;3948.1708841143395;5638.605297629168;5648.181013753024;5653.547716182696;5666.235058267122;5666.575006874501;5220.556252718524;5229.215617657382;5233.267342572043;5234.136367499358;5237.214417837355;5936.97031514844;6065.939340606582;6085.908711369333;6234.688265586748;6246.562740608159;4298;4334.046509767846;4334.869953901388;4339.153864996327;4341.240282950471;6524.804255872332;6526.216853977506;6530.183727034121;6530.314316996694;6533.314002029813;4420.093880754438;4435.112977404532;4436.489803672554;4437.667174961891;4439;4245.57544245573;4391.297392417198;4392.472903251631;4393.626541743987;4406.317020861771;5143.691378517301;5148.4079330876675;5149.588032957355;5154.92267615986;5155.200943853709;6259.655718935503;6297.055441683692;6302.590331628429;6308.211473565804;6309.08518264849;1519.8100237470317;1551.8525740054677;1552.0842702805398;1552.8447155284382;1555.3389809331215;1010.8837483689323;1012.5797793915442;1032.0402026115785;1035.0167341025906;1040.1314902056715;6006.909896351558;6044.727987240497;6046;6053.606515576562;6069.544784141207;6406.583572067801;6414.775482858077;6415.166028416369;6418.839529011812;6431.485481161496;6060.818175454743;6068.9696551517845;6071.969640151771;6072.997955337408;6073.75704971805;3386.9661303387143;3461.8269086546075;3462.9480557791653;3469.6530346965606;3471.392506311436;6636.6726654669255;6637.303083176197;6648.368405001517;6673.666316684146;6687.331266873371;6571.0471981562405;6575.243846957565;6576.539642224999;6582.045603387482;6582.506312026617;6470.1588793457495;6626.602403855784;6631;6640.0703901453835;6645;6299.937000630119;6369.681515924278;6424.582402143846;6529.8694026120165;6530.8040758777315;6424.357564243725;6442.48601578638;6449.5485316027425;6450.161479007699;6485.967570162119;6672.232693240339;6772.627505487246;6777.491688123312;6782.0505129280955;6796.048553202457;4352.804123814372;4365.781710914505;4371.235033869124;4373.912521749611;4375.671824613103;6529.640869752209;6529.7388104475285;6534.673266336569;6538.346165383424;6542.803715888531;6342.460890824332;6350.174477317919;6351.523635727432;6354.586951848115;6354.682265886595;6200.286966998853;6285.59143655661;6328.683565821782;6342.52431067681;6361.459275961595;6214.316425193135;6224.2842073160355;6239.0953311770445;6252.687365631609;6255.56211065221;6381.8085457436355;6382.32985536512;6391.456726178327;6392.0731493934045;6399.104125422352;6118.785842495491;6207.348228435949;6222.844428889314;6224.564280500503;6226.12834203221 01:08:09 INFO - 2015-11-24 01:08:09,640 DEBUG : BROWSER_OUTPUT: |5;yui.html;797.9601019949002;856.507508182795;876.7413612984169;890.8708039142825;891.6745387933404;13845.515406960758;14033.649158771035;14062.929685351559;14081.943854210924;14103.365348559339;13082.738345233114;13355.866441335607;13370.398332075056;13371.39828707708;13373.531926382579;682.1950098883316;695.5722230828055;697.7627606613751;697.8918267668494;824.6206744897324;840.1052878684181;848.7411339541437;848.7411339541437;849.362977766675;849.9830003399928;851.4465597361733;865.8138500222451;866.1511718515858;866.1554983890719;866.3718803867177;709.7622296530643;718.2996578336133;854.8546747052985;855.5166331022953;867.5141920524527;634.2009068573584;638.7093872288098;639.284001917855;639.7536948274901;639.936006399361;13432.261225632587;13879.58361249154;13892.861071389258;13898.16611003343;13931.094478858942;12075.45660445282;12612.68468288291;12690.682732931658;13125.146865453811;13198.340082995812;10592.311499752492;10670.946645266802;10787.352758834495;10800.135989120852;10821.567137314498;3607.801570913599;3607.8196090195383;3625.9274814503824;3694.8891533254045;3773.1699026214187;47180.292295615596;47283.52716472826;47562;47638;48205.27692084621;10187.745306367251;10428.323891705078;10474.319169253975;10646.946765266279;10780.40707761065;19394.224231030883;19405.90297048534;19432.12555435009;19463.513412164524;19465.610687786164;7629.656665450068;7790.649420776079;7974.641141148662;8002.239787220321;8072.83854322922;4394.252976993918;4398.648108151404;4427.734335939854;4462.062966777014;4486.618637415856;3038.2860027893425;3061.479548476764;3061.4948533491724;3066.340736741611;3072.1551573317515;548.5227851768987;559.0176408858784;562.9915551266735;571.0520535910451;575.0827430248746;651.7979426377838;664.9734010639617;702.7118881258762;705.9258777828356;708.6031822179596;8319.792005199919;8416.747497575083;8537.146285371413;8713.825723485495;8866.73399798007;605.5034871405493;627.8995360742259;665.7505568591689;686.5160062156168;687.8589889072728;3890.533136023695;4003.6997225208224;4060.715749897479;4093.263212621757;4228.133232687292;57049;58675;58769.70615146897;58824;59149.70425147847;48785;50908;51189;52469.7376513115;53013.734931325096;43884.341734874004;44119.55880441154;44678.10643787171;44763.77618111954;48669;7970.442069055111;8137.59312034384;8402.621882015203;8436.746897593082;8581.65673373058;33678.158046049044;33742.49386259257;34558.308833823685;36166.27667446584;36313;44580;45344;45373.31940020836;45588.7720561395;45990;10859.674209773719;10909.290896091728;10971.890281097087;11307.151963602599;11360.886391136313;11680.532778688757;11860.347680877634;11992;12574.937125314314;12679.429425675682;11093.112550996062;11238.15713821483;11304;11625.18623696333;11676.532938682358;11709.355985420883;11902.404879755804;12071.818922715991;12442.066844986843;12484.500619975099;11174;11431.828522572001;11439.542418303176;11500;11785.88214117848;9459.621615135318;9590.184834289164;9684;9934.701958941243;10021.649242276486;8999.370044097112;9235.907640923504;9703.9029609703;9749.463779492196;9753.730197639732 01:08:09 INFO - 2015-11-24 01:08:09,640 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:08:09 INFO - 2015-11-24 01:08:09,640 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:08:09 INFO - 2015-11-24 01:08:09,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,974 01:08:09 INFO - 2015-11-24 01:08:09,640 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:08:09 INFO - 2015-11-24 01:08:09,640 DEBUG : BROWSER_OUTPUT: __startTimestamp1448356089626__endTimestamp 01:08:09 INFO - 2015-11-24 01:08:09,641 DEBUG : BROWSER_OUTPUT: 01:08:09 INFO - 2015-11-24 01:08:09,641 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:08:09 INFO - 2015-11-24 01:08:09,641 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:08:09 INFO - 2015-11-24 01:08:09,641 DEBUG : BROWSER_OUTPUT: 01:08:09 INFO - 2015-11-24 01:08:09,641 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5425.44 Median:5625.38 stddev:626.72 (11.1%) stddev-sans-first:602.82 01:08:09 INFO - 2015-11-24 01:08:09,642 DEBUG : BROWSER_OUTPUT: Values: 3156.0 3219.1 3242.7 3256.1 3283.7 5216.9 5275.5 5328.7 5343.2 5394.5 5326.8 5353.1 5364.0 5382.3 5399.2 4923.2 4926.3 4953.5 5015.3 5046.9 4808.4 5028.9 5035.0 5045.3 5099.7 4817.3 4838.0 4885.9 4893.1 4926.1 4920.6 4928.9 4930.2 4940.5 4961.0 4757.1 4920.0 4932.0 4940.2 4962.3 5096.2 5171.3 5208.0 5238.0 5264.2 5873.1 5928.5 5931.9 5939.2 5946.0 5781.9 5928.3 5963.9 5984.8 5999.9 5425.9 5449.0 5491.3 5510.6 5534.9 5918.3 5959.2 5960.9 5966.7 6013.2 5506.7 5584.5 5737.7 5740.4 5767.1 5727.0 5813.6 5904.8 5905.0 5958.8 5741.8 5785.8 5797.0 5798.7 5801.7 5656.7 5774.9 5776.9 5785.4 5796.7 4397.7 4467.2 4470.8 4472.5 4505.5 4025.8 4025.9 4026.6 4037.5 4074.8 5419.2 5515.0 5600.2 5601.3 5601.8 5795.3 5838.8 5854.7 5859.8 5909.2 5488.8 5504.4 5504.9 5507.3 5516.6 4900.0 4912.5 4936.3 5025.0 5029.6 6066.9 6146.1 6214.6 6216.0 6223.8 5942.3 5949.6 5952.9 6007.6 6028.3 5881.6 5961.1 6094.1 6106.2 6165.0 5831.2 5890.1 5899.3 5899.5 5902.9 5925.0 6004.9 6010.5 6011.4 6012.6 5504.3 5519.9 5562.2 5612.4 5820.9 5709.6 5770.5 5776.7 5782.2 5788.9 5667.5 5684.3 5685.3 5690.8 5697.9 5611.2 5690.3 5715.7 5733.6 5773.8 5625.4 5631.8 5669.1 5716.7 5763.5 01:08:09 INFO - 2015-11-24 01:08:09,643 DEBUG : BROWSER_OUTPUT: 01:08:09 INFO - 2015-11-24 01:08:09,643 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46274.90 Median:31706.52 stddev:75177.16 (237.1%) stddev-sans-first:75309.65 01:08:09 INFO - 2015-11-24 01:08:09,644 DEBUG : BROWSER_OUTPUT: Values: 547.4 550.2 553.3 578.6 585.0 31130.2 31788.2 31941.3 39870.0 40923.8 43113.4 43461.3 43509.0 43573.3 43590.0 8627.9 8750.1 8784.6 8787.2 8797.2 7646.6 7864.8 10480.3 10686.9 10690.1 10363.0 10455.3 10459.5 10463.5 10471.6 7718.5 7913.1 10135.5 10208.6 10209.5 10458.0 10759.5 10762.1 10766.3 10769.6 39717.0 40096.0 40113.6 40172.8 40263.8 3434.7 3438.3 3626.7 3660.3 3936.1 30140.2 30308.0 30445.0 30478.1 31219.8 3689.7 3767.3 3776.5 3872.1 3886.8 264529.0 265238.0 265553.0 266222.0 266313.0 57686.0 58673.0 60142.7 60257.7 60628.4 70449.6 71182.6 71422.0 71504.0 71626.0 13659.2 13808.2 13886.1 13896.0 13904.9 10286.3 10307.7 10419.8 10428.8 10428.9 20095.0 20286.5 20304.5 20448.9 20472.0 8223.2 8319.0 8463.3 8474.0 8482.3 999.7 1004.6 1009.2 1009.7 1019.0 28798.4 29225.0 29394.8 29473.6 29703.0 1057.4 1063.4 1070.7 1080.6 1153.3 15071.9 15179.7 15330.2 15740.9 16405.5 293731.0 298786.0 299098.0 299149.0 300011.0 53219.7 53619.7 53708.2 53801.7 53808.7 1359.7 1364.8 1374.2 1374.5 1390.5 28904.9 29532.4 29766.0 30102.5 30318.0 45975.8 46375.3 46378.3 46383.8 46414.3 258050.0 262964.0 263272.0 281048.0 400372.0 31119.0 31126.8 31143.4 31403.1 31624.8 42473.0 43431.3 43465.6 44013.0 44448.3 36476.5 36498.3 37244.4 37281.6 38040.0 35813.0 36708.4 36964.4 37173.0 37596.2 34038.5 34047.7 34478.8 34485.8 35312.8 30091.4 32348.2 33146.9 33299.3 33711.0 25534.9 25728.2 25857.6 26010.9 26092.3 01:08:09 INFO - 2015-11-24 01:08:09,644 DEBUG : BROWSER_OUTPUT: 01:08:09 INFO - 2015-11-24 01:08:09,644 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23183.00 Median:177004.48 stddev:57956.88 (32.7%) stddev-sans-first:58094.12 01:08:09 INFO - 2015-11-24 01:08:09,645 DEBUG : BROWSER_OUTPUT: Values: 353.8 360.0 360.9 363.4 365.1 14154.2 14433.0 16344.2 16517.3 17031.1 15272.4 15798.5 15812.6 16617.0 16621.3 5311.8 5446.9 5455.5 5460.6 5466.1 3970.3 4072.8 5331.2 5342.9 5844.0 5939.2 5964.4 5972.1 5979.5 5989.4 4946.6 5062.0 5070.6 5075.1 5949.0 4796.1 4868.2 4869.9 4876.4 4955.7 11806.9 11819.4 14152.7 19296.7 19765.6 2063.1 2085.9 2095.5 2110.6 2117.9 9419.3 9482.1 9619.5 10506.9 13314.0 1807.7 1874.2 1880.6 1882.2 1890.1 58811.0 59328.4 59656.4 61024.7 61441.0 9712.0 10036.4 10112.2 10146.8 10155.4 13311.8 13344.5 13366.3 13382.2 13388.6 6731.0 6891.5 7011.6 7049.0 7105.9 6623.5 6630.9 6677.6 6680.4 6695.6 3994.0 4102.7 4350.3 4369.4 4447.8 1719.6 1740.9 1742.7 1785.9 1836.4 842.3 872.5 904.2 921.0 1069.9 16589.8 16882.3 17200.3 17338.9 17417.8 813.7 958.7 961.4 967.7 976.0 9120.5 9210.4 9258.8 9356.8 9493.4 337691.0 346454.0 349845.0 353649.0 365712.0 72693.6 80153.6 80820.2 81859.6 82999.2 1149.5 1173.6 1180.0 1182.9 1185.7 15406.9 15456.3 15533.0 15679.2 15917.3 34280.5 34769.1 34811.3 34934.5 36055.6 45718.8 46549.3 46779.8 48366.3 48993.8 8510.4 8936.2 8992.1 9069.0 9113.7 10555.9 10559.0 10627.7 10672.0 12410.6 13637.6 13640.9 14188.9 14295.4 14542.0 13715.4 14010.6 14085.9 14691.8 14891.2 12209.3 12614.9 12892.5 13380.5 15395.4 9461.6 9587.6 9800.4 9890.3 9905.6 13942.3 13947.2 14252.1 14637.0 14902.8 01:08:09 INFO - 2015-11-24 01:08:09,645 DEBUG : BROWSER_OUTPUT: 01:08:09 INFO - 2015-11-24 01:08:09,645 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5153.13 Median:6370.67 stddev:2603.68 (40.9%) stddev-sans-first:2597.18 01:08:09 INFO - 2015-11-24 01:08:09,646 DEBUG : BROWSER_OUTPUT: Values: 1585.8 1697.7 1739.5 1746.9 1774.1 6510.0 6663.9 6934.9 7057.4 7058.1 7263.3 7324.6 7341.2 7342.9 7343.3 1939.4 1977.6 2195.6 2213.6 2216.7 2163.5 2195.9 2216.4 2220.8 2222.9 2169.6 2196.0 2220.1 2220.2 2223.4 1940.1 1968.2 2130.6 2182.7 2200.2 2189.9 2221.7 2222.2 2225.9 2226.0 7539.9 7608.3 7609.8 7615.8 7625.3 4406.6 4487.3 4506.3 4507.6 4507.8 2935.2 2998.1 3035.3 3037.7 3056.2 916.3 926.2 930.5 973.4 1004.3 9767.5 9779.9 9791.3 9801.5 9809.3 4022.2 4100.3 4123.4 4158.5 4178.9 8436.0 8451.6 8459.5 8472.0 8478.7 4583.9 4615.6 4633.4 4634.9 4635.5 4222.3 4225.6 4226.0 4227.0 4227.6 3570.8 3573.0 3616.7 3643.1 3645.1 1177.0 1192.4 1199.7 1205.1 1207.9 1316.1 1342.3 1356.5 1357.0 1370.8 6543.4 6734.9 6743.6 7099.9 7100.7 610.5 627.9 628.2 628.4 628.5 5456.9 5493.3 5501.8 5518.2 5543.7 8630.9 8710.6 8756.4 8803.6 8817.5 8526.0 8694.7 8708.7 8722.2 8727.6 6858.2 7002.4 7007.1 7054.0 7055.4 6613.9 6672.3 6697.6 6708.7 6714.4 7598.3 7848.8 7862.1 7962.5 7969.8 7680.0 7765.3 7873.7 7882.4 7889.8 6461.7 6472.3 6572.3 6602.0 6604.5 6889.8 6926.1 6930.3 6932.8 6933.4 6489.1 6556.5 6591.8 6691.8 6733.4 6534.3 6585.6 6600.3 6619.6 6662.7 6081.2 6116.9 6760.9 6807.5 6808.0 6047.8 6135.4 6183.8 6183.8 6188.4 6145.7 6342.9 6364.8 6376.5 6407.1 01:08:09 INFO - 2015-11-24 01:08:09,646 DEBUG : BROWSER_OUTPUT: 01:08:09 INFO - 2015-11-24 01:08:09,647 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5236.11 Median:5989.95 stddev:1596.85 (26.7%) stddev-sans-first:1558.08 01:08:09 INFO - 2015-11-24 01:08:09,648 DEBUG : BROWSER_OUTPUT: Values: 318.0 319.0 320.5 321.4 326.6 5818.1 5894.6 5934.3 5965.6 5973.0 5726.6 5890.6 5910.5 5914.9 5918.0 4307.3 4386.1 4528.5 4537.6 4539.3 4411.4 4499.7 4500.3 4504.5 4522.3 4486.6 4490.2 4490.4 4494.1 4500.1 4501.4 4501.6 4501.8 4503.8 4512.6 3864.2 3930.2 3940.7 3946.8 3948.2 5638.6 5648.2 5653.5 5666.2 5666.6 5220.6 5229.2 5233.3 5234.1 5237.2 5937.0 6065.9 6085.9 6234.7 6246.6 4298.0 4334.0 4334.9 4339.2 4341.2 6524.8 6526.2 6530.2 6530.3 6533.3 4420.1 4435.1 4436.5 4437.7 4439.0 4245.6 4391.3 4392.5 4393.6 4406.3 5143.7 5148.4 5149.6 5154.9 5155.2 6259.7 6297.1 6302.6 6308.2 6309.1 1519.8 1551.9 1552.1 1552.8 1555.3 1010.9 1012.6 1032.0 1035.0 1040.1 6006.9 6044.7 6046.0 6053.6 6069.5 6406.6 6414.8 6415.2 6418.8 6431.5 6060.8 6069.0 6072.0 6073.0 6073.8 3387.0 3461.8 3462.9 3469.7 3471.4 6636.7 6637.3 6648.4 6673.7 6687.3 6571.0 6575.2 6576.5 6582.0 6582.5 6470.2 6626.6 6631.0 6640.1 6645.0 6299.9 6369.7 6424.6 6529.9 6530.8 6424.4 6442.5 6449.5 6450.2 6486.0 6672.2 6772.6 6777.5 6782.1 6796.0 4352.8 4365.8 4371.2 4373.9 4375.7 6529.6 6529.7 6534.7 6538.3 6542.8 6342.5 6350.2 6351.5 6354.6 6354.7 6200.3 6285.6 6328.7 6342.5 6361.5 6214.3 6224.3 6239.1 6252.7 6255.6 6381.8 6382.3 6391.5 6392.1 6399.1 6118.8 6207.3 6222.8 6224.6 6226.1 01:08:09 INFO - 2015-11-24 01:08:09,648 DEBUG : BROWSER_OUTPUT: 01:08:09 INFO - 2015-11-24 01:08:09,648 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13929.01 Median:24915.31 stddev:15961.79 (64.1%) stddev-sans-first:15976.11 01:08:09 INFO - 2015-11-24 01:08:09,650 DEBUG : BROWSER_OUTPUT: Values: 798.0 856.5 876.7 890.9 891.7 13845.5 14033.6 14062.9 14081.9 14103.4 13082.7 13355.9 13370.4 13371.4 13373.5 682.2 695.6 697.8 697.9 824.6 840.1 848.7 848.7 849.4 850.0 851.4 865.8 866.2 866.2 866.4 709.8 718.3 854.9 855.5 867.5 634.2 638.7 639.3 639.8 639.9 13432.3 13879.6 13892.9 13898.2 13931.1 12075.5 12612.7 12690.7 13125.1 13198.3 10592.3 10670.9 10787.4 10800.1 10821.6 3607.8 3607.8 3625.9 3694.9 3773.2 47180.3 47283.5 47562.0 47638.0 48205.3 10187.7 10428.3 10474.3 10646.9 10780.4 19394.2 19405.9 19432.1 19463.5 19465.6 7629.7 7790.6 7974.6 8002.2 8072.8 4394.3 4398.6 4427.7 4462.1 4486.6 3038.3 3061.5 3061.5 3066.3 3072.2 548.5 559.0 563.0 571.1 575.1 651.8 665.0 702.7 705.9 708.6 8319.8 8416.7 8537.1 8713.8 8866.7 605.5 627.9 665.8 686.5 687.9 3890.5 4003.7 4060.7 4093.3 4228.1 57049.0 58675.0 58769.7 58824.0 59149.7 48785.0 50908.0 51189.0 52469.7 53013.7 43884.3 44119.6 44678.1 44763.8 48669.0 7970.4 8137.6 8402.6 8436.7 8581.7 33678.2 33742.5 34558.3 36166.3 36313.0 44580.0 45344.0 45373.3 45588.8 45990.0 10859.7 10909.3 10971.9 11307.2 11360.9 11680.5 11860.3 11992.0 12574.9 12679.4 11093.1 11238.2 11304.0 11625.2 11676.5 11709.4 11902.4 12071.8 12442.1 12484.5 11174.0 11431.8 11439.5 11500.0 11785.9 9459.6 9590.2 9684.0 9934.7 10021.6 8999.4 9235.9 9703.9 9749.5 9753.7 01:08:09 INFO - 2015-11-24 01:08:09,650 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:08:09 INFO - 2015-11-24 01:08:09,650 DEBUG : BROWSER_OUTPUT: 01:08:10 INFO - 2015-11-24 01:08:10,295 INFO : Browser exited with error code: 0 01:08:10 INFO - 2015-11-24 01:08:10,314 INFO : Completed test dromaeo_css (00:18:33) 01:08:10 INFO - 2015-11-24 01:08:10,314 INFO : Starting test kraken 01:08:10 INFO - 2015-11-24 01:08:10,314 DEBUG : operating with platform_type : linux_ 01:08:10 INFO - 2015-11-24 01:08:10,314 INFO : Initialising browser for kraken test... 01:08:10 INFO - 2015-11-24 01:08:10,321 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaaDidl/profile http://localhost:57702/getInfo.html 01:08:13 INFO - 2015-11-24 01:08:13,997 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:08:13 INFO - 2015-11-24 01:08:13,997 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:08:13 INFO - 2015-11-24 01:08:13,997 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:08:13 INFO - 2015-11-24 01:08:13,997 DEBUG : BROWSER_OUTPUT: __metrics 01:08:14 INFO - 2015-11-24 01:08:14,155 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:08:15 INFO - 2015-11-24 01:08:15,291 INFO : Browser initialized. 01:08:15 INFO - 2015-11-24 01:08:15,292 INFO : Running cycle 1/1 for kraken test... 01:08:15 INFO - 2015-11-24 01:08:15,292 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaaDidl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:08:27 INFO - 2015-11-24 01:08:27,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 140304384 01:08:27 INFO - 2015-11-24 01:08:27,051 DEBUG : BROWSER_OUTPUT: 01:08:29 INFO - 2015-11-24 01:08:29,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57702/tests/kraken/driver.html?testName=audio-beat-detection) 01:08:30 INFO - 2015-11-24 01:08:30,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 178368512 01:08:30 INFO - 2015-11-24 01:08:30,088 DEBUG : BROWSER_OUTPUT: 01:08:32 INFO - 2015-11-24 01:08:32,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57702/tests/kraken/driver.html?testName=audio-dft) 01:08:33 INFO - 2015-11-24 01:08:33,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 165756928 01:08:33 INFO - 2015-11-24 01:08:33,258 DEBUG : BROWSER_OUTPUT: 01:08:36 INFO - 2015-11-24 01:08:36,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57702/tests/kraken/driver.html?testName=audio-fft) 01:08:36 INFO - 2015-11-24 01:08:36,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 152707072 01:08:36 INFO - 2015-11-24 01:08:36,683 DEBUG : BROWSER_OUTPUT: 01:08:38 INFO - 2015-11-24 01:08:38,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57702/tests/kraken/driver.html?testName=audio-oscillator) 01:08:39 INFO - 2015-11-24 01:08:39,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 154308608 01:08:39 INFO - 2015-11-24 01:08:39,216 DEBUG : BROWSER_OUTPUT: 01:08:41 INFO - 2015-11-24 01:08:41,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57702/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:08:41 INFO - 2015-11-24 01:08:41,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 156667904 01:08:41 INFO - 2015-11-24 01:08:41,982 DEBUG : BROWSER_OUTPUT: 01:08:44 INFO - 2015-11-24 01:08:44,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57702/tests/kraken/driver.html?testName=imaging-darkroom) 01:08:45 INFO - 2015-11-24 01:08:45,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 156987392 01:08:45 INFO - 2015-11-24 01:08:45,437 DEBUG : BROWSER_OUTPUT: 01:08:48 INFO - 2015-11-24 01:08:48,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57702/tests/kraken/driver.html?testName=imaging-desaturate) 01:08:49 INFO - 2015-11-24 01:08:49,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 158638080 01:08:49 INFO - 2015-11-24 01:08:49,377 DEBUG : BROWSER_OUTPUT: 01:08:52 INFO - 2015-11-24 01:08:52,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57702/tests/kraken/driver.html?testName=json-parse-financial) 01:08:52 INFO - 2015-11-24 01:08:52,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 156041216 01:08:52 INFO - 2015-11-24 01:08:52,687 DEBUG : BROWSER_OUTPUT: 01:08:54 INFO - 2015-11-24 01:08:54,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57702/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:08:54 INFO - 2015-11-24 01:08:54,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 167124992 01:08:54 INFO - 2015-11-24 01:08:54,819 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-24 01:08:56,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57702/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:08:57 INFO - 2015-11-24 01:08:57,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 166141952 01:08:57 INFO - 2015-11-24 01:08:57,216 DEBUG : BROWSER_OUTPUT: 01:08:59 INFO - 2015-11-24 01:08:59,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57702/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:08:59 INFO - 2015-11-24 01:08:59,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 175030272 01:08:59 INFO - 2015-11-24 01:08:59,817 DEBUG : BROWSER_OUTPUT: 01:09:02 INFO - 2015-11-24 01:09:02,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:09:02 INFO - 2015-11-24 01:09:02,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 183308288 01:09:02 INFO - 2015-11-24 01:09:02,764 DEBUG : BROWSER_OUTPUT: 01:09:05 INFO - 2015-11-24 01:09:05,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:09:05 INFO - 2015-11-24 01:09:05,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 182030336 01:09:05 INFO - 2015-11-24 01:09:05,861 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57702/tests/kraken/driver.html?testName=ai-astar) 01:09:07 INFO - 2015-11-24 01:09:07,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 240963584 01:09:07 INFO - 2015-11-24 01:09:07,764 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,764 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:09:07 INFO - 2015-11-24 01:09:07,765 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:09:07 INFO - 2015-11-24 01:09:07,765 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:09:07 INFO - 2015-11-24 01:09:07,765 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:09:07 INFO - 2015-11-24 01:09:07,765 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;110;102;109;111;110;99;109;111;102 01:09:07 INFO - 2015-11-24 01:09:07,765 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;123;153;163;125;155;148;129;169;125 01:09:07 INFO - 2015-11-24 01:09:07,765 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;162;160;163;159;160;160;159;163 01:09:07 INFO - 2015-11-24 01:09:07,767 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;85;96;72;71;72;94;95;71 01:09:07 INFO - 2015-11-24 01:09:07,767 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;95;140;93;95;94;133;95;94;141 01:09:07 INFO - 2015-11-24 01:09:07,767 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;110;110;110;110;109 01:09:07 INFO - 2015-11-24 01:09:07,767 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;145;146;145;146;146;147;145 01:09:07 INFO - 2015-11-24 01:09:07,767 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;96;95;95;96;96;95 01:09:07 INFO - 2015-11-24 01:09:07,767 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;58;58;59;59;57;59;59;57 01:09:07 INFO - 2015-11-24 01:09:07,768 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;68;68;69;74;69;69;70 01:09:07 INFO - 2015-11-24 01:09:07,768 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;84;84;84;93;84;84;86;84 01:09:07 INFO - 2015-11-24 01:09:07,768 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;115;126;115;115;116;123;116;118;119 01:09:07 INFO - 2015-11-24 01:09:07,768 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;152;146;146;146;137;149;148;149;136 01:09:07 INFO - 2015-11-24 01:09:07,768 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;66;67;66;67;69;66;67;67 01:09:07 INFO - 2015-11-24 01:09:07,768 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:09:07 INFO - 2015-11-24 01:09:07,768 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:09:07 INFO - 2015-11-24 01:09:07,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,937 01:09:07 INFO - 2015-11-24 01:09:07,769 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:09:07 INFO - 2015-11-24 01:09:07,769 DEBUG : BROWSER_OUTPUT: __startTimestamp1448356147764__endTimestamp 01:09:07 INFO - 2015-11-24 01:09:07,769 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,772 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:09:07 INFO - 2015-11-24 01:09:07,772 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:09:07 INFO - 2015-11-24 01:09:07,773 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,773 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:110.50 stddev:4.55 (4.1%) stddev-sans-first:4.64 01:09:07 INFO - 2015-11-24 01:09:07,773 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 102.0 109.0 111.0 110.0 99.0 109.0 111.0 102.0 01:09:07 INFO - 2015-11-24 01:09:07,773 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,773 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.30 Median:153.00 stddev:17.23 (11.3%) stddev-sans-first:17.99 01:09:07 INFO - 2015-11-24 01:09:07,774 DEBUG : BROWSER_OUTPUT: Values: 153.0 123.0 153.0 163.0 125.0 155.0 148.0 129.0 169.0 125.0 01:09:07 INFO - 2015-11-24 01:09:07,774 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,774 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.52 (0.9%) stddev-sans-first:1.56 01:09:07 INFO - 2015-11-24 01:09:07,774 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 162.0 160.0 163.0 159.0 160.0 160.0 159.0 163.0 01:09:07 INFO - 2015-11-24 01:09:07,774 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,774 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.70 Median:78.50 stddev:11.41 (14.5%) stddev-sans-first:11.55 01:09:07 INFO - 2015-11-24 01:09:07,775 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 85.0 96.0 72.0 71.0 72.0 94.0 95.0 71.0 01:09:07 INFO - 2015-11-24 01:09:07,775 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,775 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.00 stddev:21.30 (22.7%) stddev-sans-first:21.95 01:09:07 INFO - 2015-11-24 01:09:07,775 DEBUG : BROWSER_OUTPUT: Values: 93.0 95.0 140.0 93.0 95.0 94.0 133.0 95.0 94.0 141.0 01:09:07 INFO - 2015-11-24 01:09:07,775 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,775 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:09:07 INFO - 2015-11-24 01:09:07,775 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 01:09:07 INFO - 2015-11-24 01:09:07,775 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,775 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 01:09:07 INFO - 2015-11-24 01:09:07,775 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 145.0 146.0 145.0 146.0 146.0 147.0 145.0 01:09:07 INFO - 2015-11-24 01:09:07,775 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,776 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:09:07 INFO - 2015-11-24 01:09:07,776 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 01:09:07 INFO - 2015-11-24 01:09:07,776 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,776 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.50 stddev:0.88 (1.5%) stddev-sans-first:0.93 01:09:07 INFO - 2015-11-24 01:09:07,776 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 58.0 58.0 59.0 59.0 57.0 59.0 59.0 57.0 01:09:07 INFO - 2015-11-24 01:09:07,776 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,776 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:1.71 (2.5%) stddev-sans-first:1.81 01:09:07 INFO - 2015-11-24 01:09:07,776 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 68.0 68.0 69.0 74.0 69.0 69.0 70.0 01:09:07 INFO - 2015-11-24 01:09:07,776 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,777 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:2.91 (3.5%) stddev-sans-first:3.06 01:09:07 INFO - 2015-11-24 01:09:07,778 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 84.0 84.0 84.0 93.0 84.0 84.0 86.0 84.0 01:09:07 INFO - 2015-11-24 01:09:07,778 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,778 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:117.00 stddev:3.78 (3.2%) stddev-sans-first:3.95 01:09:07 INFO - 2015-11-24 01:09:07,778 DEBUG : BROWSER_OUTPUT: Values: 116.0 115.0 126.0 115.0 115.0 116.0 123.0 116.0 118.0 119.0 01:09:07 INFO - 2015-11-24 01:09:07,778 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,778 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:147.00 stddev:5.18 (3.5%) stddev-sans-first:5.43 01:09:07 INFO - 2015-11-24 01:09:07,778 DEBUG : BROWSER_OUTPUT: Values: 143.0 152.0 146.0 146.0 146.0 137.0 149.0 148.0 149.0 136.0 01:09:07 INFO - 2015-11-24 01:09:07,778 DEBUG : BROWSER_OUTPUT: 01:09:07 INFO - 2015-11-24 01:09:07,778 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 01:09:07 INFO - 2015-11-24 01:09:07,778 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 66.0 67.0 66.0 67.0 69.0 66.0 67.0 67.0 01:09:07 INFO - 2015-11-24 01:09:07,778 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:09:07 INFO - 2015-11-24 01:09:07,778 DEBUG : BROWSER_OUTPUT: 01:09:08 INFO - 2015-11-24 01:09:08,619 INFO : Browser exited with error code: 0 01:09:08 INFO - 2015-11-24 01:09:08,674 INFO : Completed test kraken (00:00:58) 01:09:08 INFO - 2015-11-24 01:09:08,675 INFO : Starting test v8_7 01:09:08 INFO - 2015-11-24 01:09:08,675 DEBUG : operating with platform_type : linux_ 01:09:08 INFO - 2015-11-24 01:09:08,675 INFO : Initialising browser for v8_7 test... 01:09:08 INFO - 2015-11-24 01:09:08,681 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl3Gqmo/profile http://localhost:57702/getInfo.html 01:09:12 INFO - 2015-11-24 01:09:12,378 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:09:12 INFO - 2015-11-24 01:09:12,378 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:09:12 INFO - 2015-11-24 01:09:12,378 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:09:12 INFO - 2015-11-24 01:09:12,378 DEBUG : BROWSER_OUTPUT: __metrics 01:09:12 INFO - 2015-11-24 01:09:12,520 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:09:13 INFO - 2015-11-24 01:09:13,652 INFO : Browser initialized. 01:09:13 INFO - 2015-11-24 01:09:13,652 INFO : Running cycle 1/1 for v8_7 test... 01:09:13 INFO - 2015-11-24 01:09:13,652 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl3Gqmo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:09:25 INFO - 2015-11-24 01:09:25,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 140423168 01:09:25 INFO - 2015-11-24 01:09:25,437 DEBUG : BROWSER_OUTPUT: 01:09:46 INFO - 2015-11-24 01:09:46,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57702/tests/v8_7/run.html (next: http://localhost:57702/tests/v8_7/run.html) 01:09:47 INFO - 2015-11-24 01:09:47,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 621494272 01:09:47 INFO - 2015-11-24 01:09:47,179 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-24 01:09:47,179 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:09:47 INFO - 2015-11-24 01:09:47,180 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:09:47 INFO - 2015-11-24 01:09:47,180 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:09:47 INFO - 2015-11-24 01:09:47,180 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:09:47 INFO - 2015-11-24 01:09:47,180 DEBUG : BROWSER_OUTPUT: |0;Richards;189.75332068311195 01:09:47 INFO - 2015-11-24 01:09:47,180 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.1747572815534 01:09:47 INFO - 2015-11-24 01:09:47,180 DEBUG : BROWSER_OUTPUT: |2;Encrypt;289.2681515765114 01:09:47 INFO - 2015-11-24 01:09:47,181 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4995.024875621891 01:09:47 INFO - 2015-11-24 01:09:47,181 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1962.7450980392157 01:09:47 INFO - 2015-11-24 01:09:47,181 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 01:09:47 INFO - 2015-11-24 01:09:47,181 DEBUG : BROWSER_OUTPUT: |6;Boyer;12011.904761904761 01:09:47 INFO - 2015-11-24 01:09:47,181 DEBUG : BROWSER_OUTPUT: |7;RegExp;26076.923076923078 01:09:47 INFO - 2015-11-24 01:09:47,182 DEBUG : BROWSER_OUTPUT: |8;Splay;637.3486297004462 01:09:47 INFO - 2015-11-24 01:09:47,182 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 01:09:47 INFO - 2015-11-24 01:09:47,182 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:09:47 INFO - 2015-11-24 01:09:47,182 DEBUG : BROWSER_OUTPUT: __startTimestamp1448356187176__endTimestamp 01:09:47 INFO - 2015-11-24 01:09:47,182 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-24 01:09:47,182 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:09:47 INFO - 2015-11-24 01:09:47,183 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:09:47 INFO - 2015-11-24 01:09:47,183 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-24 01:09:47,183 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.75 Median:189.75 stddev:0.00 (0.0%) 01:09:47 INFO - 2015-11-24 01:09:47,183 DEBUG : BROWSER_OUTPUT: Values: 189.8 01:09:47 INFO - 2015-11-24 01:09:47,183 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-24 01:09:47,183 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.17 Median:194.17 stddev:0.00 (0.0%) 01:09:47 INFO - 2015-11-24 01:09:47,183 DEBUG : BROWSER_OUTPUT: Values: 194.2 01:09:47 INFO - 2015-11-24 01:09:47,183 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-24 01:09:47,183 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:289.27 Median:289.27 stddev:0.00 (0.0%) 01:09:47 INFO - 2015-11-24 01:09:47,184 DEBUG : BROWSER_OUTPUT: Values: 289.3 01:09:47 INFO - 2015-11-24 01:09:47,184 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-24 01:09:47,184 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4995.02 Median:4995.02 stddev:0.00 (0.0%) 01:09:47 INFO - 2015-11-24 01:09:47,184 DEBUG : BROWSER_OUTPUT: Values: 4995.0 01:09:47 INFO - 2015-11-24 01:09:47,184 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-24 01:09:47,184 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1962.75 Median:1962.75 stddev:0.00 (0.0%) 01:09:47 INFO - 2015-11-24 01:09:47,184 DEBUG : BROWSER_OUTPUT: Values: 1962.7 01:09:47 INFO - 2015-11-24 01:09:47,184 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-24 01:09:47,184 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: Values: 794.3 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12011.90 Median:12011.90 stddev:0.00 (0.0%) 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: Values: 12011.9 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26076.92 Median:26076.92 stddev:0.00 (0.0%) 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: Values: 26076.9 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:637.35 Median:637.35 stddev:0.00 (0.0%) 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: Values: 637.3 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: Values: 4826.9 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:09:47 INFO - 2015-11-24 01:09:47,185 DEBUG : BROWSER_OUTPUT: 01:09:48 INFO - 2015-11-24 01:09:48,059 INFO : Browser exited with error code: 0 01:09:48 INFO - 2015-11-24 01:09:48,074 INFO : Completed test v8_7 (00:00:39) 01:09:48 INFO - 2015-11-24 01:09:48,124 INFO : Completed test suite (00:20:11) 01:09:48 INFO - 2015-11-24 01:09:48,124 DEBUG : Working with test: dromaeo_css 01:09:48 INFO - 2015-11-24 01:09:48,124 DEBUG : Generating results file: dromaeo_css 01:09:48 INFO - 2015-11-24 01:09:48,125 DEBUG : Working with test: kraken 01:09:48 INFO - 2015-11-24 01:09:48,125 DEBUG : Generating results file: kraken 01:09:48 INFO - 2015-11-24 01:09:48,125 INFO : javascript benchmark 01:09:48 INFO - 2015-11-24 01:09:48,126 DEBUG : Working with test: v8_7 01:09:48 INFO - 2015-11-24 01:09:48,126 DEBUG : Generating results file: v8_7 01:09:48 INFO - 2015-11-24 01:09:48,126 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:48 INFO - 2015-11-24 01:09:48,168 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 01:09:48 INFO - 2015-11-24 01:09:48,168 DEBUG : process_Request line: dromaeo_css 6921.37 graph.html#tests=[[72,64,35]] 01:09:48 INFO - 2015-11-24 01:09:48,168 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:48 INFO - 2015-11-24 01:09:48,206 DEBUG : process_Request line: kraken 1493.10 graph.html#tests=[[232,64,35]] 01:09:48 INFO - 2015-11-24 01:09:48,206 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:48 INFO - 2015-11-24 01:09:48,243 DEBUG : process_Request line: v8_7 19456.70 graph.html#tests=[[230,64,35]] 01:09:48 INFO - 2015-11-24 01:09:48,244 INFO : javascript benchmark 01:09:48 INFO - 2015-11-24 01:09:48,248 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3155.952660710089, 3219.0986523773354, 3242.7243684286836, 3256.1371236622285, 3283.671632836716, 5216.921746173811, 5275.49882761138, 5328.733563321833, 5343.225232341309, 5394.487523685249, 5326.840194794153, 5353.143497040474, 5364.0, 5382.300300960879, 5399.163129714891, 4923.163062279412, 4926.334944782462, 4953.4798846121, 5015.348004759376, 5046.899062018758, 4808.374911261549, 5028.899422011557, 5035.043341765053, 5045.268436076767, 5099.6685215460875, 4817.325574419584, 4837.984023355065, 4885.8778530536665, 4893.119238537062, 4926.064047830901, 4920.581750551208, 4928.8767780805765, 4930.161872481651, 4940.53064958832, 4960.950390496085, 4757.14371413149, 4920.040592084545, 4932.0, 4940.2342636891335, 4962.280469331927, 5096.235564665293, 5171.327727395452, 5208.0, 5238.004779091998, 5264.184051472028, 5873.119032145212, 5928.49607783339, 5931.911021334683, 5939.227900372924, 5946.0, 5781.942180578182, 5928.347881733006, 5963.910541341883, 5984.7606095756555, 5999.880002399971, 5425.891482170374, 5449.0, 5491.258680078218, 5510.559155267569, 5534.916976245359, 5918.348981612019, 5959.1657167995645, 5960.85097872548, 5966.701664916824, 6013.218281623361, 5506.724663766796, 5584.497395234448, 5737.713114344266, 5740.368559458456, 5767.106098554731, 5726.9713651431475, 5813.563982701315, 5904.763809447574, 5905.0, 5958.791442299499, 5741.770329186869, 5785.768569257267, 5797.043487824546, 5798.739056742456, 5801.6519008859605, 5656.688882111441, 5774.94225057744, 5776.942230577724, 5785.4214578541805, 5796.652200867961, 4397.714148580332, 4467.195904737178, 4470.776461176928, 4472.508024117409, 4505.549445055468, 4025.838966441368, 4025.8590949317218, 4026.57720939303, 4037.4953130858644, 4074.8166332515107, 5419.214213939035, 5514.972425137848, 5600.215969764236, 5601.327840659147, 5601.80393686219, 5795.275590551181, 5838.766449342063, 5854.7072646367515, 5859.824205273849, 5909.202257695242, 5488.780448782084, 5504.422035686195, 5504.944950550524, 5507.256520369699, 5516.558675305966, 4899.995500922302, 4912.484189160086, 4936.284238785356, 5025.0, 5029.5724863386295, 6066.939330606638, 6146.069703123678, 6214.596051256744, 6216.0, 6223.844403889939, 5942.286925568959, 5949.613275137102, 5952.851178720393, 6007.639541627516, 6028.2766068072115, 5881.588288819741, 5961.105834124743, 6094.146819445193, 6106.175666284995, 6165.0444181152, 5831.1836342912875, 5890.087036509348, 5899.321578018411, 5899.528037756883, 5902.852428689317, 5925.022371308686, 6004.909926351195, 6010.4891084258325, 6011.398860113954, 6012.6392416455155, 5504.284443022381, 5519.917201242065, 5562.193481945014, 5612.410696876769, 5820.854478638068, 5709.600327977002, 5770.538356931519, 5776.740046697824, 5782.161586570008, 5788.942110579009, 5667.489925906688, 5684.261046063985, 5685.289338832646, 5690.77236910519, 5697.943020569741, 5611.186377975089, 5690.260266165537, 5715.685637289989, 5733.627314224562, 5773.769049237983, 5625.381208067191, 5631.831045068655, 5669.064604340238, 5716.685582293014, 5763.510101641407], "unit": "ms", "name": "dojo.html", "value": 5383.511036332308}, {"lowerIsBetter": false, "replicates": [547.3978623514136, 550.2489102375258, 553.283497870258, 578.6325683191175, 585.0405335250188, 31130.221744456372, 31788.20529486761, 31941.284990775814, 39870.0, 40923.79538102313, 43113.35329970053, 43461.34807977883, 43509.0, 43573.34639980403, 43590.0, 8627.87058194126, 8750.124987501262, 8784.64861405543, 8787.209151176392, 8797.208251257385, 7646.579438130901, 7864.803379915491, 10480.31877927936, 10686.893131068706, 10690.144788416947, 10363.0, 10455.268131230818, 10459.477026148701, 10463.4768261587, 10471.633492827752, 7718.459707820455, 7913.129555748863, 10135.543900524493, 10208.591656333774, 10209.540570674337, 10458.0, 10759.51582178796, 10762.139028877671, 10766.300190487593, 10769.62306319275, 39717.0, 40096.0, 40113.58750537439, 40172.799136004134, 40263.7986810067, 3434.7252219822353, 3438.2951494943477, 3626.6735993760426, 3660.2862441823854, 3936.1340505088833, 30140.24649383761, 30308.0, 30445.0, 30478.085657430314, 31219.84390078035, 3689.6679298862964, 3767.321882061228, 3776.546814382292, 3872.1481274119647, 3886.7667939923695, 264528.9999999981, 265238.0, 265553.0, 266222.0, 266313.0, 57686.0, 58673.0, 60142.69928650329, 60257.698711506164, 60628.39371606227, 70449.64775176092, 71182.64408677924, 71422.0, 71504.0, 71626.0, 13659.180449172884, 13808.240546770025, 13886.09740366873, 13896.027278090436, 13904.93047534776, 10286.331388459726, 10307.690769276935, 10419.843702344471, 10428.843567346496, 10428.895711042944, 20095.0, 20286.49283767888, 20304.49238769013, 20448.897755511127, 20472.0, 8223.177682231848, 8318.958405208055, 8463.280621147149, 8474.0, 8482.279006284412, 999.7050869993369, 1004.6031817432073, 1009.2430676992255, 1009.6920439266095, 1018.981018981019, 28798.42403151925, 29225.0, 29394.752740994634, 29473.557896631566, 29703.0, 1057.3708643357345, 1063.3779239145033, 1070.7002039428971, 1080.6271836216492, 1153.2676750263643, 15071.924640376728, 15179.696406072038, 15330.156841373831, 15740.92129539345, 16405.507834764736, 293731.0, 298786.0, 299098.0, 299149.0, 300011.0, 53219.73390133025, 53619.731901340245, 53708.19437708437, 53801.73099134479, 53808.73095634575, 1359.6736783172166, 1364.7679894417972, 1374.1754947031502, 1374.4914381678843, 1390.450771945076, 28904.85547572333, 29532.409351813272, 29766.0, 30102.548461772654, 30318.0, 45975.77012115052, 46375.304370435144, 46378.30432543582, 46383.76808115938, 46414.30378544257, 258050.0, 262964.0, 263272.0, 281048.0, 400372.0, 31119.0, 31126.844365778026, 31143.377132457677, 31403.11581305129, 31624.841875790473, 42473.0, 43431.34852977271, 43465.56534434615, 44013.0, 44448.33327500025, 36476.45285320775, 36498.27003459863, 37244.44133337948, 37281.62718372782, 38040.0, 35813.0, 36708.44937325996, 36964.44553331648, 37173.0, 37596.24807503889, 34038.48942265918, 34047.65952340445, 34478.82760586181, 34485.827570861984, 35312.82343588266, 30091.398172036876, 32348.191295217806, 33146.94453727828, 33299.334013319116, 33711.0, 25534.865293185274, 25728.228153155436, 25857.612135818355, 26010.86994565015, 26092.34769130787], "unit": "ms", "name": "ext.html", "value": 18850.258142126488}, {"lowerIsBetter": false, "replicates": [353.8076681583067, 359.95860476045254, 360.9350316942951, 363.351417719371, 365.1400950760958, 14154.221517816515, 14433.0, 16344.182790860468, 16517.339306427744, 17031.148442577884, 15272.38910443581, 15798.526044218663, 15812.604684882883, 16617.0, 16621.335146594152, 5311.814086506973, 5446.891062178754, 5455.536279416255, 5460.645058071233, 5466.125419932811, 3970.3250447424007, 4072.7963601819793, 5331.2269720890445, 5342.866428339303, 5844.0, 5939.227900372945, 5964.403559644044, 5972.134040564116, 5979.52163826895, 5989.43100405463, 4946.554810067093, 5062.0, 5070.61970352225, 5075.111855425323, 5949.018411962021, 4796.064767370364, 4868.172410690191, 4869.853904382839, 4876.390451193601, 4955.653104282702, 11806.881931180664, 11819.409029548488, 14152.716945661132, 19296.71054934177, 19765.60468790616, 2063.10255039057, 2085.937421877346, 2095.4551816527814, 2110.5778844231213, 2117.8729276243475, 9419.340646154771, 9482.146606805352, 9619.51902404877, 10506.947465262701, 13314.0, 1807.6565452564103, 1874.175362840346, 1880.5674694820132, 1882.2471011595335, 1890.1399863062275, 58811.0, 59328.40671593315, 59656.40343596552, 61024.69487652578, 61441.0, 9711.951440242894, 10036.390538460053, 10112.241581881388, 10146.797064058677, 10155.39067655943, 13311.800322995163, 13344.5329413472, 13366.33168341579, 13382.197068175941, 13388.598342049754, 6731.0, 6891.517593768388, 7011.614361210182, 7049.0, 7105.89341159883, 6623.503237257225, 6630.9336906630315, 6677.632730199788, 6680.3987641112535, 6695.631740254333, 3993.9600603994168, 4102.733322334038, 4350.282203436397, 4369.4101296325225, 4447.799849006802, 1719.6130870554025, 1740.895546267228, 1742.7298768690873, 1785.9464216073538, 1836.4307064809684, 842.3429724814654, 872.4775267158849, 904.2268860124631, 920.9861852072224, 1069.8823129455754, 16589.83410165907, 16882.324707011827, 17200.31198752061, 17338.91330543339, 17417.82582174162, 813.7070654564352, 958.736347504428, 961.4087336288272, 967.6758285974278, 975.9804803903883, 9120.49837258957, 9210.35527513081, 9258.768530786649, 9356.812863742824, 9493.430394176234, 337691.0, 346454.0, 349845.0, 353649.0, 365712.0, 72693.63653181806, 80153.59923200347, 80820.19179808127, 81859.5907020473, 82999.17000830035, 1149.4769879704882, 1173.5833779008499, 1179.991107602987, 1182.92902425853, 1185.7391373897728, 15406.92296538555, 15456.304466299269, 15533.0, 15679.216039197767, 15917.28372223276, 34280.48579271263, 34769.13077173091, 34811.30377392488, 34934.475982860786, 36055.63944360523, 45718.771406142754, 46549.30176047294, 46779.766101169276, 48366.27450588174, 48993.75503122462, 8510.404271700922, 8936.195742383217, 8992.055834137584, 9069.0, 9113.681021164228, 10555.94722026385, 10559.04968552834, 10627.734306642396, 10672.0, 12410.5656302029, 13637.590872273848, 13640.863591364356, 14188.929055354658, 14295.428182872985, 14542.0, 13715.382807773474, 14010.64973375633, 14085.929570352082, 14691.779623305445, 14891.180985045927, 12209.328486933304, 12614.936925315682, 12892.548760793703, 13380.464781408635, 15395.384184632489, 9461.574229159567, 9587.616495340108, 9800.41197528122, 9890.258230632588, 9905.603775848886, 13942.302884855513, 13947.232902190071, 14252.073615214978, 14637.0, 14902.77645835335], "unit": "ms", "name": "jquery.html", "value": 8489.166543015644}, {"lowerIsBetter": false, "replicates": [1585.8414158584135, 1697.711389063859, 1739.5129363778146, 1746.9301227950882, 1774.1306759687748, 6510.0, 6663.933360666398, 6934.895976560356, 7057.435405167587, 7058.082449281599, 7263.309985551377, 7324.633768311576, 7341.229170937041, 7342.8531429371515, 7343.339099481059, 1939.4181745476371, 1977.6440240756658, 2195.571863486625, 2213.5683541709373, 2216.656418255173, 2163.459135216196, 2195.890205489719, 2216.445888527868, 2220.7779222077825, 2222.8999695013763, 2169.5660867826496, 2196.02276986741, 2220.0897631970897, 2220.1896307847683, 2223.4107961390246, 1940.1172466527767, 1968.2323893681405, 2130.5845360154776, 2182.74898386686, 2200.1529411176653, 2189.9233526826642, 2221.7222847144108, 2222.2222222222094, 2225.899834507451, 2225.9666105008437, 7539.886901696479, 7608.277213664693, 7609.847803043908, 7615.80960475987, 7625.313721765067, 4406.647468202536, 4487.259602165639, 4506.301523263899, 4507.616852567536, 4507.819687212507, 2935.2368384220044, 2998.100569829064, 3035.332226910098, 3037.665856755755, 3056.159556122062, 916.2679662813399, 926.2173463423396, 930.4603330068544, 973.445136272325, 1004.3371374892608, 9767.511624418821, 9779.902200978042, 9791.314607977445, 9801.509924503818, 9809.264305177068, 4022.155347377025, 4100.2619528484565, 4123.381492776048, 4158.480189976253, 4178.895527611834, 8436.0, 8451.577421128919, 8459.534725590029, 8472.0, 8478.74563763088, 4583.931241031387, 4615.561521655437, 4633.4208223972, 4634.884127896829, 4635.513271106485, 4222.303319952173, 4225.598568136023, 4226.028013556899, 4226.957730422718, 4227.640650544677, 3570.7500474967023, 3572.964270357315, 3616.72874534411, 3643.143861192618, 3645.0522864055006, 1176.9529218831321, 1192.3680449361852, 1199.7060720123625, 1205.0600531585378, 1207.9456424460745, 1316.1445060710423, 1342.328835582209, 1356.504875720355, 1357.0297237475252, 1370.8286464191976, 6543.411093001652, 6734.932650673529, 6743.5953842769595, 7099.858002839915, 7100.68046937889, 610.5054905526538, 627.9120923070774, 628.2241431831684, 628.434409031875, 628.5129025005566, 5456.890862182734, 5493.285872836505, 5501.779928802883, 5518.19986102013, 5543.722813859372, 8630.870536941951, 8710.608022638997, 8756.4308319959, 8803.559822008874, 8817.515036672916, 8525.957370213233, 8694.695685650971, 8708.738737837875, 8722.171393717586, 8727.60725767342, 6858.177018757781, 7002.439804815603, 7007.089078419773, 7054.047703559953, 7055.435565154878, 6613.908705063803, 6672.332766723289, 6697.598144111369, 6708.698108585223, 6714.429273511806, 7598.278163574451, 7848.803779905548, 7862.135165131716, 7962.522248665098, 7969.8406031880195, 7680.0, 7765.301122898966, 7873.685052598061, 7882.408819338458, 7889.842203156019, 6461.676916154268, 6472.255690595642, 6572.34276572339, 6601.966990165019, 6604.471642268703, 6889.827754306182, 6926.134233220848, 6930.306969303029, 6932.757353492603, 6933.410660093747, 6489.059086432535, 6556.541042127005, 6591.835204119935, 6691.832704182434, 6733.360330768569, 6534.346565343428, 6585.5719378240265, 6600.306967768507, 6619.602823830585, 6662.700178492077, 6081.239845019372, 6116.8776624468155, 6760.898586521108, 6807.489438292049, 6807.965960170365, 6047.848803779941, 6135.447809697149, 6183.783567575113, 6183.81448556544, 6188.350223226496, 6145.692715364304, 6342.90485642725, 6364.809055728336, 6376.52176086786, 6407.103005579316], "unit": "ms", "name": "mootools.html", "value": 4242.984752912168}, {"lowerIsBetter": false, "replicates": [317.985690643921, 318.99999999999994, 320.4696227743086, 321.4166288186939, 326.5640370105908, 5818.098194779805, 5894.58737888348, 5934.338385252131, 5965.642061476315, 5973.0, 5726.570507211955, 5890.558208134396, 5910.46805787479, 5914.852128696784, 5917.970410147954, 4307.332363483665, 4386.144701783153, 4528.524504926992, 4537.61602711173, 4539.341795439659, 4411.42651455312, 4499.6850220484575, 4500.347449619803, 4504.549545045502, 4522.276435770277, 4486.641068714495, 4490.236659767831, 4490.371348011265, 4494.123645889053, 4500.054988452429, 4501.437320334958, 4501.572350626701, 4501.7524036178, 4503.819847206124, 4512.616427603658, 3864.1937691373973, 3930.233604447134, 3940.6847452204042, 3946.8223929923224, 3948.1708841143395, 5638.605297629168, 5648.181013753024, 5653.547716182696, 5666.235058267122, 5666.575006874501, 5220.556252718524, 5229.215617657382, 5233.267342572043, 5234.136367499358, 5237.214417837355, 5936.97031514844, 6065.939340606582, 6085.908711369333, 6234.688265586748, 6246.562740608159, 4298.0, 4334.046509767846, 4334.869953901388, 4339.153864996327, 4341.240282950471, 6524.804255872332, 6526.216853977506, 6530.183727034121, 6530.314316996694, 6533.314002029813, 4420.093880754438, 4435.112977404532, 4436.489803672554, 4437.667174961891, 4439.0, 4245.57544245573, 4391.297392417198, 4392.472903251631, 4393.626541743987, 4406.317020861771, 5143.691378517301, 5148.4079330876675, 5149.588032957355, 5154.92267615986, 5155.200943853709, 6259.655718935503, 6297.055441683692, 6302.590331628429, 6308.211473565804, 6309.08518264849, 1519.8100237470317, 1551.8525740054677, 1552.0842702805398, 1552.8447155284382, 1555.3389809331215, 1010.8837483689323, 1012.5797793915442, 1032.0402026115785, 1035.0167341025906, 1040.1314902056715, 6006.909896351558, 6044.727987240497, 6046.0, 6053.606515576562, 6069.544784141207, 6406.583572067801, 6414.775482858077, 6415.166028416369, 6418.839529011812, 6431.485481161496, 6060.818175454743, 6068.9696551517845, 6071.969640151771, 6072.997955337408, 6073.75704971805, 3386.9661303387143, 3461.8269086546075, 3462.9480557791653, 3469.6530346965606, 3471.392506311436, 6636.6726654669255, 6637.303083176197, 6648.368405001517, 6673.666316684146, 6687.331266873371, 6571.0471981562405, 6575.243846957565, 6576.539642224999, 6582.045603387482, 6582.506312026617, 6470.1588793457495, 6626.602403855784, 6631.0, 6640.0703901453835, 6645.0, 6299.937000630119, 6369.681515924278, 6424.582402143846, 6529.8694026120165, 6530.8040758777315, 6424.357564243725, 6442.48601578638, 6449.5485316027425, 6450.161479007699, 6485.967570162119, 6672.232693240339, 6772.627505487246, 6777.491688123312, 6782.0505129280955, 6796.048553202457, 4352.804123814372, 4365.781710914505, 4371.235033869124, 4373.912521749611, 4375.671824613103, 6529.640869752209, 6529.7388104475285, 6534.673266336569, 6538.346165383424, 6542.803715888531, 6342.460890824332, 6350.174477317919, 6351.523635727432, 6354.586951848115, 6354.682265886595, 6200.286966998853, 6285.59143655661, 6328.683565821782, 6342.52431067681, 6361.459275961595, 6214.316425193135, 6224.2842073160355, 6239.0953311770445, 6252.687365631609, 6255.56211065221, 6381.8085457436355, 6382.32985536512, 6391.456726178327, 6392.0731493934045, 6399.104125422352, 6118.785842495491, 6207.348228435949, 6222.844428889314, 6224.564280500503, 6226.12834203221], "unit": "ms", "name": "prototype.html", "value": 4709.30257057449}, {"lowerIsBetter": false, "replicates": [797.9601019949002, 856.507508182795, 876.7413612984169, 890.8708039142825, 891.6745387933404, 13845.515406960758, 14033.649158771035, 14062.929685351559, 14081.943854210924, 14103.365348559339, 13082.738345233114, 13355.866441335607, 13370.398332075056, 13371.39828707708, 13373.531926382579, 682.1950098883316, 695.5722230828055, 697.7627606613751, 697.8918267668494, 824.6206744897324, 840.1052878684181, 848.7411339541437, 848.7411339541437, 849.362977766675, 849.9830003399928, 851.4465597361733, 865.8138500222451, 866.1511718515858, 866.1554983890719, 866.3718803867177, 709.7622296530643, 718.2996578336133, 854.8546747052985, 855.5166331022953, 867.5141920524527, 634.2009068573584, 638.7093872288098, 639.284001917855, 639.7536948274901, 639.936006399361, 13432.261225632587, 13879.58361249154, 13892.861071389258, 13898.16611003343, 13931.094478858942, 12075.45660445282, 12612.68468288291, 12690.682732931658, 13125.146865453811, 13198.340082995812, 10592.311499752492, 10670.946645266802, 10787.352758834495, 10800.135989120852, 10821.567137314498, 3607.801570913599, 3607.8196090195383, 3625.9274814503824, 3694.8891533254045, 3773.1699026214187, 47180.292295615596, 47283.52716472826, 47562.0, 47638.0, 48205.27692084621, 10187.745306367251, 10428.323891705078, 10474.319169253975, 10646.946765266279, 10780.40707761065, 19394.224231030883, 19405.90297048534, 19432.12555435009, 19463.513412164524, 19465.610687786164, 7629.656665450068, 7790.649420776079, 7974.641141148662, 8002.239787220321, 8072.83854322922, 4394.252976993918, 4398.648108151404, 4427.734335939854, 4462.062966777014, 4486.618637415856, 3038.2860027893425, 3061.479548476764, 3061.4948533491724, 3066.340736741611, 3072.1551573317515, 548.5227851768987, 559.0176408858784, 562.9915551266735, 571.0520535910451, 575.0827430248746, 651.7979426377838, 664.9734010639617, 702.7118881258762, 705.9258777828356, 708.6031822179596, 8319.792005199919, 8416.747497575083, 8537.146285371413, 8713.825723485495, 8866.73399798007, 605.5034871405493, 627.8995360742259, 665.7505568591689, 686.5160062156168, 687.8589889072728, 3890.533136023695, 4003.6997225208224, 4060.715749897479, 4093.263212621757, 4228.133232687292, 57049.0, 58675.0, 58769.70615146897, 58824.0, 59149.70425147847, 48785.0, 50908.0, 51189.0, 52469.7376513115, 53013.734931325096, 43884.341734874004, 44119.55880441154, 44678.10643787171, 44763.77618111954, 48669.0, 7970.442069055111, 8137.59312034384, 8402.621882015203, 8436.746897593082, 8581.65673373058, 33678.158046049044, 33742.49386259257, 34558.308833823685, 36166.27667446584, 36313.0, 44580.0, 45344.0, 45373.31940020836, 45588.7720561395, 45990.0, 10859.674209773719, 10909.290896091728, 10971.890281097087, 11307.151963602599, 11360.886391136313, 11680.532778688757, 11860.347680877634, 11992.0, 12574.937125314314, 12679.429425675682, 11093.112550996062, 11238.15713821483, 11304.0, 11625.18623696333, 11676.532938682358, 11709.355985420883, 11902.404879755804, 12071.818922715991, 12442.066844986843, 12484.500619975099, 11174.0, 11431.828522572001, 11439.542418303176, 11500.0, 11785.88214117848, 9459.621615135318, 9590.184834289164, 9684.0, 9934.701958941243, 10021.649242276486, 8999.370044097112, 9235.907640923504, 9703.9029609703, 9749.463779492196, 9753.730197639732], "unit": "ms", "name": "yui.html", "value": 6386.12540625615}], "name": "dromaeo_css", "value": 6921.375402224258}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 102.0, 109.0, 111.0, 110.0, 99.0, 109.0, 111.0, 102.0], "unit": "ms", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [153.0, 123.0, 153.0, 163.0, 125.0, 155.0, 148.0, 129.0, 169.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 160.0, 163.0, 159.0, 160.0, 160.0, 159.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 85.0, 96.0, 72.0, 71.0, 72.0, 94.0, 95.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 140.0, 93.0, 95.0, 94.0, 133.0, 95.0, 94.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 147.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 58.0, 58.0, 59.0, 59.0, 57.0, 59.0, 59.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 68.0, 69.0, 74.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 84.0, 84.0, 93.0, 84.0, 84.0, 86.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 126.0, 115.0, 115.0, 116.0, 123.0, 116.0, 118.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [143.0, 152.0, 146.0, 146.0, 146.0, 137.0, 149.0, 148.0, 149.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 67.0, 66.0, 67.0, 69.0, 66.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1493.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.75332068311195], "unit": "score", "name": "Richards", "value": 186.04154000000005}, {"lowerIsBetter": false, "replicates": [194.1747572815534], "unit": "score", "name": "DeltaBlue", "value": 340.50769999999994}, {"lowerIsBetter": false, "replicates": [289.2681515765114], "unit": "score", "name": "Encrypt", "value": 920.1877170000002}, {"lowerIsBetter": false, "replicates": [4995.024875621891], "unit": "score", "name": "Decrypt", "value": 53.289224103585696}, {"lowerIsBetter": false, "replicates": [1962.7450980392157], "unit": "score", "name": "RayTrace", "value": 377.0173726273725}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [12011.904761904761], "unit": "score", "name": "Boyer", "value": 55.483540138751295}, {"lowerIsBetter": false, "replicates": [26076.923076923078], "unit": "score", "name": "RegExp", "value": 34.934528023598794}, {"lowerIsBetter": false, "replicates": [637.3486297004462], "unit": "score", "name": "Splay", "value": 127.85937899999995}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19456.696128551823}]} 01:09:48 INFO - RETURN: dromaeo_css: 6921.37 01:09:48 INFO - RETURN: kraken: 1493.10 01:09:48 INFO - RETURN: v8_7: 19456.70 01:09:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19456.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1493.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6921.37"}}} 01:09:48 INFO - Return code: 0 01:09:48 INFO - # TBPL SUCCESS # 01:09:48 INFO - Running post-action listener: _resource_record_post_action 01:09:48 INFO - Running post-run listener: _resource_record_post_run 01:09:49 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 217088; Write bytes: 497377280; Read time: 48; Write time: 428368 01:09:49 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 164286464; Read time: 0; Write time: 178284 01:09:49 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 217088; Write bytes: 333090816; Read time: 48; Write time: 250084 01:09:49 INFO - Running post-run listener: _upload_blobber_files 01:09:49 INFO - Blob upload gear active. 01:09:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:09:49 INFO - Copying logs to upload dir... 01:09:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.455965 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-24 01:09:49.216415) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 01:09:49.220497) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010039 build_url: 'https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/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-24 01:09:49.272199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:09:49.272553) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448354793.60198-1285148140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:09:49.322024) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 01:09:49.322353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 01:09:49.322685) ========= ========= Total master_lag: 0.23 =========