builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1447923468.76 results: success (0) buildid: 20151118233011 builduid: d40bc0fe6f7142d99c95e2396ae5a970 revision: 3c747d782958267e847037c20fa37e14abc4de6c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:48.762795) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:48.763421) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:48.763974) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007673 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:48.803063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:48.803392) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:48.820277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:48.820557) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004690 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:48.869737) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:48.870059) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:48.870436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:48.870714) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 00:57:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.6M=0s 2015-11-19 00:57:49 (77.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117287 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:49.001987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:49.002260) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022304 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:49.052666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 00:57:49.052986) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c747d782958267e847037c20fa37e14abc4de6c --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 3c747d782958267e847037c20fa37e14abc4de6c --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=fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 00:57:49,337 truncating revision to first 12 chars 2015-11-19 00:57:49,337 Setting DEBUG logging. 2015-11-19 00:57:49,337 attempt 1/10 2015-11-19 00:57:49,337 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c747d782958?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 00:57:50,471 unpacking tar archive at: fx-team-3c747d782958/testing/mozharness/ program finished with exit code 0 elapsedTime=1.411222 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 00:57:50.477907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:50.478466) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:50.486693) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:50.486963) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 00:57:50.487348) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-11-19 00:57:50.487642) ========= /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=fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:57:50 INFO - MultiFileLogger online at 20151119 00:57:50 in /builds/slave/test-pgo 00:57:50 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:57:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:57:50 INFO - {'append_to_log': False, 00:57:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:57:50 INFO - 'blob_upload_branch': 'Fx-Team', 00:57:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:57:50 INFO - 'branch': 'Fx-Team', 00:57:50 INFO - 'buildbot_json_path': 'buildprops.json', 00:57:50 INFO - 'config_files': ('talos/linux_config.py',), 00:57:50 INFO - 'default_actions': ('clobber', 00:57:50 INFO - 'read-buildbot-config', 00:57:50 INFO - 'download-and-extract', 00:57:50 INFO - 'populate-webroot', 00:57:50 INFO - 'create-virtualenv', 00:57:50 INFO - 'install', 00:57:50 INFO - 'run-tests'), 00:57:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:57:50 INFO - 'download_minidump_stackwalk': True, 00:57:50 INFO - 'download_symbols': 'ondemand', 00:57:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:57:50 INFO - 'tooltool.py': '/tools/tooltool.py', 00:57:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:57:50 INFO - '/tools/misc-python/virtualenv.py')}, 00:57:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:57:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:57:50 INFO - 'installer_path': 'installer.exe', 00:57:50 INFO - 'log_level': 'info', 00:57:50 INFO - 'log_name': 'talos', 00:57:50 INFO - 'log_to_console': True, 00:57:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:57:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:57:50 INFO - 'opt_config_files': (), 00:57:50 INFO - 'pip_index': False, 00:57:50 INFO - 'sps_profile': False, 00:57:50 INFO - 'sps_profile_interval': 0, 00:57:50 INFO - 'suite': 'dromaeojs', 00:57:50 INFO - 'system_bits': '64', 00:57:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:57:50 INFO - 'title': 'talos-linux64-ix-020', 00:57:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:57:50 INFO - 'use_talos_json': True, 00:57:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:57:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:57:50 INFO - 'work_dir': 'build'} 00:57:50 INFO - ##### 00:57:50 INFO - ##### Running clobber step. 00:57:50 INFO - ##### 00:57:50 INFO - Running pre-action listener: _resource_record_pre_action 00:57:50 INFO - Running main action method: clobber 00:57:50 INFO - rmtree: /builds/slave/test-pgo/build 00:57:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:57:51 INFO - Running post-action listener: _resource_record_post_action 00:57:51 INFO - ##### 00:57:51 INFO - ##### Running read-buildbot-config step. 00:57:51 INFO - ##### 00:57:51 INFO - Running pre-action listener: _resource_record_pre_action 00:57:51 INFO - Running main action method: read_buildbot_config 00:57:51 INFO - Using buildbot properties: 00:57:51 INFO - { 00:57:51 INFO - "properties": { 00:57:51 INFO - "buildnumber": 501, 00:57:51 INFO - "product": "firefox", 00:57:51 INFO - "script_repo_revision": "production", 00:57:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:57:51 INFO - "repository": "", 00:57:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:57:51 INFO - "buildid": "20151118233011", 00:57:51 INFO - "slavename": "talos-linux64-ix-020", 00:57:51 INFO - "pgo_build": "True", 00:57:51 INFO - "basedir": "/builds/slave/test-pgo", 00:57:51 INFO - "project": "", 00:57:51 INFO - "platform": "ubuntu64_hw", 00:57:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:57:51 INFO - "slavebuilddir": "test", 00:57:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:57:51 INFO - "branch": "fx-team", 00:57:51 INFO - "repo_path": "integration/fx-team", 00:57:51 INFO - "stage_platform": "linux64-pgo", 00:57:51 INFO - "builduid": "d40bc0fe6f7142d99c95e2396ae5a970", 00:57:51 INFO - "revision": "3c747d782958267e847037c20fa37e14abc4de6c" 00:57:51 INFO - }, 00:57:51 INFO - "sourcestamp": { 00:57:51 INFO - "repository": "", 00:57:51 INFO - "hasPatch": false, 00:57:51 INFO - "project": "", 00:57:51 INFO - "branch": "fx-team-linux64-pgo-talos", 00:57:51 INFO - "changes": [ 00:57:51 INFO - { 00:57:51 INFO - "category": null, 00:57:51 INFO - "files": [ 00:57:51 INFO - { 00:57:51 INFO - "url": null, 00:57:51 INFO - "name": "https://queue.taskcluster.net/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:57:51 INFO - } 00:57:51 INFO - ], 00:57:51 INFO - "repository": "", 00:57:51 INFO - "rev": "3c747d782958267e847037c20fa37e14abc4de6c", 00:57:51 INFO - "who": "sendchange", 00:57:51 INFO - "when": 1447923381, 00:57:51 INFO - "number": 6681535, 00:57:51 INFO - "comments": "", 00:57:51 INFO - "project": "", 00:57:51 INFO - "at": "Thu 19 Nov 2015 00:56:21", 00:57:51 INFO - "branch": "fx-team-linux64-pgo-talos", 00:57:51 INFO - "revlink": "", 00:57:51 INFO - "properties": [ 00:57:51 INFO - [ 00:57:51 INFO - "buildid", 00:57:51 INFO - "20151118233011", 00:57:51 INFO - "Change" 00:57:51 INFO - ], 00:57:51 INFO - [ 00:57:51 INFO - "builduid", 00:57:51 INFO - "d40bc0fe6f7142d99c95e2396ae5a970", 00:57:51 INFO - "Change" 00:57:51 INFO - ], 00:57:51 INFO - [ 00:57:51 INFO - "pgo_build", 00:57:51 INFO - "True", 00:57:51 INFO - "Change" 00:57:51 INFO - ] 00:57:51 INFO - ], 00:57:51 INFO - "revision": "3c747d782958267e847037c20fa37e14abc4de6c" 00:57:51 INFO - } 00:57:51 INFO - ], 00:57:51 INFO - "revision": "3c747d782958267e847037c20fa37e14abc4de6c" 00:57:51 INFO - } 00:57:51 INFO - } 00:57:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:57:51 INFO - Running post-action listener: _resource_record_post_action 00:57:51 INFO - ##### 00:57:51 INFO - ##### Running download-and-extract step. 00:57:51 INFO - ##### 00:57:51 INFO - Running pre-action listener: _resource_record_pre_action 00:57:51 INFO - Running main action method: download_and_extract 00:57:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:57:51 INFO - https://queue.taskcluster.net/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:57:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/test_packages.json 00:57:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/test_packages.json 00:57:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:57:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:57:51 INFO - Downloaded 1302 bytes. 00:57:51 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:57:51 INFO - Using the following test package requirements: 00:57:51 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:57:51 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:57:51 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:51 INFO - u'jsshell-linux-x86_64.zip'], 00:57:51 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:57:51 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:57:51 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:57:51 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:57:51 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:57:51 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:57:51 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:57:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:57:51 INFO - https://queue.taskcluster.net/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:57:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:57:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:57:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/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:57:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/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:58:07 INFO - Downloaded 22475381 bytes. 00:58:07 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:58:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:58:07 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:58:09 INFO - Return code: 0 00:58:09 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:58: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:58:09 INFO - https://queue.taskcluster.net/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:58:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:58:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:58:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/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:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/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:58:10 INFO - Downloaded 22475381 bytes. 00:58:10 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:58:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:58:10 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:58:11 INFO - Return code: 0 00:58: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:58:11 INFO - https://queue.taskcluster.net/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:58:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:58:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:58:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/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:58:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/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:58:16 INFO - Downloaded 11130997 bytes. 00:58:16 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:58:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:58:16 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:58:16 INFO - Return code: 0 00:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:58:16 INFO - https://queue.taskcluster.net/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:58:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:58:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:58:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/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:58:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_aokhJQHQ5i2MMlFRqSGow/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:58:18 INFO - Downloaded 57213200 bytes. 00:58:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:58:18 INFO - mkdir: /builds/slave/test-pgo/properties 00:58:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:58:18 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:58:18 INFO - Contents: 00:58:18 INFO - build_url:https://queue.taskcluster.net/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:58:18 INFO - Running post-action listener: _resource_record_post_action 00:58:18 INFO - Running post-action listener: set_extra_try_arguments 00:58:18 INFO - ##### 00:58:18 INFO - ##### Running populate-webroot step. 00:58:18 INFO - ##### 00:58:18 INFO - Running pre-action listener: _resource_record_pre_action 00:58:18 INFO - Running main action method: populate_webroot 00:58:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:58:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:58:18 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:58:18 INFO - '../fennec_ids.txt'], 00:58:18 INFO - 'tests': ['tcheck2']}, 00:58:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:58:18 INFO - '--tppagecycles', 00:58:18 INFO - '7'], 00:58:18 INFO - 'tests': ['tsvgm']}}, 00:58:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:58:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:58:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:58:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:58:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:58:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:58:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:58:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:18 INFO - 'talos_options': ['--e10s'], 00:58:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:58:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:18 INFO - 'tests': ['damp', 'tps']}, 00:58:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:18 INFO - 'talos_options': ['--e10s'], 00:58:18 INFO - 'tests': ['damp', 'tps']}, 00:58:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:58:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:58:18 INFO - 'other': {'tests': ['a11yr', 00:58:18 INFO - 'ts_paint', 00:58:18 INFO - 'tpaint', 00:58:18 INFO - 'sessionrestore', 00:58:18 INFO - 'sessionrestore_no_auto_restore']}, 00:58:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:58:18 INFO - 'tests': ['a11yr', 00:58:18 INFO - 'ts_paint', 00:58:18 INFO - 'tpaint', 00:58:18 INFO - 'sessionrestore', 00:58:18 INFO - 'sessionrestore_no_auto_restore']}, 00:58:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:58:18 INFO - 'tests': ['a11yr', 00:58:18 INFO - 'ts_paint', 00:58:18 INFO - 'tpaint', 00:58:18 INFO - 'sessionrestore', 00:58:18 INFO - 'sessionrestore_no_auto_restore']}, 00:58:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:58:18 INFO - 'tests': ['a11yr', 00:58:18 INFO - 'ts_paint', 00:58:18 INFO - 'tpaint', 00:58:18 INFO - 'sessionrestore', 00:58:18 INFO - 'sessionrestore_no_auto_restore']}, 00:58:18 INFO - 'other_l64': {'tests': ['a11yr', 00:58:18 INFO - 'ts_paint', 00:58:18 INFO - 'tpaint', 00:58:18 INFO - 'sessionrestore', 00:58:18 INFO - 'sessionrestore_no_auto_restore']}, 00:58:18 INFO - 'other_nol64': {'tests': ['a11yr', 00:58:18 INFO - 'ts_paint', 00:58:18 INFO - 'tpaint', 00:58:18 INFO - 'sessionrestore', 00:58:18 INFO - 'sessionrestore_no_auto_restore']}, 00:58:18 INFO - 'svgr': {'tests': ['tsvgx', 00:58:18 INFO - 'tsvgr_opacity', 00:58:18 INFO - 'tart', 00:58:18 INFO - 'tscrollx', 00:58:18 INFO - 'cart']}, 00:58:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:58:18 INFO - 'tests': ['tsvgx', 00:58:18 INFO - 'tsvgr_opacity', 00:58:18 INFO - 'tart', 00:58:18 INFO - 'tscrollx', 00:58:18 INFO - 'cart']}, 00:58:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:18 INFO - 'tests': ['tp5o']}, 00:58:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:18 INFO - 'talos_options': ['--e10s'], 00:58:18 INFO - 'tests': ['tp5o']}, 00:58:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:18 INFO - 'talos_options': ['--xperf_path', 00:58:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:58:18 INFO - 'tests': ['tp5n']}, 00:58:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:18 INFO - 'talos_options': ['--e10s', 00:58:18 INFO - '--xperf_path', 00:58:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:58:18 INFO - 'tests': ['tp5n']}}, 00:58:18 INFO - 'talos.zip': {'path': '', 00:58:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:58:18 INFO - Running post-action listener: _resource_record_post_action 00:58:18 INFO - ##### 00:58:18 INFO - ##### Running create-virtualenv step. 00:58:18 INFO - ##### 00:58:18 INFO - Running pre-action listener: _resource_record_pre_action 00:58:18 INFO - Running main action method: create_virtualenv 00:58:18 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:58:18 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:58:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:58:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:58:18 INFO - Using real prefix '/usr' 00:58:18 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:58:19 INFO - Installing distribute.............................................................................................................................................................................................done. 00:58:21 INFO - Installing pip.................done. 00:58:21 INFO - Return code: 0 00:58:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:58: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:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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', '--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 0x7fb613c97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e646c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f256e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ba90>, '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 0x1fadf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fae2e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', '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:58:21 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:58:21 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:58:21 INFO - Using env: {'DISPLAY': ':0', 00:58:21 INFO - 'HOME': '/home/cltbld', 00:58:21 INFO - 'LANG': 'en_US.UTF-8', 00:58:21 INFO - 'LANGUAGE': 'en_US:en', 00:58:21 INFO - 'LOGNAME': 'cltbld', 00:58:21 INFO - 'MAIL': '/var/mail/cltbld', 00:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:21 INFO - 'MOZ_NO_REMOTE': '1', 00:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:21 INFO - 'NO_EM_RESTART': '1', 00:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:58:21 INFO - 'PWD': '/builds/slave/test-pgo', 00:58:21 INFO - 'SHELL': '/bin/bash', 00:58:21 INFO - 'SHLVL': '1', 00:58:21 INFO - 'TERM': 'linux', 00:58:21 INFO - 'TMOUT': '86400', 00:58:21 INFO - 'USER': 'cltbld', 00:58:21 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', 00:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:21 INFO - '_': '/tools/buildbot/bin/python'} 00:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:21 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:58:21 INFO - Cleaning up... 00:58:21 INFO - Return code: 0 00:58:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:58: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:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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', '--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 0x7fb613c97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e646c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f256e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ba90>, '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 0x1fadf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fae2e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', '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:58:21 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:58:21 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:58:21 INFO - Using env: {'DISPLAY': ':0', 00:58:21 INFO - 'HOME': '/home/cltbld', 00:58:21 INFO - 'LANG': 'en_US.UTF-8', 00:58:21 INFO - 'LANGUAGE': 'en_US:en', 00:58:21 INFO - 'LOGNAME': 'cltbld', 00:58:21 INFO - 'MAIL': '/var/mail/cltbld', 00:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:21 INFO - 'MOZ_NO_REMOTE': '1', 00:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:21 INFO - 'NO_EM_RESTART': '1', 00:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:58:21 INFO - 'PWD': '/builds/slave/test-pgo', 00:58:21 INFO - 'SHELL': '/bin/bash', 00:58:21 INFO - 'SHLVL': '1', 00:58:21 INFO - 'TERM': 'linux', 00:58:21 INFO - 'TMOUT': '86400', 00:58:21 INFO - 'USER': 'cltbld', 00:58:21 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', 00:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:21 INFO - '_': '/tools/buildbot/bin/python'} 00:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:21 INFO - Downloading/unpacking psutil>=0.7.1 00:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:58:23 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:58:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:58:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:58:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:58:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:58:23 INFO - Installing collected packages: psutil 00:58:23 INFO - Running setup.py install for psutil 00:58:23 INFO - building 'psutil._psutil_linux' extension 00:58:23 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:58:23 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:58:23 INFO - building 'psutil._psutil_posix' extension 00:58:23 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:58:23 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:58:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:58:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:58:24 INFO - Successfully installed psutil 00:58:24 INFO - Cleaning up... 00:58:24 INFO - Return code: 0 00:58:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fb613c97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e646c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f256e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ba90>, '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 0x1fadf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fae2e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', '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:58:24 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:58:24 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:58:24 INFO - Using env: {'DISPLAY': ':0', 00:58:24 INFO - 'HOME': '/home/cltbld', 00:58:24 INFO - 'LANG': 'en_US.UTF-8', 00:58:24 INFO - 'LANGUAGE': 'en_US:en', 00:58:24 INFO - 'LOGNAME': 'cltbld', 00:58:24 INFO - 'MAIL': '/var/mail/cltbld', 00:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:24 INFO - 'MOZ_NO_REMOTE': '1', 00:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:24 INFO - 'NO_EM_RESTART': '1', 00:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:58:24 INFO - 'PWD': '/builds/slave/test-pgo', 00:58:24 INFO - 'SHELL': '/bin/bash', 00:58:24 INFO - 'SHLVL': '1', 00:58:24 INFO - 'TERM': 'linux', 00:58:24 INFO - 'TMOUT': '86400', 00:58:24 INFO - 'USER': 'cltbld', 00:58:24 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', 00:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:24 INFO - '_': '/tools/buildbot/bin/python'} 00:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:58:24 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:58:24 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:58:24 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:58:24 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:58:24 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:58:24 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:58:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:58:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:58:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:58:26 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:58:26 INFO - Installing collected packages: mozsystemmonitor 00:58:26 INFO - Running setup.py install for mozsystemmonitor 00:58:26 INFO - Successfully installed mozsystemmonitor 00:58:26 INFO - Cleaning up... 00:58:26 INFO - Return code: 0 00:58:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:26 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 0x7fb613c97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e646c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f256e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ba90>, '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 0x1fadf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fae2e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', '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:58:26 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:58:26 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:58:26 INFO - Using env: {'DISPLAY': ':0', 00:58:26 INFO - 'HOME': '/home/cltbld', 00:58:26 INFO - 'LANG': 'en_US.UTF-8', 00:58:26 INFO - 'LANGUAGE': 'en_US:en', 00:58:26 INFO - 'LOGNAME': 'cltbld', 00:58:26 INFO - 'MAIL': '/var/mail/cltbld', 00:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:26 INFO - 'MOZ_NO_REMOTE': '1', 00:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:26 INFO - 'NO_EM_RESTART': '1', 00:58:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:58:26 INFO - 'PWD': '/builds/slave/test-pgo', 00:58:26 INFO - 'SHELL': '/bin/bash', 00:58:26 INFO - 'SHLVL': '1', 00:58:26 INFO - 'TERM': 'linux', 00:58:26 INFO - 'TMOUT': '86400', 00:58:26 INFO - 'USER': 'cltbld', 00:58:26 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', 00:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:26 INFO - '_': '/tools/buildbot/bin/python'} 00:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:26 INFO - Downloading/unpacking blobuploader==1.2.4 00:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:58:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:58:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:58:28 INFO - Downloading blobuploader-1.2.4.tar.gz 00:58:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:58:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:58:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:58:28 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:58:28 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:58:28 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:58:28 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:58:28 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:58:28 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:58:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:58:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:58:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:58:28 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:58:28 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:58:28 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:58:28 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:58:28 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:58:28 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:58:28 INFO - Downloading docopt-0.6.1.tar.gz 00:58:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:58:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:58:28 INFO - Installing collected packages: blobuploader, requests, docopt 00:58:28 INFO - Running setup.py install for blobuploader 00:58:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:58:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:58:28 INFO - Running setup.py install for requests 00:58:29 INFO - Running setup.py install for docopt 00:58:29 INFO - Successfully installed blobuploader requests docopt 00:58:29 INFO - Cleaning up... 00:58:29 INFO - Return code: 0 00:58:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:58:29 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:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:29 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:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:29 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 0x7fb613c97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e646c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f256e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ba90>, '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 0x1fadf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fae2e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', '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:58:29 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:58:29 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:58:29 INFO - Using env: {'DISPLAY': ':0', 00:58:29 INFO - 'HOME': '/home/cltbld', 00:58:29 INFO - 'LANG': 'en_US.UTF-8', 00:58:29 INFO - 'LANGUAGE': 'en_US:en', 00:58:29 INFO - 'LOGNAME': 'cltbld', 00:58:29 INFO - 'MAIL': '/var/mail/cltbld', 00:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:29 INFO - 'MOZ_NO_REMOTE': '1', 00:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:29 INFO - 'NO_EM_RESTART': '1', 00:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:58:29 INFO - 'PWD': '/builds/slave/test-pgo', 00:58:29 INFO - 'SHELL': '/bin/bash', 00:58:29 INFO - 'SHLVL': '1', 00:58:29 INFO - 'TERM': 'linux', 00:58:29 INFO - 'TMOUT': '86400', 00:58:29 INFO - 'USER': 'cltbld', 00:58:29 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', 00:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:29 INFO - '_': '/tools/buildbot/bin/python'} 00:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:58:29 INFO - Running setup.py (path:/tmp/pip-AxzIbO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:58:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:58:29 INFO - Running setup.py (path:/tmp/pip-llqnUr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:58:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:58:29 INFO - Running setup.py (path:/tmp/pip-WFLUrY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:58:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:58:29 INFO - Running setup.py (path:/tmp/pip-C6Z3iN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:58:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:58:29 INFO - Running setup.py (path:/tmp/pip-24G1Bh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:58:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:58:30 INFO - Running setup.py (path:/tmp/pip-aWKba8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:58:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:58:30 INFO - Running setup.py (path:/tmp/pip-Ii6NgF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:58:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:58:30 INFO - Running setup.py (path:/tmp/pip-GZ_uL5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:58:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:58:30 INFO - Running setup.py (path:/tmp/pip-YsQHnF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:58:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:58:30 INFO - Running setup.py (path:/tmp/pip-9Er8Bj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:58:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:58:30 INFO - Running setup.py (path:/tmp/pip-p1L9nV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:58:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:58:30 INFO - Running setup.py (path:/tmp/pip-_uoasN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:58:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:58:30 INFO - Running setup.py (path:/tmp/pip-CYYtkA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:58:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:58:30 INFO - Running setup.py (path:/tmp/pip-gR80O4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:58:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:58:30 INFO - Running setup.py (path:/tmp/pip-WDlIr4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:58:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:58:30 INFO - Running setup.py (path:/tmp/pip-e6xVcF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:58:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:58:30 INFO - Running setup.py (path:/tmp/pip-8bbwOj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:58:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:58:30 INFO - Running setup.py install for manifestparser 00:58:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:58:30 INFO - Running setup.py install for mozcrash 00:58:31 INFO - Running setup.py install for mozdebug 00:58:31 INFO - Running setup.py install for mozdevice 00:58:31 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:58:31 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:58:31 INFO - Running setup.py install for mozfile 00:58:31 INFO - Running setup.py install for mozhttpd 00:58:31 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:58:31 INFO - Running setup.py install for mozinfo 00:58:31 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:58:31 INFO - Running setup.py install for mozInstall 00:58:31 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:58:31 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:58:31 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:58:31 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:58:31 INFO - Running setup.py install for mozleak 00:58:31 INFO - Running setup.py install for mozlog 00:58:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:58:31 INFO - Running setup.py install for moznetwork 00:58:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:58:32 INFO - Running setup.py install for mozprocess 00:58:32 INFO - Running setup.py install for mozprofile 00:58:32 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:58:32 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:58:32 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:58:32 INFO - Running setup.py install for mozrunner 00:58:32 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:58:32 INFO - Running setup.py install for mozscreenshot 00:58:32 INFO - Running setup.py install for moztest 00:58:32 INFO - Running setup.py install for mozversion 00:58:32 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:58:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:58:32 INFO - Cleaning up... 00:58:32 INFO - Return code: 0 00:58:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:58:32 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:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:32 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:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:32 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 0x7fb613c97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e646c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f256e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ba90>, '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 0x1fadf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fae2e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', '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:58:32 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:58:32 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:58:32 INFO - Using env: {'DISPLAY': ':0', 00:58:32 INFO - 'HOME': '/home/cltbld', 00:58:32 INFO - 'LANG': 'en_US.UTF-8', 00:58:32 INFO - 'LANGUAGE': 'en_US:en', 00:58:32 INFO - 'LOGNAME': 'cltbld', 00:58:32 INFO - 'MAIL': '/var/mail/cltbld', 00:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:32 INFO - 'MOZ_NO_REMOTE': '1', 00:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:32 INFO - 'NO_EM_RESTART': '1', 00:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:58:32 INFO - 'PWD': '/builds/slave/test-pgo', 00:58:32 INFO - 'SHELL': '/bin/bash', 00:58:32 INFO - 'SHLVL': '1', 00:58:32 INFO - 'TERM': 'linux', 00:58:32 INFO - 'TMOUT': '86400', 00:58:32 INFO - 'USER': 'cltbld', 00:58:32 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', 00:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:32 INFO - '_': '/tools/buildbot/bin/python'} 00:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:58:32 INFO - Running setup.py (path:/tmp/pip-jeRbHD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:58:32 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:58:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:58:32 INFO - Running setup.py (path:/tmp/pip-2eAHTG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:58:33 INFO - Running setup.py (path:/tmp/pip-YXON0M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:58:33 INFO - Running setup.py (path:/tmp/pip-MzZAZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:58:33 INFO - Running setup.py (path:/tmp/pip-_v2WfS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:58:33 INFO - Running setup.py (path:/tmp/pip-t42B8A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:58:33 INFO - Running setup.py (path:/tmp/pip-A7rmln-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:58:33 INFO - Running setup.py (path:/tmp/pip-QA9VQe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:58:33 INFO - Running setup.py (path:/tmp/pip-rlLDHR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:58:33 INFO - Running setup.py (path:/tmp/pip-ZabWIB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:58:33 INFO - Running setup.py (path:/tmp/pip-pmZjVH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:58:33 INFO - Running setup.py (path:/tmp/pip-7ruvKi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:58:33 INFO - Running setup.py (path:/tmp/pip-wDaPAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:58:33 INFO - Running setup.py (path:/tmp/pip-rxdi9j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:58:33 INFO - Running setup.py (path:/tmp/pip-Yxmgyd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:58:33 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:58:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:58:33 INFO - Running setup.py (path:/tmp/pip-TsIT1H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:58:34 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:58:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:58:34 INFO - Running setup.py (path:/tmp/pip-Qc0G9E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:58:34 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:58:34 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:58:34 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:58:34 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:58:34 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:58:34 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:58:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:58:34 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:58:34 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:58:34 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:58:34 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:58:34 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:58:34 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:58:35 INFO - Downloading blessings-1.5.1.tar.gz 00:58:35 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:58:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:58:35 INFO - Installing collected packages: blessings 00:58:35 INFO - Running setup.py install for blessings 00:58:35 INFO - Successfully installed blessings 00:58:35 INFO - Cleaning up... 00:58:35 INFO - Return code: 0 00:58:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:58:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:58:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:58:36 INFO - Reading from file tmpfile_stdout 00:58:36 INFO - Current package versions: 00:58:36 INFO - argparse == 1.2.1 00:58:36 INFO - blessings == 1.5.1 00:58:36 INFO - blobuploader == 1.2.4 00:58:36 INFO - docopt == 0.6.1 00:58:36 INFO - manifestparser == 1.1 00:58:36 INFO - mozInstall == 1.12 00:58:36 INFO - mozcrash == 0.16 00:58:36 INFO - mozdebug == 0.1 00:58:36 INFO - mozdevice == 0.47 00:58:36 INFO - mozfile == 1.2 00:58:36 INFO - mozhttpd == 0.7 00:58:36 INFO - mozinfo == 0.9 00:58:36 INFO - mozleak == 0.1 00:58:36 INFO - mozlog == 3.0 00:58:36 INFO - moznetwork == 0.27 00:58:36 INFO - mozprocess == 0.22 00:58:36 INFO - mozprofile == 0.27 00:58:36 INFO - mozrunner == 6.11 00:58:36 INFO - mozscreenshot == 0.1 00:58:36 INFO - mozsystemmonitor == 0.0 00:58:36 INFO - moztest == 0.7 00:58:36 INFO - mozversion == 1.4 00:58:36 INFO - psutil == 3.1.1 00:58:36 INFO - requests == 1.2.3 00:58:36 INFO - wsgiref == 0.1.2 00:58:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:58: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:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:36 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 0x7fb613c97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e646c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f256e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ba90>, '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 0x1fadf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fae2e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', '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:58:36 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:58:36 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:58:36 INFO - Using env: {'DISPLAY': ':0', 00:58:36 INFO - 'HOME': '/home/cltbld', 00:58:36 INFO - 'LANG': 'en_US.UTF-8', 00:58:36 INFO - 'LANGUAGE': 'en_US:en', 00:58:36 INFO - 'LOGNAME': 'cltbld', 00:58:36 INFO - 'MAIL': '/var/mail/cltbld', 00:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:36 INFO - 'MOZ_NO_REMOTE': '1', 00:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:36 INFO - 'NO_EM_RESTART': '1', 00:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:58:36 INFO - 'PWD': '/builds/slave/test-pgo', 00:58:36 INFO - 'SHELL': '/bin/bash', 00:58:36 INFO - 'SHLVL': '1', 00:58:36 INFO - 'TERM': 'linux', 00:58:36 INFO - 'TMOUT': '86400', 00:58:36 INFO - 'USER': 'cltbld', 00:58:36 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', 00:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:36 INFO - '_': '/tools/buildbot/bin/python'} 00:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:36 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:58:36 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:58:36 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:58:36 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:58:36 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:58:36 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:58:36 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:58:36 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:58:36 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:58:36 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:58:36 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:58:36 INFO - Cleaning up... 00:58:36 INFO - Return code: 0 00:58:36 INFO - Running post-action listener: _resource_record_post_action 00:58:36 INFO - Running post-action listener: _start_resource_monitoring 00:58:36 INFO - Starting resource monitoring. 00:58:36 INFO - ##### 00:58:36 INFO - ##### Running install step. 00:58:36 INFO - ##### 00:58:36 INFO - Running pre-action listener: _resource_record_pre_action 00:58:36 INFO - Running main action method: install 00:58:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:58:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:58:36 INFO - Reading from file tmpfile_stdout 00:58:36 INFO - Detecting whether we're running mozinstall >=1.0... 00:58:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:58:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:58:36 INFO - Reading from file tmpfile_stdout 00:58:36 INFO - Output received: 00:58:36 INFO - Usage: mozinstall [options] installer 00:58:36 INFO - Options: 00:58:36 INFO - -h, --help show this help message and exit 00:58:36 INFO - -d DEST, --destination=DEST 00:58:36 INFO - Directory to install application into. [default: 00:58:36 INFO - "/builds/slave/test-pgo"] 00:58:36 INFO - --app=APP Application being installed. [default: firefox] 00:58:36 INFO - mkdir: /builds/slave/test-pgo/build/application 00:58:36 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:58:36 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:58:51 INFO - Reading from file tmpfile_stdout 00:58:51 INFO - Output received: 00:58:51 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:58:51 INFO - Running post-action listener: _resource_record_post_action 00:58:51 INFO - ##### 00:58:51 INFO - ##### Running run-tests step. 00:58:51 INFO - ##### 00:58:51 INFO - Running pre-action listener: _resource_record_pre_action 00:58:51 INFO - Running main action method: run_tests 00:58:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:58:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:58:51 INFO - Python 2.7.3 00:58:51 INFO - Return code: 0 00:58:51 INFO - grabbing minidump binary from tooltool 00:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:58:51 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 0x1f5ba90>, '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 0x1fadf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fae2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:58:51 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:58:51 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:58:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:58:51 INFO - Return code: 0 00:58:51 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:58:51 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:58:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:58:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:58:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:58:51 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/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 00:58:51 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/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost 00:58:51 INFO - Using env: {'DISPLAY': ':0', 00:58:51 INFO - 'HOME': '/home/cltbld', 00:58:51 INFO - 'LANG': 'en_US.UTF-8', 00:58:51 INFO - 'LANGUAGE': 'en_US:en', 00:58:51 INFO - 'LOGNAME': 'cltbld', 00:58:51 INFO - 'MAIL': '/var/mail/cltbld', 00:58:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:58:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:51 INFO - 'MOZ_NO_REMOTE': '1', 00:58:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:51 INFO - 'NO_EM_RESTART': '1', 00:58:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:58:51 INFO - 'PWD': '/builds/slave/test-pgo', 00:58:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:58:51 INFO - 'SHELL': '/bin/bash', 00:58:51 INFO - 'SHLVL': '1', 00:58:51 INFO - 'TERM': 'linux', 00:58:51 INFO - 'TMOUT': '86400', 00:58:51 INFO - 'USER': 'cltbld', 00:58:51 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985', 00:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:51 INFO - '_': '/tools/buildbot/bin/python'} 00:58:51 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/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] with output_timeout 3600 00:58:51 INFO - mozversion INFO | application_buildid: 20151118233011 00:58:51 INFO - mozversion INFO | application_changeset: 3c747d782958267e847037c20fa37e14abc4de6c 00:58:51 INFO - mozversion INFO | application_display_name: Nightly 00:58:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:58:51 INFO - mozversion INFO | application_name: Firefox 00:58:51 INFO - mozversion INFO | application_remotingname: firefox 00:58:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 00:58:51 INFO - mozversion INFO | application_vendor: Mozilla 00:58:51 INFO - mozversion INFO | application_version: 45.0a1 00:58:51 INFO - mozversion INFO | platform_buildid: 20151118233011 00:58:51 INFO - mozversion INFO | platform_changeset: 3c747d782958267e847037c20fa37e14abc4de6c 00:58:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 00:58:51 INFO - mozversion INFO | platform_version: 45.0a1 00:58:51 INFO - 2015-11-19 00:58:51,402 DEBUG : using testdate: 1447923531 00:58:51 INFO - 2015-11-19 00:58:51,402 DEBUG : actual date: 1447923531 00:58:51 INFO - 2015-11-19 00:58:51,483 INFO : starting webserver on 'localhost:46912' 00:58:51 INFO - 2015-11-19 00:58:51,484 INFO : Starting test suite talos-linux64-ix-020 00:58:51 INFO - 2015-11-19 00:58:51,484 INFO : Starting test dromaeo_css 00:58:51 INFO - 2015-11-19 00:58:51,484 DEBUG : operating with platform_type : linux_ 00:58:51 INFO - 2015-11-19 00:58:51,485 INFO : Initialising browser for dromaeo_css test... 00:58:51 INFO - 2015-11-19 00:58:51,498 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1yYu4E/profile http://localhost:46912/getInfo.html 00:58:56 INFO - 2015-11-19 00:58:56,145 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:58:56 INFO - 2015-11-19 00:58:56,145 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:58:56 INFO - 2015-11-19 00:58:56,145 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:58:56 INFO - 2015-11-19 00:58:56,146 DEBUG : BROWSER_OUTPUT: __metrics 00:58:56 INFO - 2015-11-19 00:58:56,307 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:58:57 INFO - 2015-11-19 00:58:57,767 INFO : Browser initialized. 00:58:57 INFO - 2015-11-19 00:58:57,768 INFO : Running cycle 1/1 for dromaeo_css test... 00:58:57 INFO - 2015-11-19 00:58:57,768 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1yYu4E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:59:09 INFO - 2015-11-19 00:59:09,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 139841536 00:59:09 INFO - 2015-11-19 00:59:09,546 DEBUG : BROWSER_OUTPUT: 01:00:01 INFO - 2015-11-19 01:00:01,225 DEBUG : BROWSER_OUTPUT: 1447923601219 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] 01:02:09 INFO - 2015-11-19 01:02:09,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46912/tests/dromaeo/cssquery-ext.html) 01:02:11 INFO - 2015-11-19 01:02:11,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 304889856 01:02:11 INFO - 2015-11-19 01:02:11,288 DEBUG : BROWSER_OUTPUT: 01:05:13 INFO - 2015-11-19 01:05:13,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/dromaeo/cssquery-ext.html (next: http://localhost:46912/tests/dromaeo/cssquery-jquery.html) 01:05:14 INFO - 2015-11-19 01:05:14,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 223203328 01:05:14 INFO - 2015-11-19 01:05:14,245 DEBUG : BROWSER_OUTPUT: 01:08:16 INFO - 2015-11-19 01:08:16,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46912/tests/dromaeo/cssquery-mootools.html) 01:08:16 INFO - 2015-11-19 01:08:16,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 218189824 01:08:16 INFO - 2015-11-19 01:08:16,771 DEBUG : BROWSER_OUTPUT: 01:11:18 INFO - 2015-11-19 01:11:18,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46912/tests/dromaeo/cssquery-prototype.html) 01:11:19 INFO - 2015-11-19 01:11:19,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 199819264 01:11:19 INFO - 2015-11-19 01:11:19,190 DEBUG : BROWSER_OUTPUT: 01:14:21 INFO - 2015-11-19 01:14:21,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46912/tests/dromaeo/cssquery-yui.html) 01:14:22 INFO - 2015-11-19 01:14:22,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 204697600 01:14:22 INFO - 2015-11-19 01:14:22,272 DEBUG : BROWSER_OUTPUT: 01:17:24 INFO - 2015-11-19 01:17:24,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/dromaeo/cssquery-yui.html (next: http://localhost:46912/tests/dromaeo/cssquery-dojo.html) 01:17:24 INFO - 2015-11-19 01:17:24,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 247693312 01:17:24 INFO - 2015-11-19 01:17:24,881 DEBUG : BROWSER_OUTPUT: 01:17:24 INFO - 2015-11-19 01:17:24,882 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:17:24 INFO - 2015-11-19 01:17:24,882 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:17:24 INFO - 2015-11-19 01:17:24,883 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:17:24 INFO - 2015-11-19 01:17:24,883 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:17:24 INFO - 2015-11-19 01:17:24,884 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3156.7790254682172;3178.809271443712;3214.5338925855735;3230.4346739320613;3235.7573182011356;5193.974030129844;5289.391719952202;5302.337207849019;5302.469753024696;5319.122344813101;5353.5984801139975;5410.026195284847;5436.401995780471;5468.7539060742265;5478.643888147268;4878.829240976566;4983.152864013126;5000.874978125557;5059.392872855244;5062.544371006608;4958.132326842806;5045.772940217699;5105.719185444799;5105.948940510603;5110.310108135392;4837.105135549935;4883.413990321149;4953.306537084811;4980.103581355373;4982.825601103962;4882.365292511986;5006.299118123466;5015.774290156952;5019.272205530177;5024.145895197825;4941.678790878582;4946.653734238605;4952.727599981999;4964.379452568429;4999;5117.48825117489;5181.637285390024;5246.160614301732;5254.527092561688;5269.604779641504;5836.795712150097;5846.50304724099;5850.268716410449;5852.297724273115;5858.619189752652;5771.538276937877;5859.7949071782705;5865.120231965197;5866.530677545786;5893.44012318829;5502.5597952163735;5503.854694244147;5506.752196151183;5510.779568817283;5553.750081246354;5772.249607550992;5974.641521508724;5981.342052374235;5983.1623572699855;5989.191459153046;5652.293463317085;5701.914471282934;5703.916255911364;5726.828195154152;5752.769889204469;5826.329972053268;5861;5866.296044474605;5866.882662346729;5872.58891877573;5666.773329066874;5801.216835727208;5804.187413762077;5805.796797112081;5821.767129314865;5754.712264386764;5829.679367634821;5839.9124013139835;5848.385919478394;5892.1161825726485;4447.7998490067375;4456.108778244299;4483.170613436525;4488.349189367524;4523.411956445641;3914.9608503915165;3924.3328634132267;3993.940090898639;4039.111395492987;4047.514298284225;5515.862103447365;5547.805826796042;5550.139728342114;5553.694546799965;5557.5553955683445;5863.413658634187;5868.383819698955;5873.706314684248;5880.764769409176;5881.676507792027;5339.359276886798;5453.372862120907;5455.372632147274;5535.169724541271;5584.357798853102;5098.515641014098;5108.489151084936;5110.207917772751;5110.744462776846;5128.820491282787;6060.939390606038;6076.0278355462915;6076.3316035236085;6077.969610152098;6082.787102451482;5628.212050312877;5749.856253593526;5805.622634528742;5955.315138759098;5957.880842383215;6058.242719660043;6060.363661815446;6061.060535616986;6069.423404776539;6069.757209711739;5797.913031304618;5798.768049277982;5803.883922321615;5807.912881306868;5809.477147056785;5714.114312281603;5821.126830975388;5832.096025116114;5836.795712150054;5842.123681447647;5663.2071509989455;5665.405132461032;5670.546356291569;5672.43275672446;5674.77300907959;5681.914771278517;5686.829395118153;5692.48767610917;5692.886142277049;5827.5629327801435;5644.350899646429;5645.068563686946;5651.067573850269;5651.915221271602;5682.0340542107115;5720.542356611378;5739.253896993531;5752.9712351437975;5754.165645981226;5793.333766616893;5428.45715428454;5565.666060036411;5575.358833734173;5661.57538184646;5726.0838265877255 01:17:24 INFO - 2015-11-19 01:17:24,888 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.5610868288213;600.9068594367873;605.1165298663951;612.9049997250424;614.0635530815503;29788.40423191535;30414.847925760394;30421.087367378987;30433.695663043363;40646.593534064654;42353;42647.36028959561;42741.572584274145;42817;42883.499077532295;8760.255378292837;8945.105489451067;8949.731508054736;8949.910500894974;8950.910490895105;7660.885086723703;7819.843603127934;10443.373397596131;10628.574857005711;10647.254692171513;10364.689059328231;10436.165106791439;10454.947725261363;10485.370877747322;10496;7820.765377038698;8019.15798841125;10337.844932326021;10436;10443.26897117206;10355.119814815675;10531.104856087242;10598.576056957712;10610.098141657969;10610.840837387444;40893.79553102245;40911.59088409108;41305.586944130475;41364.37953430701;41408.1718365631;3336.9499457508155;3368.6294507604143;3400.863965441379;3406.097384193191;3742.438634204891;30032;30711.38577228443;31098.37803243945;31289.217769555715;32083.197920051953;3519.7184225261917;3616.9095772605633;3637.308911306843;3651.434027725707;3661.8901432957055;271669;273167;273208;274035;274052;52784;53768;58987;59438;59477;64053;64940.35059649343;65224.34775652277;65242.67378663076;65295.347046529874;15790.763138552931;15855.762163567555;15957.840421595867;15978.920105399398;15990.920045399698;12391.566295179626;12471.812922806164;12472.563460278847;12474.126811123135;12477.31374774378;19313.227470901005;19548.759538172562;19566.5108372289;20071.698924516142;20106.798932010784;7439.702411903571;7605.581693006938;7665.6550455228535;7676.155622881479;7810.804729881685;885.9158379953894;907.8728977943093;932.2588542109039;1024.7540590258434;1118.4128332625437;26037.609435858478;26255.920413784872;26596.734032659813;26687.19938401851;26761.866190669312;1018.4754851251612;1032.2206733915996;1055.488088277185;1059.655611926127;1062.6493257225097;14155.29223538819;14313.499027533986;14530.128192308495;14592.343344549521;14610.26948652563;478704;489293;490202;495836;496582;51525.227121593205;52188;52194.739026304625;52279;52327;1327.2965328375976;1329.634350553586;1341.9530316438877;1344.8856847167904;1347.1176379471658;28112.43775124527;28818;29103.41793164167;29177.7082229175;29181.270468238465;44164.77917610391;44793.55206448024;46246.53753462557;46511;46700.532994670975;294480;296013;298434;299275;300768;29582;29902.25244368908;30304.54543181898;30546.389072218877;30593.847030764704;39888.401673975495;40009.79995100006;40311.59688403078;40908.1818363637;41133.58866411298;34175.829120854236;34600.653993459746;35014.64985350216;37082.25835483329;37115;37672.74531695819;37755.62244377521;37935;38106.56327444236;38588.80705596454;36274.455883161245;37072.258554828215;37232.25535489221;37237;37415.25169496649;32043.519347210276;32503;33505;34396.82801585976;34509.13727156841;25656.230313090637;25917.6112358311;25939.481210376063;26029;26131.73868261293 01:17:24 INFO - 2015-11-19 01:17:24,889 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.35674963440636;359.9622039685833;360.6411620437665;362.6446082838818;364.1569765991727;16680.582985425357;17402.216900239502;18343.816561834377;18380.90809545952;18395.172217250223;16968.575785605368;17066.82933170668;17286.654266914684;17456.650866982684;17493.212805423755;5262.763175657095;5316.388615309231;5440.183972404151;5448.700321482317;5449.7275136243225;5405.486478784529;5446.591505637073;5452.6183167178315;5453.781848726066;5453.863653408657;3522.1546828761043;3574.767640103385;4705.600023997964;5400.91898621521;5403.324584426947;4852.708837469763;4967.850964471072;4994.126027945095;4999.875003124915;5002.1496345621335;4239.406483092339;4318.179545886272;4318.805653745589;4318.805653745589;4321.891952701176;11497.080233581293;11851.644450666494;13096.34518274092;13414.396352164176;13553;1829.8078701736392;2043.6832290994919;2112.450762801667;2216.3240211735415;2361.8346715729904;9674.661386851427;9680.27397945157;9826.115649591571;9893.15908147801;10019.248556358229;1670.0564181237562;1673.1299724143378;1680.4370535870498;1698.108493041151;1754.0878743053668;58839.41160588425;58873;59901;61830.690846545476;62623.37376626221;6918.93081069193;7035.190953040364;7090.964545177344;7118.466115041392;7153.284671532805;8530.616122274512;8532.829343413097;8533.957330213434;8539.829203415897;8545.786355341166;5707.6290041147195;5716.514096301861;5742.425757424224;5772.018756811352;5802.33273173582;5919.852003699942;5925.881482370329;5941.22764040672;5952.434518720715;5972.372900845348;3293.390722716305;3306.057773534531;3314.8011119332436;3333.866645334208;3344.4648856182894;1150.9769804603861;1158.0735411670798;1158.4265788434611;1170.128254450423;1193.8539002557468;447.7224121044908;461.1307685013706;475.766874231624;475.9119562880878;481.12195243679724;10902.618408355669;11658.883411165949;11817.350045747566;11989.340586267665;12002.339871306987;473.9857804265878;492.59361027152744;494.0736119775421;502.7938545196452;505.4288653821159;5309.550353028614;6215;6313.40022697843;6472.029195620695;6498.155239818793;499373;499924;504736;510221;511239.20749114326;70392;71387.64306178539;72316;72862.27137728661;73662;537.1995726367762;540.5270388410141;540.9350877894599;541.1179776963525;542.9158480435539;11305;11555.4800033997;11663.416829158678;11701.941490292495;11738.823917641414;36095.097622559646;36336;36408.81795591005;36854.8157259212;36870.07824804401;47155;47527.04945900993;49064.75467622639;49319.780609873356;49373.25940110829;6931.549449285781;7003.5797852129035;7044.647767611496;7048.823779405556;7053.717851285891;11926.940365298118;12466.812997805222;12531.436085375997;12559.93720031394;12578.245305281713;10625.415602141957;10715.142788576739;10747.408892510986;10809.56761729522;10983.286086404358;10484.423356715453;10611.2041596879;10821.891781082088;10834;11062.557497700323;9031.593578289125;9215.078492150731;10471.267011309135;10904.727381815517;10973.122150227802;6729.730810767514;6761.695723692544;6883.483738719716;6892.827679308058;6892.827679308058;10385.740356490845;10504.054635082879;10918.563257469612;10921.399323037309;11054.834177487182 01:17:24 INFO - 2015-11-19 01:17:24,892 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1307.1960744142355;1452.1650051220552;1479.541342183923;1742.8692848036396;1815.9182836772347;6625.204975402952;7310.707571697132;7430.219826918177;7436.5166264192785;7440.888386674204;7417.740379086733;7468.738594149206;7523.962380188092;7524.962375188116;7532.698692052325;1985.7617085949705;2015.4457524180893;2018.1927229108328;2243.102758896442;2269.5914735347633;2266.05958527211;2298.4139044543617;2312.2600767754325;2312.9653055204103;2317.304808557426;2209.425549357171;2210.06072419222;2264.8867556622104;2266.693996310502;2268.8638681679067;1985.8609897307122;2028.9391318260402;2172.4894649757293;2208.182972300243;2254.087094726622;2230.052227803177;2256.029907139929;2265.66015097735;2267.7618850020676;2278.327893271489;7505.286997735207;7515.361194298491;7566.16772155068;7590.3548198403205;7593.392528597754;4476.776161191928;4593.150267200579;4605.746683932382;4614.792334344929;4617.30740388941;3196.9040928772174;3202.471592187286;3205.7275131613605;3256.7231785298277;3278.983605081983;1167.8365028895962;1867.421099459172;1902.6384986852593;1915.808419158087;1915.8467322614158;10224.13094886928;10346.275760696753;10348.741281468023;10352.120069794002;10359.482025898751;4137.358709400048;4141.316682747373;4204.516480604709;4224.408582798411;4266.146770645883;8427.705030324032;8443.746687599381;8445.282151017233;8448.915510844936;8456.02755683092;4665.136949664323;4676.5791078802395;4679.110968915895;4688.343631891538;4706.599939005223;4252.340887162495;4255.702100852973;4279.101388708344;4279.914401711948;4294.119705460374;3483.1292176955762;3507.228409749851;3520.612732599412;3521.876734314338;3547.3260080584605;1051.117061668187;1052.9631462898762;1059.390850261103;1064.297563608015;1066.5040756048475;1337.2444568818587;1339.189790176929;1359.3950691942189;1367.43934986655;1372.1492674541648;6547.869042619216;7018.017477553147;7340.743073992385;7361.079865016873;7376.151742549569;684.4045680258207;686.289690170671;693.7121094745725;703.2124021096303;717.178830239373;5597.244372009808;5649.576281778883;5655.349634791969;5671.120976248688;5679.744411501492;8880.200781929658;8926.955365223132;9020.684276050439;9094.090590940854;9235.1688348049;8928.419652722552;8999.82000359989;9102;9148;9154.86267705985;7071.29287071299;7079.371744498691;7111.9063207504905;7114.715411383487;7155.284471552907;6858.897116543156;6881.827954301182;6888.173419189729;6894.413974812197;6896.413804826445;7812.726554570563;7938.04743430792;8178.059523154913;8190.894229279209;8195.754127376189;8059.758207253792;8251.422400431911;8257.050439199329;8380.53907035119;8392.496450213006;6912.4815638828295;6913;6971.9651401744695;6984.895226571707;6993.545419547713;7528.247175282428;7576.696932122653;7582.393408527415;7584.582847943196;7588.203238659861;6978.68595913175;7075.6815943281645;7078.4691148163065;7194.064771579661;7197.71209151628;6932.861342773217;7026.683799228945;7046.436285097077;7112.537685050455;7144.678489467882;6488.221413430419;6925.757598484029;6928.861422771617;6975.651217439006;7036.9296307036275;6362.840928976812;6425.614463132227;6427.646479443489;6443.162388889415;6446.903296450463;6347.746090156526;6393.7122829471855;6407.038944158227;6422.036694495863;6479.384458476437 01:17:24 INFO - 2015-11-19 01:17:24,892 DEBUG : BROWSER_OUTPUT: |4;prototype.html;332.5676620393488;335.1804837173111;336.5507048090799;339.84197348233073;342.34270201213684;5939.85150371241;5947.226860508139;6083.300420451649;6094.268687757475;6116.204893363856;5828.650280983144;5976.282846058468;5980.1926739890105;5993.640381577108;6007.789727359544;4626.167289887827;4653.8836529086875;4654.813022679229;4655.837045703401;4660.16117098922;4417.31531612599;4457.219986502365;4518.615917647004;4523.977380113095;4653.278741795028;4457.10857828434;4459.620932220765;4470.530594287602;4522.5025247222775;4533.614642755353;4534.251848445003;4535.841245556389;4546.20441422753;4547.04512052471;4556.157110934455;3972.066564357374;3978.6817054635558;3982.4424580558743;3985.06351007513;3985.143194213258;5572.192032155355;5685.715714214272;5702.7433765480655;5725.341585717654;5731.484166425042;5303.920441193385;5313;5313.734313284321;5324.653897496689;5325.973370133163;6140.385961403868;6390.233172019387;6398.360163983611;6404.775832845875;6427.035944608299;4322.157179350028;4351;4433.401490798733;4433.445819272591;4437.800298986521;6596.340365963413;6634.838903191922;6655.600663960129;6663.13379260693;6677.964915438066;4502.122086193226;4502.3921770560555;4504.909901801946;4505.954940450619;4509.210888094571;4394.956050439455;4519.932201016987;4558.817647294071;4561.315802629632;4572.45130584332;5284.445133261029;5289.576833853283;5290.523852853262;5294;5298.867528311823;6424.839379015562;6427.807165785034;6431.099646049557;6433.067205255212;6435.034744788226;1590.5943984284165;1601.303433006646;1601.5675767542698;1603.2384617306918;1603.7353836616828;1054.7679510507676;1066.6959916423782;1070.55571937645;1071.0628200324716;1096.0135877710125;6196.783112591128;6218.440340369389;6241.594296370721;6256.718447669866;6260.499160067275;6552.672366381662;6596.406323430914;6621.139251897319;6637.435817955527;6638.834029149213;6122.326544080237;6213.192285003011;6223.190985171898;6236.812895613139;6250.312465628777;3580.946285805715;3607.7654952428006;3611.29579731955;3611.494390785292;3612.4039533477207;6824.0446337512785;6846.657667116624;6848.828779280459;6855.314468553105;6859.314068593101;6638.96680516604;6787.185537735503;6791.898121528181;6795.592264464148;6797.66011699423;6832.282610325944;6868.862622747617;6869.0383346331555;6871.278515755874;6872.484563657646;6365.9681701593045;6483.384078512534;6484.805455836333;6632.436242919213;6632.568883022588;6521.282658907421;6540.607563546202;6545.410913017851;6550.148480697479;6557.639329836905;6895.6552172390175;6899.551529150589;6907.033015377951;6912.135983002125;6915.446764258948;4309.84915527955;4445.977425192159;4446.866594002185;4457.398251236042;4479.955200448084;6613.867722645424;6614.338566143347;6619.139511863427;6621.569597976116;6622.966885165543;6366.3633636637815;6414.647194404166;6429.807105786646;6431.517636177212;6435.324290949383;6280.371962803866;6385.776497822554;6400.9039864403;6489.286178520265;6515.218173819172;6382.585131966407;6395.040743888454;6400.679966001774;6401.775937842153;6404.455621272244;6521.054447105238;6540.411362977355;6544;6544.934550654432;6551.6069035858;6202.162708034538;6352.237731472253;6378.2346118466085;6381.649009304347;6384.329645387167 01:17:24 INFO - 2015-11-19 01:17:24,894 DEBUG : BROWSER_OUTPUT: |5;yui.html;758.7609902880592;859.3468963587676;863.4775960543867;865.6667183134496;874.1171416868964;13679.521216757415;14053.367598458068;14060.789088163672;14063.156210627369;14078.577642670723;10842.078423334005;10845;10871.402072885989;11098.778024439507;11858.584949526768;668.9498287628423;796.9760907172765;819.8196396792725;820.2084987986592;821.2239433735123;819.8278361544083;820.4461988157999;823.4606332851992;824.47233770387;826.983460330793;703.5919166883195;717.0857157124682;856.6273670953155;866.1857853617611;866.1944391715701;840.23538579892;859.1623167411817;859.5315553023618;859.6776208921655;860.7848037990502;621.3972446726668;627.109504503606;628.1927722876082;630.3286999345682;634.4448607468465;12359.455068116486;12576.874231257661;12639.810402843965;12668.80996785049;12695.492180312776;12231.204971676812;12695.873041269562;12729.299888506128;12998.080766897696;13023.739525209538;10100.494975251282;10214.182865370827;10359.119474844647;10428.94785526075;10523.78952420955;3625.89122326328;3631.4371272452813;3637.1452708613456;3707.9814600927093;3798.525184351956;45061.54938450606;45895.54104458946;46174.53825461736;46271;46497.30254046192;9813.460259685644;9829.262805289633;9831.1643510301;9903.356281841658;10079.59681612742;17924.28302867897;17992.190351434216;18034.458966231035;18036.188371523313;18059.367922122663;7241.348278654947;7282.162551306667;7376.631168441557;7493.812654683567;7709.38324934004;4170.666346692257;4220.6412454941055;4275.935860962026;4279.87160385189;4317.460317460317;3023.516237402005;3083.599132112856;3091.2580980564503;3093.0875391759487;3095.1797773590015;443.6295693096236;457.33686155075276;457.43963644535177;462.1819379697983;473.28770200847504;543.9755211015514;560.8345538066199;561.5760101123707;635.8760041791807;656.0618315808345;7673.34776544;7954;8023.289896616252;8085;8150.673973041012;560.9130584759369;566.1931747260138;601.4767152577285;652.846581053452;697.166885571747;3804.8287827047848;3940.9556467535554;4014.7791871447353;4094.385842123705;4109.116539943926;56018.439815602134;57389;57427;57444;57466;49762.25356619654;50244.748776256616;50490.495095049315;51459.228111578355;51724.482755171965;44291.33562996558;44549.77725111353;45486;46488;46833.531664682916;8579.613917373608;8595.011573669108;8780.912190878265;8877.73366798997;8938.37431379797;32615;33206.83396583002;33350.833245833615;33633.15917102092;34176;42465.78767106268;42862;43849.56150438455;44500.33249501325;44556.108877821614;8511.91488085136;8582.313414926915;8772.819977117893;8828.911710882809;8837.337199709918;11914.285142891455;12094.334811585448;12146.514139434325;12315.137940344448;12558.309292988974;10793.730156746144;10915.727106822393;11072.557097716324;11137.94431027872;11176.944115279372;10799.892001079888;10907.181961352771;10910;10918.672439826818;10922.50848711794;10892;10970.616028438966;10986.835197471884;10993.725156871142;11008.559657613927;9858.852117218104;9910.851337229804;10084.243681723754;10085.142762865238;10416.843747343948;9361.578728957076;9366.2038726709;9438.85841712361;9523.809523809623;9526.142647161789 01:17:24 INFO - 2015-11-19 01:17:24,894 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:17:24 INFO - 2015-11-19 01:17:24,894 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:17:24 INFO - 2015-11-19 01:17:24,894 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1243 01:17:24 INFO - 2015-11-19 01:17:24,894 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:17:24 INFO - 2015-11-19 01:17:24,894 DEBUG : BROWSER_OUTPUT: __startTimestamp1447924644881__endTimestamp 01:17:24 INFO - 2015-11-19 01:17:24,894 DEBUG : BROWSER_OUTPUT: 01:17:24 INFO - 2015-11-19 01:17:24,894 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:17:24 INFO - 2015-11-19 01:17:24,894 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:17:24 INFO - 2015-11-19 01:17:24,894 DEBUG : BROWSER_OUTPUT: 01:17:24 INFO - 2015-11-19 01:17:24,895 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5418.94 Median:5651.92 stddev:608.32 (10.8%) stddev-sans-first:583.73 01:17:24 INFO - 2015-11-19 01:17:24,895 DEBUG : BROWSER_OUTPUT: Values: 3156.8 3178.8 3214.5 3230.4 3235.8 5194.0 5289.4 5302.3 5302.5 5319.1 5353.6 5410.0 5436.4 5468.8 5478.6 4878.8 4983.2 5000.9 5059.4 5062.5 4958.1 5045.8 5105.7 5105.9 5110.3 4837.1 4883.4 4953.3 4980.1 4982.8 4882.4 5006.3 5015.8 5019.3 5024.1 4941.7 4946.7 4952.7 4964.4 4999.0 5117.5 5181.6 5246.2 5254.5 5269.6 5836.8 5846.5 5850.3 5852.3 5858.6 5771.5 5859.8 5865.1 5866.5 5893.4 5502.6 5503.9 5506.8 5510.8 5553.8 5772.2 5974.6 5981.3 5983.2 5989.2 5652.3 5701.9 5703.9 5726.8 5752.8 5826.3 5861.0 5866.3 5866.9 5872.6 5666.8 5801.2 5804.2 5805.8 5821.8 5754.7 5829.7 5839.9 5848.4 5892.1 4447.8 4456.1 4483.2 4488.3 4523.4 3915.0 3924.3 3993.9 4039.1 4047.5 5515.9 5547.8 5550.1 5553.7 5557.6 5863.4 5868.4 5873.7 5880.8 5881.7 5339.4 5453.4 5455.4 5535.2 5584.4 5098.5 5108.5 5110.2 5110.7 5128.8 6060.9 6076.0 6076.3 6078.0 6082.8 5628.2 5749.9 5805.6 5955.3 5957.9 6058.2 6060.4 6061.1 6069.4 6069.8 5797.9 5798.8 5803.9 5807.9 5809.5 5714.1 5821.1 5832.1 5836.8 5842.1 5663.2 5665.4 5670.5 5672.4 5674.8 5681.9 5686.8 5692.5 5692.9 5827.6 5644.4 5645.1 5651.1 5651.9 5682.0 5720.5 5739.3 5753.0 5754.2 5793.3 5428.5 5565.7 5575.4 5661.6 5726.1 01:17:24 INFO - 2015-11-19 01:17:24,895 DEBUG : BROWSER_OUTPUT: 01:17:24 INFO - 2015-11-19 01:17:24,895 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51498.16 Median:18436.81 stddev:97090.62 (526.6%) stddev-sans-first:97287.64 01:17:24 INFO - 2015-11-19 01:17:24,896 DEBUG : BROWSER_OUTPUT: Values: 555.6 600.9 605.1 612.9 614.1 29788.4 30414.8 30421.1 30433.7 40646.6 42353.0 42647.4 42741.6 42817.0 42883.5 8760.3 8945.1 8949.7 8949.9 8950.9 7660.9 7819.8 10443.4 10628.6 10647.3 10364.7 10436.2 10454.9 10485.4 10496.0 7820.8 8019.2 10337.8 10436.0 10443.3 10355.1 10531.1 10598.6 10610.1 10610.8 40893.8 40911.6 41305.6 41364.4 41408.2 3336.9 3368.6 3400.9 3406.1 3742.4 30032.0 30711.4 31098.4 31289.2 32083.2 3519.7 3616.9 3637.3 3651.4 3661.9 271669.0 273167.0 273208.0 274035.0 274052.0 52784.0 53768.0 58987.0 59438.0 59477.0 64053.0 64940.4 65224.3 65242.7 65295.3 15790.8 15855.8 15957.8 15978.9 15990.9 12391.6 12471.8 12472.6 12474.1 12477.3 19313.2 19548.8 19566.5 20071.7 20106.8 7439.7 7605.6 7665.7 7676.2 7810.8 885.9 907.9 932.3 1024.8 1118.4 26037.6 26255.9 26596.7 26687.2 26761.9 1018.5 1032.2 1055.5 1059.7 1062.6 14155.3 14313.5 14530.1 14592.3 14610.3 478704.0 489293.0 490202.0 495836.0 496582.0 51525.2 52188.0 52194.7 52279.0 52327.0 1327.3 1329.6 1342.0 1344.9 1347.1 28112.4 28818.0 29103.4 29177.7 29181.3 44164.8 44793.6 46246.5 46511.0 46700.5 294480.0 296013.0 298434.0 299275.0 300768.0 29582.0 29902.3 30304.5 30546.4 30593.8 39888.4 40009.8 40311.6 40908.2 41133.6 34175.8 34600.7 35014.6 37082.3 37115.0 37672.7 37755.6 37935.0 38106.6 38588.8 36274.5 37072.3 37232.3 37237.0 37415.3 32043.5 32503.0 33505.0 34396.8 34509.1 25656.2 25917.6 25939.5 26029.0 26131.7 01:17:24 INFO - 2015-11-19 01:17:24,896 DEBUG : BROWSER_OUTPUT: 01:17:24 INFO - 2015-11-19 01:17:24,896 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26122.20 Median:474.88 stddev:82783.93 (17432.7%) stddev-sans-first:82993.56 01:17:24 INFO - 2015-11-19 01:17:24,896 DEBUG : BROWSER_OUTPUT: Values: 358.4 360.0 360.6 362.6 364.2 16680.6 17402.2 18343.8 18380.9 18395.2 16968.6 17066.8 17286.7 17456.7 17493.2 5262.8 5316.4 5440.2 5448.7 5449.7 5405.5 5446.6 5452.6 5453.8 5453.9 3522.2 3574.8 4705.6 5400.9 5403.3 4852.7 4967.9 4994.1 4999.9 5002.1 4239.4 4318.2 4318.8 4318.8 4321.9 11497.1 11851.6 13096.3 13414.4 13553.0 1829.8 2043.7 2112.5 2216.3 2361.8 9674.7 9680.3 9826.1 9893.2 10019.2 1670.1 1673.1 1680.4 1698.1 1754.1 58839.4 58873.0 59901.0 61830.7 62623.4 6918.9 7035.2 7091.0 7118.5 7153.3 8530.6 8532.8 8534.0 8539.8 8545.8 5707.6 5716.5 5742.4 5772.0 5802.3 5919.9 5925.9 5941.2 5952.4 5972.4 3293.4 3306.1 3314.8 3333.9 3344.5 1151.0 1158.1 1158.4 1170.1 1193.9 447.7 461.1 475.8 475.9 481.1 10902.6 11658.9 11817.4 11989.3 12002.3 474.0 492.6 494.1 502.8 505.4 5309.6 6215.0 6313.4 6472.0 6498.2 499373.0 499924.0 504736.0 510221.0 511239.2 70392.0 71387.6 72316.0 72862.3 73662.0 537.2 540.5 540.9 541.1 542.9 11305.0 11555.5 11663.4 11701.9 11738.8 36095.1 36336.0 36408.8 36854.8 36870.1 47155.0 47527.0 49064.8 49319.8 49373.3 6931.5 7003.6 7044.6 7048.8 7053.7 11926.9 12466.8 12531.4 12559.9 12578.2 10625.4 10715.1 10747.4 10809.6 10983.3 10484.4 10611.2 10821.9 10834.0 11062.6 9031.6 9215.1 10471.3 10904.7 10973.1 6729.7 6761.7 6883.5 6892.8 6892.8 10385.7 10504.1 10918.6 10921.4 11054.8 01:17:24 INFO - 2015-11-19 01:17:24,896 DEBUG : BROWSER_OUTPUT: 01:17:24 INFO - 2015-11-19 01:17:24,896 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5349.85 Median:6426.63 stddev:2705.24 (42.1%) stddev-sans-first:2695.76 01:17:24 INFO - 2015-11-19 01:17:24,896 DEBUG : BROWSER_OUTPUT: Values: 1307.2 1452.2 1479.5 1742.9 1815.9 6625.2 7310.7 7430.2 7436.5 7440.9 7417.7 7468.7 7524.0 7525.0 7532.7 1985.8 2015.4 2018.2 2243.1 2269.6 2266.1 2298.4 2312.3 2313.0 2317.3 2209.4 2210.1 2264.9 2266.7 2268.9 1985.9 2028.9 2172.5 2208.2 2254.1 2230.1 2256.0 2265.7 2267.8 2278.3 7505.3 7515.4 7566.2 7590.4 7593.4 4476.8 4593.2 4605.7 4614.8 4617.3 3196.9 3202.5 3205.7 3256.7 3279.0 1167.8 1867.4 1902.6 1915.8 1915.8 10224.1 10346.3 10348.7 10352.1 10359.5 4137.4 4141.3 4204.5 4224.4 4266.1 8427.7 8443.7 8445.3 8448.9 8456.0 4665.1 4676.6 4679.1 4688.3 4706.6 4252.3 4255.7 4279.1 4279.9 4294.1 3483.1 3507.2 3520.6 3521.9 3547.3 1051.1 1053.0 1059.4 1064.3 1066.5 1337.2 1339.2 1359.4 1367.4 1372.1 6547.9 7018.0 7340.7 7361.1 7376.2 684.4 686.3 693.7 703.2 717.2 5597.2 5649.6 5655.3 5671.1 5679.7 8880.2 8927.0 9020.7 9094.1 9235.2 8928.4 8999.8 9102.0 9148.0 9154.9 7071.3 7079.4 7111.9 7114.7 7155.3 6858.9 6881.8 6888.2 6894.4 6896.4 7812.7 7938.0 8178.1 8190.9 8195.8 8059.8 8251.4 8257.1 8380.5 8392.5 6912.5 6913.0 6972.0 6984.9 6993.5 7528.2 7576.7 7582.4 7584.6 7588.2 6978.7 7075.7 7078.5 7194.1 7197.7 6932.9 7026.7 7046.4 7112.5 7144.7 6488.2 6925.8 6928.9 6975.7 7036.9 6362.8 6425.6 6427.6 6443.2 6446.9 6347.7 6393.7 6407.0 6422.0 6479.4 01:17:24 INFO - 2015-11-19 01:17:24,897 DEBUG : BROWSER_OUTPUT: 01:17:24 INFO - 2015-11-19 01:17:24,897 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5349.26 Median:6131.36 stddev:1631.12 (26.6%) stddev-sans-first:1591.64 01:17:24 INFO - 2015-11-19 01:17:24,897 DEBUG : BROWSER_OUTPUT: Values: 332.6 335.2 336.6 339.8 342.3 5939.9 5947.2 6083.3 6094.3 6116.2 5828.7 5976.3 5980.2 5993.6 6007.8 4626.2 4653.9 4654.8 4655.8 4660.2 4417.3 4457.2 4518.6 4524.0 4653.3 4457.1 4459.6 4470.5 4522.5 4533.6 4534.3 4535.8 4546.2 4547.0 4556.2 3972.1 3978.7 3982.4 3985.1 3985.1 5572.2 5685.7 5702.7 5725.3 5731.5 5303.9 5313.0 5313.7 5324.7 5326.0 6140.4 6390.2 6398.4 6404.8 6427.0 4322.2 4351.0 4433.4 4433.4 4437.8 6596.3 6634.8 6655.6 6663.1 6678.0 4502.1 4502.4 4504.9 4506.0 4509.2 4395.0 4519.9 4558.8 4561.3 4572.5 5284.4 5289.6 5290.5 5294.0 5298.9 6424.8 6427.8 6431.1 6433.1 6435.0 1590.6 1601.3 1601.6 1603.2 1603.7 1054.8 1066.7 1070.6 1071.1 1096.0 6196.8 6218.4 6241.6 6256.7 6260.5 6552.7 6596.4 6621.1 6637.4 6638.8 6122.3 6213.2 6223.2 6236.8 6250.3 3580.9 3607.8 3611.3 3611.5 3612.4 6824.0 6846.7 6848.8 6855.3 6859.3 6639.0 6787.2 6791.9 6795.6 6797.7 6832.3 6868.9 6869.0 6871.3 6872.5 6366.0 6483.4 6484.8 6632.4 6632.6 6521.3 6540.6 6545.4 6550.1 6557.6 6895.7 6899.6 6907.0 6912.1 6915.4 4309.8 4446.0 4446.9 4457.4 4480.0 6613.9 6614.3 6619.1 6621.6 6623.0 6366.4 6414.6 6429.8 6431.5 6435.3 6280.4 6385.8 6400.9 6489.3 6515.2 6382.6 6395.0 6400.7 6401.8 6404.5 6521.1 6540.4 6544.0 6544.9 6551.6 6202.2 6352.2 6378.2 6381.6 6384.3 01:17:24 INFO - 2015-11-19 01:17:24,897 DEBUG : BROWSER_OUTPUT: 01:17:24 INFO - 2015-11-19 01:17:24,897 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13442.96 Median:23176.49 stddev:15630.95 (67.4%) stddev-sans-first:15645.77 01:17:24 INFO - 2015-11-19 01:17:24,898 DEBUG : BROWSER_OUTPUT: Values: 758.8 859.3 863.5 865.7 874.1 13679.5 14053.4 14060.8 14063.2 14078.6 10842.1 10845.0 10871.4 11098.8 11858.6 668.9 797.0 819.8 820.2 821.2 819.8 820.4 823.5 824.5 827.0 703.6 717.1 856.6 866.2 866.2 840.2 859.2 859.5 859.7 860.8 621.4 627.1 628.2 630.3 634.4 12359.5 12576.9 12639.8 12668.8 12695.5 12231.2 12695.9 12729.3 12998.1 13023.7 10100.5 10214.2 10359.1 10428.9 10523.8 3625.9 3631.4 3637.1 3708.0 3798.5 45061.5 45895.5 46174.5 46271.0 46497.3 9813.5 9829.3 9831.2 9903.4 10079.6 17924.3 17992.2 18034.5 18036.2 18059.4 7241.3 7282.2 7376.6 7493.8 7709.4 4170.7 4220.6 4275.9 4279.9 4317.5 3023.5 3083.6 3091.3 3093.1 3095.2 443.6 457.3 457.4 462.2 473.3 544.0 560.8 561.6 635.9 656.1 7673.3 7954.0 8023.3 8085.0 8150.7 560.9 566.2 601.5 652.8 697.2 3804.8 3941.0 4014.8 4094.4 4109.1 56018.4 57389.0 57427.0 57444.0 57466.0 49762.3 50244.7 50490.5 51459.2 51724.5 44291.3 44549.8 45486.0 46488.0 46833.5 8579.6 8595.0 8780.9 8877.7 8938.4 32615.0 33206.8 33350.8 33633.2 34176.0 42465.8 42862.0 43849.6 44500.3 44556.1 8511.9 8582.3 8772.8 8828.9 8837.3 11914.3 12094.3 12146.5 12315.1 12558.3 10793.7 10915.7 11072.6 11137.9 11176.9 10799.9 10907.2 10910.0 10918.7 10922.5 10892.0 10970.6 10986.8 10993.7 11008.6 9858.9 9910.9 10084.2 10085.1 10416.8 9361.6 9366.2 9438.9 9523.8 9526.1 01:17:24 INFO - 2015-11-19 01:17:24,898 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:17:24 INFO - 2015-11-19 01:17:24,898 DEBUG : BROWSER_OUTPUT: 01:17:25 INFO - 2015-11-19 01:17:25,549 INFO : Browser exited with error code: 0 01:17:25 INFO - 2015-11-19 01:17:25,569 INFO : Completed test dromaeo_css (00:18:34) 01:17:25 INFO - 2015-11-19 01:17:25,570 INFO : Starting test kraken 01:17:25 INFO - 2015-11-19 01:17:25,570 DEBUG : operating with platform_type : linux_ 01:17:25 INFO - 2015-11-19 01:17:25,570 INFO : Initialising browser for kraken test... 01:17:25 INFO - 2015-11-19 01:17:25,576 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaknygY/profile http://localhost:46912/getInfo.html 01:17:29 INFO - 2015-11-19 01:17:29,811 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:17:29 INFO - 2015-11-19 01:17:29,811 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:17:29 INFO - 2015-11-19 01:17:29,811 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:17:29 INFO - 2015-11-19 01:17:29,811 DEBUG : BROWSER_OUTPUT: __metrics 01:17:30 INFO - 2015-11-19 01:17:30,009 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:17:31 INFO - 2015-11-19 01:17:31,195 INFO : Browser initialized. 01:17:31 INFO - 2015-11-19 01:17:31,196 INFO : Running cycle 1/1 for kraken test... 01:17:31 INFO - 2015-11-19 01:17:31,196 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaknygY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:17:43 INFO - 2015-11-19 01:17:43,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 140742656 01:17:43 INFO - 2015-11-19 01:17:43,019 DEBUG : BROWSER_OUTPUT: 01:17:45 INFO - 2015-11-19 01:17:45,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46912/tests/kraken/driver.html?testName=audio-beat-detection) 01:17:46 INFO - 2015-11-19 01:17:46,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 179482624 01:17:46 INFO - 2015-11-19 01:17:46,065 DEBUG : BROWSER_OUTPUT: 01:17:48 INFO - 2015-11-19 01:17:48,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46912/tests/kraken/driver.html?testName=audio-dft) 01:17:49 INFO - 2015-11-19 01:17:49,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 167931904 01:17:49 INFO - 2015-11-19 01:17:49,262 DEBUG : BROWSER_OUTPUT: 01:17:52 INFO - 2015-11-19 01:17:52,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46912/tests/kraken/driver.html?testName=audio-fft) 01:17:52 INFO - 2015-11-19 01:17:52,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 151511040 01:17:52 INFO - 2015-11-19 01:17:52,756 DEBUG : BROWSER_OUTPUT: 01:17:54 INFO - 2015-11-19 01:17:54,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46912/tests/kraken/driver.html?testName=audio-oscillator) 01:17:55 INFO - 2015-11-19 01:17:55,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 155525120 01:17:55 INFO - 2015-11-19 01:17:55,318 DEBUG : BROWSER_OUTPUT: 01:17:57 INFO - 2015-11-19 01:17:57,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46912/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:17:58 INFO - 2015-11-19 01:17:58,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 155262976 01:17:58 INFO - 2015-11-19 01:17:58,042 DEBUG : BROWSER_OUTPUT: 01:18:00 INFO - 2015-11-19 01:18:00,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46912/tests/kraken/driver.html?testName=imaging-darkroom) 01:18:01 INFO - 2015-11-19 01:18:01,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 156946432 01:18:01 INFO - 2015-11-19 01:18:01,539 DEBUG : BROWSER_OUTPUT: 01:18:04 INFO - 2015-11-19 01:18:04,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46912/tests/kraken/driver.html?testName=imaging-desaturate) 01:18:05 INFO - 2015-11-19 01:18:05,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 158281728 01:18:05 INFO - 2015-11-19 01:18:05,522 DEBUG : BROWSER_OUTPUT: 01:18:08 INFO - 2015-11-19 01:18:08,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46912/tests/kraken/driver.html?testName=json-parse-financial) 01:18:08 INFO - 2015-11-19 01:18:08,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 156729344 01:18:08 INFO - 2015-11-19 01:18:08,849 DEBUG : BROWSER_OUTPUT: 01:18:10 INFO - 2015-11-19 01:18:10,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46912/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:18:10 INFO - 2015-11-19 01:18:10,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 166285312 01:18:10 INFO - 2015-11-19 01:18:10,981 DEBUG : BROWSER_OUTPUT: 01:18:12 INFO - 2015-11-19 01:18:12,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46912/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:18:13 INFO - 2015-11-19 01:18:13,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 165265408 01:18:13 INFO - 2015-11-19 01:18:13,372 DEBUG : BROWSER_OUTPUT: 01:18:15 INFO - 2015-11-19 01:18:15,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46912/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:18:16 INFO - 2015-11-19 01:18:16,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 173596672 01:18:16 INFO - 2015-11-19 01:18:16,024 DEBUG : BROWSER_OUTPUT: 01:18:18 INFO - 2015-11-19 01:18:18,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:18:19 INFO - 2015-11-19 01:18:19,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 179662848 01:18:19 INFO - 2015-11-19 01:18:19,019 DEBUG : BROWSER_OUTPUT: 01:18:21 INFO - 2015-11-19 01:18:21,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:18:22 INFO - 2015-11-19 01:18:22,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 176992256 01:18:22 INFO - 2015-11-19 01:18:22,181 DEBUG : BROWSER_OUTPUT: 01:18:23 INFO - 2015-11-19 01:18:23,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46912/tests/kraken/driver.html?testName=ai-astar) 01:18:24 INFO - 2015-11-19 01:18:24,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 236392448 01:18:24 INFO - 2015-11-19 01:18:24,119 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,119 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:18:24 INFO - 2015-11-19 01:18:24,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:18:24 INFO - 2015-11-19 01:18:24,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:18:24 INFO - 2015-11-19 01:18:24,120 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:18:24 INFO - 2015-11-19 01:18:24,120 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;104;109;111;112;119;111;111;109;110 01:18:24 INFO - 2015-11-19 01:18:24,120 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;125;155;168;125;148;152;127;174;125 01:18:24 INFO - 2015-11-19 01:18:24,120 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;161;161;160;160;161;163;160;161 01:18:24 INFO - 2015-11-19 01:18:24,120 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;80;91;73;72;71;118;91;71 01:18:24 INFO - 2015-11-19 01:18:24,121 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;133;90;90;91;135;90;91;134 01:18:24 INFO - 2015-11-19 01:18:24,121 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;109;109;110;109;110 01:18:24 INFO - 2015-11-19 01:18:24,121 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;146;146;146;145;146;145;147;145 01:18:24 INFO - 2015-11-19 01:18:24,121 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;96;96;96;96;96 01:18:24 INFO - 2015-11-19 01:18:24,121 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;57;58;57;57;56;57;65;56;54 01:18:24 INFO - 2015-11-19 01:18:24,121 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;69;70;70;69;68;69;69 01:18:24 INFO - 2015-11-19 01:18:24,121 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;85;84;95;85;85;84;85;85;86 01:18:24 INFO - 2015-11-19 01:18:24,122 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;119;125;113;119;117;130;127;119;118 01:18:24 INFO - 2015-11-19 01:18:24,122 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;153;152;144;144;143;159;159;155;142 01:18:24 INFO - 2015-11-19 01:18:24,122 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;69;67;70;68;69;71;69;71 01:18:24 INFO - 2015-11-19 01:18:24,122 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:18:24 INFO - 2015-11-19 01:18:24,122 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:18:24 INFO - 2015-11-19 01:18:24,122 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,938 01:18:24 INFO - 2015-11-19 01:18:24,122 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:18:24 INFO - 2015-11-19 01:18:24,123 DEBUG : BROWSER_OUTPUT: __startTimestamp1447924704114__endTimestamp 01:18:24 INFO - 2015-11-19 01:18:24,123 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,123 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:18:24 INFO - 2015-11-19 01:18:24,123 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:18:24 INFO - 2015-11-19 01:18:24,123 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:3.68 (3.3%) stddev-sans-first:3.91 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: Values: 111.0 104.0 109.0 111.0 112.0 119.0 111.0 111.0 109.0 110.0 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.60 Median:153.50 stddev:18.83 (12.3%) stddev-sans-first:19.52 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: Values: 157.0 125.0 155.0 168.0 125.0 148.0 152.0 127.0 174.0 125.0 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 161.0 161.0 160.0 160.0 161.0 163.0 160.0 161.0 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:73.50 stddev:15.01 (20.4%) stddev-sans-first:15.60 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 80.0 91.0 73.0 72.0 71.0 118.0 91.0 71.0 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,125 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:90.00 stddev:21.06 (23.4%) stddev-sans-first:21.84 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 133.0 90.0 90.0 91.0 135.0 90.0 91.0 134.0 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 146.0 146.0 146.0 145.0 146.0 145.0 147.0 145.0 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:2.91 (5.1%) stddev-sans-first:3.05 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: Values: 56.0 57.0 58.0 57.0 57.0 56.0 57.0 65.0 56.0 54.0 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 01:18:24 INFO - 2015-11-19 01:18:24,126 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 70.0 70.0 69.0 68.0 69.0 69.0 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:85.00 stddev:3.60 (4.2%) stddev-sans-first:3.43 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: Values: 91.0 85.0 84.0 95.0 85.0 85.0 84.0 85.0 85.0 86.0 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:119.00 stddev:5.23 (4.4%) stddev-sans-first:5.40 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: Values: 117.0 119.0 125.0 113.0 119.0 117.0 130.0 127.0 119.0 118.0 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:152.50 stddev:7.15 (4.7%) stddev-sans-first:6.94 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: Values: 141.0 153.0 152.0 144.0 144.0 143.0 159.0 159.0 155.0 142.0 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.32 (1.9%) stddev-sans-first:1.36 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 69.0 67.0 70.0 68.0 69.0 71.0 69.0 71.0 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:18:24 INFO - 2015-11-19 01:18:24,127 DEBUG : BROWSER_OUTPUT: 01:18:24 INFO - 2015-11-19 01:18:24,948 INFO : Browser exited with error code: 0 01:18:24 INFO - 2015-11-19 01:18:24,994 INFO : Completed test kraken (00:00:59) 01:18:24 INFO - 2015-11-19 01:18:24,994 INFO : Starting test v8_7 01:18:24 INFO - 2015-11-19 01:18:24,994 DEBUG : operating with platform_type : linux_ 01:18:24 INFO - 2015-11-19 01:18:24,994 INFO : Initialising browser for v8_7 test... 01:18:25 INFO - 2015-11-19 01:18:25,000 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1mxmXU/profile http://localhost:46912/getInfo.html 01:18:29 INFO - 2015-11-19 01:18:29,008 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:18:29 INFO - 2015-11-19 01:18:29,008 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:18:29 INFO - 2015-11-19 01:18:29,008 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:18:29 INFO - 2015-11-19 01:18:29,008 DEBUG : BROWSER_OUTPUT: __metrics 01:18:29 INFO - 2015-11-19 01:18:29,129 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:18:30 INFO - 2015-11-19 01:18:30,520 INFO : Browser initialized. 01:18:30 INFO - 2015-11-19 01:18:30,521 INFO : Running cycle 1/1 for v8_7 test... 01:18:30 INFO - 2015-11-19 01:18:30,521 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1mxmXU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:18:42 INFO - 2015-11-19 01:18:42,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 139960320 01:18:42 INFO - 2015-11-19 01:18:42,176 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46912/tests/v8_7/run.html (next: http://localhost:46912/tests/v8_7/run.html) 01:19:03 INFO - 2015-11-19 01:19:03,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 568610816 01:19:03 INFO - 2015-11-19 01:19:03,765 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,765 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:19:03 INFO - 2015-11-19 01:19:03,765 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:19:03 INFO - 2015-11-19 01:19:03,765 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:19:03 INFO - 2015-11-19 01:19:03,765 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:19:03 INFO - 2015-11-19 01:19:03,765 DEBUG : BROWSER_OUTPUT: |0;Richards;162.91951775822744 01:19:03 INFO - 2015-11-19 01:19:03,766 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.42359767891682 01:19:03 INFO - 2015-11-19 01:19:03,766 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.8191398461977 01:19:03 INFO - 2015-11-19 01:19:03,766 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 01:19:03 INFO - 2015-11-19 01:19:03,766 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1121.0762331838564 01:19:03 INFO - 2015-11-19 01:19:03,766 DEBUG : BROWSER_OUTPUT: |5;Earley;776.3975155279503 01:19:03 INFO - 2015-11-19 01:19:03,767 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 01:19:03 INFO - 2015-11-19 01:19:03,767 DEBUG : BROWSER_OUTPUT: |7;RegExp;26473.684210526317 01:19:03 INFO - 2015-11-19 01:19:03,767 DEBUG : BROWSER_OUTPUT: |8;Splay;644.3298969072165 01:19:03 INFO - 2015-11-19 01:19:03,767 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 01:19:03 INFO - 2015-11-19 01:19:03,767 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:19:03 INFO - 2015-11-19 01:19:03,768 DEBUG : BROWSER_OUTPUT: __startTimestamp1447924743764__endTimestamp 01:19:03 INFO - 2015-11-19 01:19:03,768 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,768 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:19:03 INFO - 2015-11-19 01:19:03,768 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:19:03 INFO - 2015-11-19 01:19:03,768 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,769 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.92 Median:162.92 stddev:0.00 (0.0%) 01:19:03 INFO - 2015-11-19 01:19:03,769 DEBUG : BROWSER_OUTPUT: Values: 162.9 01:19:03 INFO - 2015-11-19 01:19:03,769 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,769 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.42 Median:193.42 stddev:0.00 (0.0%) 01:19:03 INFO - 2015-11-19 01:19:03,769 DEBUG : BROWSER_OUTPUT: Values: 193.4 01:19:03 INFO - 2015-11-19 01:19:03,769 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,769 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.82 Median:284.82 stddev:0.00 (0.0%) 01:19:03 INFO - 2015-11-19 01:19:03,769 DEBUG : BROWSER_OUTPUT: Values: 284.8 01:19:03 INFO - 2015-11-19 01:19:03,769 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,770 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 01:19:03 INFO - 2015-11-19 01:19:03,770 DEBUG : BROWSER_OUTPUT: Values: 5035.2 01:19:03 INFO - 2015-11-19 01:19:03,770 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,770 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1121.08 Median:1121.08 stddev:0.00 (0.0%) 01:19:03 INFO - 2015-11-19 01:19:03,770 DEBUG : BROWSER_OUTPUT: Values: 1121.1 01:19:03 INFO - 2015-11-19 01:19:03,770 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,770 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:776.40 Median:776.40 stddev:0.00 (0.0%) 01:19:03 INFO - 2015-11-19 01:19:03,770 DEBUG : BROWSER_OUTPUT: Values: 776.4 01:19:03 INFO - 2015-11-19 01:19:03,770 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,770 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 01:19:03 INFO - 2015-11-19 01:19:03,772 DEBUG : BROWSER_OUTPUT: Values: 12256.1 01:19:03 INFO - 2015-11-19 01:19:03,772 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,772 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26473.68 Median:26473.68 stddev:0.00 (0.0%) 01:19:03 INFO - 2015-11-19 01:19:03,772 DEBUG : BROWSER_OUTPUT: Values: 26473.7 01:19:03 INFO - 2015-11-19 01:19:03,772 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,772 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:644.33 Median:644.33 stddev:0.00 (0.0%) 01:19:03 INFO - 2015-11-19 01:19:03,772 DEBUG : BROWSER_OUTPUT: Values: 644.3 01:19:03 INFO - 2015-11-19 01:19:03,772 DEBUG : BROWSER_OUTPUT: 01:19:03 INFO - 2015-11-19 01:19:03,772 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 01:19:03 INFO - 2015-11-19 01:19:03,772 DEBUG : BROWSER_OUTPUT: Values: 4830.9 01:19:03 INFO - 2015-11-19 01:19:03,772 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:19:03 INFO - 2015-11-19 01:19:03,772 DEBUG : BROWSER_OUTPUT: 01:19:04 INFO - 2015-11-19 01:19:04,712 INFO : Browser exited with error code: 0 01:19:04 INFO - 2015-11-19 01:19:04,727 INFO : Completed test v8_7 (00:00:39) 01:19:04 INFO - 2015-11-19 01:19:04,837 INFO : Completed test suite (00:20:13) 01:19:04 INFO - 2015-11-19 01:19:04,837 DEBUG : Working with test: dromaeo_css 01:19:04 INFO - 2015-11-19 01:19:04,837 DEBUG : Generating results file: dromaeo_css 01:19:04 INFO - 2015-11-19 01:19:04,838 DEBUG : Working with test: kraken 01:19:04 INFO - 2015-11-19 01:19:04,838 DEBUG : Generating results file: kraken 01:19:04 INFO - 2015-11-19 01:19:04,838 INFO : javascript benchmark 01:19:04 INFO - 2015-11-19 01:19:04,838 DEBUG : Working with test: v8_7 01:19:04 INFO - 2015-11-19 01:19:04,839 DEBUG : Generating results file: v8_7 01:19:04 INFO - 2015-11-19 01:19:04,839 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:19:04 INFO - 2015-11-19 01:19:04,895 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 01:19:04 INFO - 2015-11-19 01:19:04,895 DEBUG : process_Request line: dromaeo_css 6740.15 graph.html#tests=[[72,64,35]] 01:19:04 INFO - 2015-11-19 01:19:04,895 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:19:04 INFO - 2015-11-19 01:19:04,932 DEBUG : process_Request line: kraken 1504.70 graph.html#tests=[[232,64,35]] 01:19:04 INFO - 2015-11-19 01:19:04,933 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:19:04 INFO - 2015-11-19 01:19:04,964 DEBUG : process_Request line: v8_7 20872.18 graph.html#tests=[[230,64,35]] 01:19:04 INFO - 2015-11-19 01:19:04,965 INFO : javascript benchmark 01:19:05 INFO - 2015-11-19 01:19:04,969 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3156.7790254682172, 3178.809271443712, 3214.5338925855735, 3230.4346739320613, 3235.7573182011356, 5193.974030129844, 5289.391719952202, 5302.337207849019, 5302.469753024696, 5319.122344813101, 5353.5984801139975, 5410.026195284847, 5436.401995780471, 5468.7539060742265, 5478.643888147268, 4878.829240976566, 4983.152864013126, 5000.874978125557, 5059.392872855244, 5062.544371006608, 4958.132326842806, 5045.772940217699, 5105.719185444799, 5105.948940510603, 5110.310108135392, 4837.105135549935, 4883.413990321149, 4953.306537084811, 4980.103581355373, 4982.825601103962, 4882.365292511986, 5006.299118123466, 5015.774290156952, 5019.272205530177, 5024.145895197825, 4941.678790878582, 4946.653734238605, 4952.727599981999, 4964.379452568429, 4999.0, 5117.48825117489, 5181.637285390024, 5246.160614301732, 5254.527092561688, 5269.604779641504, 5836.795712150097, 5846.50304724099, 5850.268716410449, 5852.297724273115, 5858.619189752652, 5771.538276937877, 5859.7949071782705, 5865.120231965197, 5866.530677545786, 5893.44012318829, 5502.5597952163735, 5503.854694244147, 5506.752196151183, 5510.779568817283, 5553.750081246354, 5772.249607550992, 5974.641521508724, 5981.342052374235, 5983.1623572699855, 5989.191459153046, 5652.293463317085, 5701.914471282934, 5703.916255911364, 5726.828195154152, 5752.769889204469, 5826.329972053268, 5861.0, 5866.296044474605, 5866.882662346729, 5872.58891877573, 5666.773329066874, 5801.216835727208, 5804.187413762077, 5805.796797112081, 5821.767129314865, 5754.712264386764, 5829.679367634821, 5839.9124013139835, 5848.385919478394, 5892.1161825726485, 4447.7998490067375, 4456.108778244299, 4483.170613436525, 4488.349189367524, 4523.411956445641, 3914.9608503915165, 3924.3328634132267, 3993.940090898639, 4039.111395492987, 4047.514298284225, 5515.862103447365, 5547.805826796042, 5550.139728342114, 5553.694546799965, 5557.5553955683445, 5863.413658634187, 5868.383819698955, 5873.706314684248, 5880.764769409176, 5881.676507792027, 5339.359276886798, 5453.372862120907, 5455.372632147274, 5535.169724541271, 5584.357798853102, 5098.515641014098, 5108.489151084936, 5110.207917772751, 5110.744462776846, 5128.820491282787, 6060.939390606038, 6076.0278355462915, 6076.3316035236085, 6077.969610152098, 6082.787102451482, 5628.212050312877, 5749.856253593526, 5805.622634528742, 5955.315138759098, 5957.880842383215, 6058.242719660043, 6060.363661815446, 6061.060535616986, 6069.423404776539, 6069.757209711739, 5797.913031304618, 5798.768049277982, 5803.883922321615, 5807.912881306868, 5809.477147056785, 5714.114312281603, 5821.126830975388, 5832.096025116114, 5836.795712150054, 5842.123681447647, 5663.2071509989455, 5665.405132461032, 5670.546356291569, 5672.43275672446, 5674.77300907959, 5681.914771278517, 5686.829395118153, 5692.48767610917, 5692.886142277049, 5827.5629327801435, 5644.350899646429, 5645.068563686946, 5651.067573850269, 5651.915221271602, 5682.0340542107115, 5720.542356611378, 5739.253896993531, 5752.9712351437975, 5754.165645981226, 5793.333766616893, 5428.45715428454, 5565.666060036411, 5575.358833734173, 5661.57538184646, 5726.0838265877255], "unit": "ms", "name": "dojo.html", "value": 5378.627363638487}, {"lowerIsBetter": false, "replicates": [555.5610868288213, 600.9068594367873, 605.1165298663951, 612.9049997250424, 614.0635530815503, 29788.40423191535, 30414.847925760394, 30421.087367378987, 30433.695663043363, 40646.593534064654, 42353.0, 42647.36028959561, 42741.572584274145, 42817.0, 42883.499077532295, 8760.255378292837, 8945.105489451067, 8949.731508054736, 8949.910500894974, 8950.910490895105, 7660.885086723703, 7819.843603127934, 10443.373397596131, 10628.574857005711, 10647.254692171513, 10364.689059328231, 10436.165106791439, 10454.947725261363, 10485.370877747322, 10496.0, 7820.765377038698, 8019.15798841125, 10337.844932326021, 10436.0, 10443.26897117206, 10355.119814815675, 10531.104856087242, 10598.576056957712, 10610.098141657969, 10610.840837387444, 40893.79553102245, 40911.59088409108, 41305.586944130475, 41364.37953430701, 41408.1718365631, 3336.9499457508155, 3368.6294507604143, 3400.863965441379, 3406.097384193191, 3742.438634204891, 30032.0, 30711.38577228443, 31098.37803243945, 31289.217769555715, 32083.197920051953, 3519.7184225261917, 3616.9095772605633, 3637.308911306843, 3651.434027725707, 3661.8901432957055, 271669.0, 273167.0, 273208.0, 274035.0, 274052.0, 52784.0, 53768.0, 58987.0, 59438.0, 59477.0, 64053.0, 64940.35059649343, 65224.34775652277, 65242.67378663076, 65295.347046529874, 15790.763138552931, 15855.762163567555, 15957.840421595867, 15978.920105399398, 15990.920045399698, 12391.566295179626, 12471.812922806164, 12472.563460278847, 12474.126811123135, 12477.31374774378, 19313.227470901005, 19548.759538172562, 19566.5108372289, 20071.698924516142, 20106.798932010784, 7439.702411903571, 7605.581693006938, 7665.6550455228535, 7676.155622881479, 7810.804729881685, 885.9158379953894, 907.8728977943093, 932.2588542109039, 1024.7540590258434, 1118.4128332625437, 26037.609435858478, 26255.920413784872, 26596.734032659813, 26687.19938401851, 26761.866190669312, 1018.4754851251612, 1032.2206733915996, 1055.488088277185, 1059.655611926127, 1062.6493257225097, 14155.29223538819, 14313.499027533986, 14530.128192308495, 14592.343344549521, 14610.26948652563, 478704.0, 489293.0, 490202.0, 495836.0, 496582.0, 51525.227121593205, 52188.0, 52194.739026304625, 52279.0, 52327.0, 1327.2965328375976, 1329.634350553586, 1341.9530316438877, 1344.8856847167904, 1347.1176379471658, 28112.43775124527, 28818.0, 29103.41793164167, 29177.7082229175, 29181.270468238465, 44164.77917610391, 44793.55206448024, 46246.53753462557, 46511.0, 46700.532994670975, 294480.0, 296013.0, 298434.0, 299275.0, 300768.0, 29582.0, 29902.25244368908, 30304.54543181898, 30546.389072218877, 30593.847030764704, 39888.401673975495, 40009.79995100006, 40311.59688403078, 40908.1818363637, 41133.58866411298, 34175.829120854236, 34600.653993459746, 35014.64985350216, 37082.25835483329, 37115.0, 37672.74531695819, 37755.62244377521, 37935.0, 38106.56327444236, 38588.80705596454, 36274.455883161245, 37072.258554828215, 37232.25535489221, 37237.0, 37415.25169496649, 32043.519347210276, 32503.0, 33505.0, 34396.82801585976, 34509.13727156841, 25656.230313090637, 25917.6112358311, 25939.481210376063, 26029.0, 26131.73868261293], "unit": "ms", "name": "ext.html", "value": 18937.654807976895}, {"lowerIsBetter": false, "replicates": [358.35674963440636, 359.9622039685833, 360.6411620437665, 362.6446082838818, 364.1569765991727, 16680.582985425357, 17402.216900239502, 18343.816561834377, 18380.90809545952, 18395.172217250223, 16968.575785605368, 17066.82933170668, 17286.654266914684, 17456.650866982684, 17493.212805423755, 5262.763175657095, 5316.388615309231, 5440.183972404151, 5448.700321482317, 5449.7275136243225, 5405.486478784529, 5446.591505637073, 5452.6183167178315, 5453.781848726066, 5453.863653408657, 3522.1546828761043, 3574.767640103385, 4705.600023997964, 5400.91898621521, 5403.324584426947, 4852.708837469763, 4967.850964471072, 4994.126027945095, 4999.875003124915, 5002.1496345621335, 4239.406483092339, 4318.179545886272, 4318.805653745589, 4318.805653745589, 4321.891952701176, 11497.080233581293, 11851.644450666494, 13096.34518274092, 13414.396352164176, 13553.0, 1829.8078701736392, 2043.6832290994919, 2112.450762801667, 2216.3240211735415, 2361.8346715729904, 9674.661386851427, 9680.27397945157, 9826.115649591571, 9893.15908147801, 10019.248556358229, 1670.0564181237562, 1673.1299724143378, 1680.4370535870498, 1698.108493041151, 1754.0878743053668, 58839.41160588425, 58873.0, 59901.0, 61830.690846545476, 62623.37376626221, 6918.93081069193, 7035.190953040364, 7090.964545177344, 7118.466115041392, 7153.284671532805, 8530.616122274512, 8532.829343413097, 8533.957330213434, 8539.829203415897, 8545.786355341166, 5707.6290041147195, 5716.514096301861, 5742.425757424224, 5772.018756811352, 5802.33273173582, 5919.852003699942, 5925.881482370329, 5941.22764040672, 5952.434518720715, 5972.372900845348, 3293.390722716305, 3306.057773534531, 3314.8011119332436, 3333.866645334208, 3344.4648856182894, 1150.9769804603861, 1158.0735411670798, 1158.4265788434611, 1170.128254450423, 1193.8539002557468, 447.7224121044908, 461.1307685013706, 475.766874231624, 475.9119562880878, 481.12195243679724, 10902.618408355669, 11658.883411165949, 11817.350045747566, 11989.340586267665, 12002.339871306987, 473.9857804265878, 492.59361027152744, 494.0736119775421, 502.7938545196452, 505.4288653821159, 5309.550353028614, 6215.0, 6313.40022697843, 6472.029195620695, 6498.155239818793, 499373.0, 499924.0, 504736.0, 510221.0, 511239.20749114326, 70392.0, 71387.64306178539, 72316.0, 72862.27137728661, 73662.0, 537.1995726367762, 540.5270388410141, 540.9350877894599, 541.1179776963525, 542.9158480435539, 11305.0, 11555.4800033997, 11663.416829158678, 11701.941490292495, 11738.823917641414, 36095.097622559646, 36336.0, 36408.81795591005, 36854.8157259212, 36870.07824804401, 47155.0, 47527.04945900993, 49064.75467622639, 49319.780609873356, 49373.25940110829, 6931.549449285781, 7003.5797852129035, 7044.647767611496, 7048.823779405556, 7053.717851285891, 11926.940365298118, 12466.812997805222, 12531.436085375997, 12559.93720031394, 12578.245305281713, 10625.415602141957, 10715.142788576739, 10747.408892510986, 10809.56761729522, 10983.286086404358, 10484.423356715453, 10611.2041596879, 10821.891781082088, 10834.0, 11062.557497700323, 9031.593578289125, 9215.078492150731, 10471.267011309135, 10904.727381815517, 10973.122150227802, 6729.730810767514, 6761.695723692544, 6883.483738719716, 6892.827679308058, 6892.827679308058, 10385.740356490845, 10504.054635082879, 10918.563257469612, 10921.399323037309, 11054.834177487182], "unit": "ms", "name": "jquery.html", "value": 7050.959702923913}, {"lowerIsBetter": false, "replicates": [1307.1960744142355, 1452.1650051220552, 1479.541342183923, 1742.8692848036396, 1815.9182836772347, 6625.204975402952, 7310.707571697132, 7430.219826918177, 7436.5166264192785, 7440.888386674204, 7417.740379086733, 7468.738594149206, 7523.962380188092, 7524.962375188116, 7532.698692052325, 1985.7617085949705, 2015.4457524180893, 2018.1927229108328, 2243.102758896442, 2269.5914735347633, 2266.05958527211, 2298.4139044543617, 2312.2600767754325, 2312.9653055204103, 2317.304808557426, 2209.425549357171, 2210.06072419222, 2264.8867556622104, 2266.693996310502, 2268.8638681679067, 1985.8609897307122, 2028.9391318260402, 2172.4894649757293, 2208.182972300243, 2254.087094726622, 2230.052227803177, 2256.029907139929, 2265.66015097735, 2267.7618850020676, 2278.327893271489, 7505.286997735207, 7515.361194298491, 7566.16772155068, 7590.3548198403205, 7593.392528597754, 4476.776161191928, 4593.150267200579, 4605.746683932382, 4614.792334344929, 4617.30740388941, 3196.9040928772174, 3202.471592187286, 3205.7275131613605, 3256.7231785298277, 3278.983605081983, 1167.8365028895962, 1867.421099459172, 1902.6384986852593, 1915.808419158087, 1915.8467322614158, 10224.13094886928, 10346.275760696753, 10348.741281468023, 10352.120069794002, 10359.482025898751, 4137.358709400048, 4141.316682747373, 4204.516480604709, 4224.408582798411, 4266.146770645883, 8427.705030324032, 8443.746687599381, 8445.282151017233, 8448.915510844936, 8456.02755683092, 4665.136949664323, 4676.5791078802395, 4679.110968915895, 4688.343631891538, 4706.599939005223, 4252.340887162495, 4255.702100852973, 4279.101388708344, 4279.914401711948, 4294.119705460374, 3483.1292176955762, 3507.228409749851, 3520.612732599412, 3521.876734314338, 3547.3260080584605, 1051.117061668187, 1052.9631462898762, 1059.390850261103, 1064.297563608015, 1066.5040756048475, 1337.2444568818587, 1339.189790176929, 1359.3950691942189, 1367.43934986655, 1372.1492674541648, 6547.869042619216, 7018.017477553147, 7340.743073992385, 7361.079865016873, 7376.151742549569, 684.4045680258207, 686.289690170671, 693.7121094745725, 703.2124021096303, 717.178830239373, 5597.244372009808, 5649.576281778883, 5655.349634791969, 5671.120976248688, 5679.744411501492, 8880.200781929658, 8926.955365223132, 9020.684276050439, 9094.090590940854, 9235.1688348049, 8928.419652722552, 8999.82000359989, 9102.0, 9148.0, 9154.86267705985, 7071.29287071299, 7079.371744498691, 7111.9063207504905, 7114.715411383487, 7155.284471552907, 6858.897116543156, 6881.827954301182, 6888.173419189729, 6894.413974812197, 6896.413804826445, 7812.726554570563, 7938.04743430792, 8178.059523154913, 8190.894229279209, 8195.754127376189, 8059.758207253792, 8251.422400431911, 8257.050439199329, 8380.53907035119, 8392.496450213006, 6912.4815638828295, 6913.0, 6971.9651401744695, 6984.895226571707, 6993.545419547713, 7528.247175282428, 7576.696932122653, 7582.393408527415, 7584.582847943196, 7588.203238659861, 6978.68595913175, 7075.6815943281645, 7078.4691148163065, 7194.064771579661, 7197.71209151628, 6932.861342773217, 7026.683799228945, 7046.436285097077, 7112.537685050455, 7144.678489467882, 6488.221413430419, 6925.757598484029, 6928.861422771617, 6975.651217439006, 7036.9296307036275, 6362.840928976812, 6425.614463132227, 6427.646479443489, 6443.162388889415, 6446.903296450463, 6347.746090156526, 6393.7122829471855, 6407.038944158227, 6422.036694495863, 6479.384458476437], "unit": "ms", "name": "mootools.html", "value": 4425.693105758052}, {"lowerIsBetter": false, "replicates": [332.5676620393488, 335.1804837173111, 336.5507048090799, 339.84197348233073, 342.34270201213684, 5939.85150371241, 5947.226860508139, 6083.300420451649, 6094.268687757475, 6116.204893363856, 5828.650280983144, 5976.282846058468, 5980.1926739890105, 5993.640381577108, 6007.789727359544, 4626.167289887827, 4653.8836529086875, 4654.813022679229, 4655.837045703401, 4660.16117098922, 4417.31531612599, 4457.219986502365, 4518.615917647004, 4523.977380113095, 4653.278741795028, 4457.10857828434, 4459.620932220765, 4470.530594287602, 4522.5025247222775, 4533.614642755353, 4534.251848445003, 4535.841245556389, 4546.20441422753, 4547.04512052471, 4556.157110934455, 3972.066564357374, 3978.6817054635558, 3982.4424580558743, 3985.06351007513, 3985.143194213258, 5572.192032155355, 5685.715714214272, 5702.7433765480655, 5725.341585717654, 5731.484166425042, 5303.920441193385, 5313.0, 5313.734313284321, 5324.653897496689, 5325.973370133163, 6140.385961403868, 6390.233172019387, 6398.360163983611, 6404.775832845875, 6427.035944608299, 4322.157179350028, 4351.0, 4433.401490798733, 4433.445819272591, 4437.800298986521, 6596.340365963413, 6634.838903191922, 6655.600663960129, 6663.13379260693, 6677.964915438066, 4502.122086193226, 4502.3921770560555, 4504.909901801946, 4505.954940450619, 4509.210888094571, 4394.956050439455, 4519.932201016987, 4558.817647294071, 4561.315802629632, 4572.45130584332, 5284.445133261029, 5289.576833853283, 5290.523852853262, 5294.0, 5298.867528311823, 6424.839379015562, 6427.807165785034, 6431.099646049557, 6433.067205255212, 6435.034744788226, 1590.5943984284165, 1601.303433006646, 1601.5675767542698, 1603.2384617306918, 1603.7353836616828, 1054.7679510507676, 1066.6959916423782, 1070.55571937645, 1071.0628200324716, 1096.0135877710125, 6196.783112591128, 6218.440340369389, 6241.594296370721, 6256.718447669866, 6260.499160067275, 6552.672366381662, 6596.406323430914, 6621.139251897319, 6637.435817955527, 6638.834029149213, 6122.326544080237, 6213.192285003011, 6223.190985171898, 6236.812895613139, 6250.312465628777, 3580.946285805715, 3607.7654952428006, 3611.29579731955, 3611.494390785292, 3612.4039533477207, 6824.0446337512785, 6846.657667116624, 6848.828779280459, 6855.314468553105, 6859.314068593101, 6638.96680516604, 6787.185537735503, 6791.898121528181, 6795.592264464148, 6797.66011699423, 6832.282610325944, 6868.862622747617, 6869.0383346331555, 6871.278515755874, 6872.484563657646, 6365.9681701593045, 6483.384078512534, 6484.805455836333, 6632.436242919213, 6632.568883022588, 6521.282658907421, 6540.607563546202, 6545.410913017851, 6550.148480697479, 6557.639329836905, 6895.6552172390175, 6899.551529150589, 6907.033015377951, 6912.135983002125, 6915.446764258948, 4309.84915527955, 4445.977425192159, 4446.866594002185, 4457.398251236042, 4479.955200448084, 6613.867722645424, 6614.338566143347, 6619.139511863427, 6621.569597976116, 6622.966885165543, 6366.3633636637815, 6414.647194404166, 6429.807105786646, 6431.517636177212, 6435.324290949383, 6280.371962803866, 6385.776497822554, 6400.9039864403, 6489.286178520265, 6515.218173819172, 6382.585131966407, 6395.040743888454, 6400.679966001774, 6401.775937842153, 6404.455621272244, 6521.054447105238, 6540.411362977355, 6544.0, 6544.934550654432, 6551.6069035858, 6202.162708034538, 6352.237731472253, 6378.2346118466085, 6381.649009304347, 6384.329645387167], "unit": "ms", "name": "prototype.html", "value": 4817.506363922349}, {"lowerIsBetter": false, "replicates": [758.7609902880592, 859.3468963587676, 863.4775960543867, 865.6667183134496, 874.1171416868964, 13679.521216757415, 14053.367598458068, 14060.789088163672, 14063.156210627369, 14078.577642670723, 10842.078423334005, 10845.0, 10871.402072885989, 11098.778024439507, 11858.584949526768, 668.9498287628423, 796.9760907172765, 819.8196396792725, 820.2084987986592, 821.2239433735123, 819.8278361544083, 820.4461988157999, 823.4606332851992, 824.47233770387, 826.983460330793, 703.5919166883195, 717.0857157124682, 856.6273670953155, 866.1857853617611, 866.1944391715701, 840.23538579892, 859.1623167411817, 859.5315553023618, 859.6776208921655, 860.7848037990502, 621.3972446726668, 627.109504503606, 628.1927722876082, 630.3286999345682, 634.4448607468465, 12359.455068116486, 12576.874231257661, 12639.810402843965, 12668.80996785049, 12695.492180312776, 12231.204971676812, 12695.873041269562, 12729.299888506128, 12998.080766897696, 13023.739525209538, 10100.494975251282, 10214.182865370827, 10359.119474844647, 10428.94785526075, 10523.78952420955, 3625.89122326328, 3631.4371272452813, 3637.1452708613456, 3707.9814600927093, 3798.525184351956, 45061.54938450606, 45895.54104458946, 46174.53825461736, 46271.0, 46497.30254046192, 9813.460259685644, 9829.262805289633, 9831.1643510301, 9903.356281841658, 10079.59681612742, 17924.28302867897, 17992.190351434216, 18034.458966231035, 18036.188371523313, 18059.367922122663, 7241.348278654947, 7282.162551306667, 7376.631168441557, 7493.812654683567, 7709.38324934004, 4170.666346692257, 4220.6412454941055, 4275.935860962026, 4279.87160385189, 4317.460317460317, 3023.516237402005, 3083.599132112856, 3091.2580980564503, 3093.0875391759487, 3095.1797773590015, 443.6295693096236, 457.33686155075276, 457.43963644535177, 462.1819379697983, 473.28770200847504, 543.9755211015514, 560.8345538066199, 561.5760101123707, 635.8760041791807, 656.0618315808345, 7673.34776544, 7954.0, 8023.289896616252, 8085.0, 8150.673973041012, 560.9130584759369, 566.1931747260138, 601.4767152577285, 652.846581053452, 697.166885571747, 3804.8287827047848, 3940.9556467535554, 4014.7791871447353, 4094.385842123705, 4109.116539943926, 56018.439815602134, 57389.0, 57427.0, 57444.0, 57466.0, 49762.25356619654, 50244.748776256616, 50490.495095049315, 51459.228111578355, 51724.482755171965, 44291.33562996558, 44549.77725111353, 45486.0, 46488.0, 46833.531664682916, 8579.613917373608, 8595.011573669108, 8780.912190878265, 8877.73366798997, 8938.37431379797, 32615.0, 33206.83396583002, 33350.833245833615, 33633.15917102092, 34176.0, 42465.78767106268, 42862.0, 43849.56150438455, 44500.33249501325, 44556.108877821614, 8511.91488085136, 8582.313414926915, 8772.819977117893, 8828.911710882809, 8837.337199709918, 11914.285142891455, 12094.334811585448, 12146.514139434325, 12315.137940344448, 12558.309292988974, 10793.730156746144, 10915.727106822393, 11072.557097716324, 11137.94431027872, 11176.944115279372, 10799.892001079888, 10907.181961352771, 10910.0, 10918.672439826818, 10922.50848711794, 10892.0, 10970.616028438966, 10986.835197471884, 10993.725156871142, 11008.559657613927, 9858.852117218104, 9910.851337229804, 10084.243681723754, 10085.142762865238, 10416.843747343948, 9361.578728957076, 9366.2038726709, 9438.85841712361, 9523.809523809623, 9526.142647161789], "unit": "ms", "name": "yui.html", "value": 6122.50825712743}], "name": "dromaeo_css", "value": 6740.148338337305}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 109.0, 111.0, 112.0, 119.0, 111.0, 111.0, 109.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [157.0, 125.0, 155.0, 168.0, 125.0, 148.0, 152.0, 127.0, 174.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 163.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 80.0, 91.0, 73.0, 72.0, 71.0, 118.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 133.0, 90.0, 90.0, 91.0, 135.0, 90.0, 91.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 103.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 147.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 58.0, 57.0, 57.0, 56.0, 57.0, 65.0, 56.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 70.0, 70.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [91.0, 85.0, 84.0, 95.0, 85.0, 85.0, 84.0, 85.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [117.0, 119.0, 125.0, 113.0, 119.0, 117.0, 130.0, 127.0, 119.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [141.0, 153.0, 152.0, 144.0, 144.0, 143.0, 159.0, 159.0, 155.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 67.0, 70.0, 68.0, 69.0, 71.0, 69.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1504.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.91951775822744], "unit": "score", "name": "Richards", "value": 216.6836759999999}, {"lowerIsBetter": false, "replicates": [193.42359767891682], "unit": "score", "name": "DeltaBlue", "value": 341.83006}, {"lowerIsBetter": false, "replicates": [284.8191398461977], "unit": "score", "name": "Encrypt", "value": 934.5614910000002}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [1121.0762331838564], "unit": "score", "name": "RayTrace", "value": 660.070188}, {"lowerIsBetter": false, "replicates": [776.3975155279503], "unit": "score", "name": "Earley", "value": 858.4043439999999}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [26473.684210526317], "unit": "score", "name": "RegExp", "value": 34.410964214711704}, {"lowerIsBetter": false, "replicates": [644.3298969072165], "unit": "score", "name": "Splay", "value": 126.47403200000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20872.182169472184}]} 01:19:05 INFO - RETURN: dromaeo_css: 6740.15 01:19:05 INFO - RETURN: kraken: 1504.70 01:19:05 INFO - RETURN: v8_7: 20872.18 01:19:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20872.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1504.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6740.15"}}} 01:19:05 INFO - Return code: 0 01:19:05 INFO - # TBPL SUCCESS # 01:19:05 INFO - Running post-action listener: _resource_record_post_action 01:19:05 INFO - Running post-run listener: _resource_record_post_run 01:19:06 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 499814400; Read time: 592; Write time: 669760 01:19:06 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 126689280; Read time: 0; Write time: 266736 01:19:06 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283959296; Read time: 592; Write time: 324120 01:19:06 INFO - Running post-run listener: _upload_blobber_files 01:19:06 INFO - Blob upload gear active. 01:19:06 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:19:06 INFO - Copying logs to upload dir... 01:19:06 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.437372 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-11-19 01:19:05.937015) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 01:19:05.940181) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_aokhJQHQ5i2MMlFRqSGow/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009550 build_url: 'https://queue.taskcluster.net/v1/task/_aokhJQHQ5i2MMlFRqSGow/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-19 01:19:05.990895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 01:19:05.991214) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447915056.458525-273181985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004646 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 01:19:06.040733) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 01:19:06.041057) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 01:19:06.041354) ========= ========= Total master_lag: 0.23 =========