builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1448033329.32 results: success (0) buildid: 20151120053001 builduid: 50d2cdfa0f9e413fa53ddf0b037f2fcf revision: 3d4f379b47fc12812f5e21657b63c6f426f5a063 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.316440) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.317195) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.317607) ========= 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=0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006454 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.340102) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.340747) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.351814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.352082) ========= 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=0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.401747) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.402050) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.402432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.402734) ========= 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=0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 07:28:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2015-11-20 07:28:51 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195795 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.610662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.610997) ========= 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=0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014886 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.660608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:49.660991) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3d4f379b47fc12812f5e21657b63c6f426f5a063 --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 3d4f379b47fc12812f5e21657b63c6f426f5a063 --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=0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 07:28:51,747 truncating revision to first 12 chars 2015-11-20 07:28:51,747 Setting DEBUG logging. 2015-11-20 07:28:51,747 attempt 1/10 2015-11-20 07:28:51,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3d4f379b47fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 07:28:51,994 unpacking tar archive at: fx-team-3d4f379b47fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515847 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:50.189652) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:50.189996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:50.198727) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:50.199027) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 07:28:50.199418) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-20 07:28:50.199722) ========= /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=0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:28:52 INFO - MultiFileLogger online at 20151120 07:28:52 in /builds/slave/test-pgo 07:28:52 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 07:28:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:28:52 INFO - {'append_to_log': False, 07:28:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:28:52 INFO - 'blob_upload_branch': 'Fx-Team', 07:28:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:28:52 INFO - 'branch': 'Fx-Team', 07:28:52 INFO - 'buildbot_json_path': 'buildprops.json', 07:28:52 INFO - 'config_files': ('talos/linux_config.py',), 07:28:52 INFO - 'default_actions': ('clobber', 07:28:52 INFO - 'read-buildbot-config', 07:28:52 INFO - 'download-and-extract', 07:28:52 INFO - 'populate-webroot', 07:28:52 INFO - 'create-virtualenv', 07:28:52 INFO - 'install', 07:28:52 INFO - 'run-tests'), 07:28:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:28:52 INFO - 'download_minidump_stackwalk': True, 07:28:52 INFO - 'download_symbols': 'ondemand', 07:28:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:28:52 INFO - 'tooltool.py': '/tools/tooltool.py', 07:28:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:28:52 INFO - '/tools/misc-python/virtualenv.py')}, 07:28:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:28:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:28:52 INFO - 'installer_path': 'installer.exe', 07:28:52 INFO - 'log_level': 'info', 07:28:52 INFO - 'log_name': 'talos', 07:28:52 INFO - 'log_to_console': True, 07:28:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:28:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:28:52 INFO - 'opt_config_files': (), 07:28:52 INFO - 'pip_index': False, 07:28:52 INFO - 'sps_profile': False, 07:28:52 INFO - 'sps_profile_interval': 0, 07:28:52 INFO - 'suite': 'dromaeojs', 07:28:52 INFO - 'system_bits': '64', 07:28:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:28:52 INFO - 'title': 'talos-linux64-ix-044', 07:28:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:28:52 INFO - 'use_talos_json': True, 07:28:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:28:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:28:52 INFO - 'work_dir': 'build'} 07:28:52 INFO - ##### 07:28:52 INFO - ##### Running clobber step. 07:28:52 INFO - ##### 07:28:52 INFO - Running pre-action listener: _resource_record_pre_action 07:28:52 INFO - Running main action method: clobber 07:28:52 INFO - rmtree: /builds/slave/test-pgo/build 07:28:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:28:52 INFO - Running post-action listener: _resource_record_post_action 07:28:52 INFO - ##### 07:28:52 INFO - ##### Running read-buildbot-config step. 07:28:52 INFO - ##### 07:28:52 INFO - Running pre-action listener: _resource_record_pre_action 07:28:52 INFO - Running main action method: read_buildbot_config 07:28:52 INFO - Using buildbot properties: 07:28:52 INFO - { 07:28:52 INFO - "properties": { 07:28:52 INFO - "buildnumber": 334, 07:28:52 INFO - "product": "firefox", 07:28:52 INFO - "script_repo_revision": "production", 07:28:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:28:52 INFO - "repository": "", 07:28:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:28:52 INFO - "buildid": "20151120053001", 07:28:52 INFO - "slavename": "talos-linux64-ix-044", 07:28:52 INFO - "pgo_build": "True", 07:28:52 INFO - "basedir": "/builds/slave/test-pgo", 07:28:52 INFO - "project": "", 07:28:52 INFO - "platform": "ubuntu64_hw", 07:28:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:28:52 INFO - "slavebuilddir": "test", 07:28:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:28:52 INFO - "branch": "fx-team", 07:28:52 INFO - "repo_path": "integration/fx-team", 07:28:52 INFO - "stage_platform": "linux64-pgo", 07:28:52 INFO - "builduid": "50d2cdfa0f9e413fa53ddf0b037f2fcf", 07:28:52 INFO - "revision": "3d4f379b47fc12812f5e21657b63c6f426f5a063" 07:28:52 INFO - }, 07:28:52 INFO - "sourcestamp": { 07:28:52 INFO - "repository": "", 07:28:52 INFO - "hasPatch": false, 07:28:52 INFO - "project": "", 07:28:52 INFO - "branch": "fx-team-linux64-pgo-talos", 07:28:52 INFO - "changes": [ 07:28:52 INFO - { 07:28:52 INFO - "category": null, 07:28:52 INFO - "files": [ 07:28:52 INFO - { 07:28:52 INFO - "url": null, 07:28:52 INFO - "name": "https://queue.taskcluster.net/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:28:52 INFO - } 07:28:52 INFO - ], 07:28:52 INFO - "repository": "", 07:28:52 INFO - "rev": "3d4f379b47fc12812f5e21657b63c6f426f5a063", 07:28:52 INFO - "who": "sendchange", 07:28:52 INFO - "when": 1448032909, 07:28:52 INFO - "number": 6688823, 07:28:52 INFO - "comments": "", 07:28:52 INFO - "project": "", 07:28:52 INFO - "at": "Fri 20 Nov 2015 07:21:49", 07:28:52 INFO - "branch": "fx-team-linux64-pgo-talos", 07:28:52 INFO - "revlink": "", 07:28:52 INFO - "properties": [ 07:28:52 INFO - [ 07:28:52 INFO - "buildid", 07:28:52 INFO - "20151120053001", 07:28:52 INFO - "Change" 07:28:52 INFO - ], 07:28:52 INFO - [ 07:28:52 INFO - "builduid", 07:28:52 INFO - "50d2cdfa0f9e413fa53ddf0b037f2fcf", 07:28:52 INFO - "Change" 07:28:52 INFO - ], 07:28:52 INFO - [ 07:28:52 INFO - "pgo_build", 07:28:52 INFO - "True", 07:28:52 INFO - "Change" 07:28:52 INFO - ] 07:28:52 INFO - ], 07:28:52 INFO - "revision": "3d4f379b47fc12812f5e21657b63c6f426f5a063" 07:28:52 INFO - } 07:28:52 INFO - ], 07:28:52 INFO - "revision": "3d4f379b47fc12812f5e21657b63c6f426f5a063" 07:28:52 INFO - } 07:28:52 INFO - } 07:28:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:28:52 INFO - Running post-action listener: _resource_record_post_action 07:28:52 INFO - ##### 07:28:52 INFO - ##### Running download-and-extract step. 07:28:52 INFO - ##### 07:28:52 INFO - Running pre-action listener: _resource_record_pre_action 07:28:52 INFO - Running main action method: download_and_extract 07:28:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:28:52 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')]} 07:28:52 INFO - https://queue.taskcluster.net/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:28:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/test_packages.json 07:28:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/test_packages.json 07:28:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:28:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:28:53 INFO - Downloaded 1302 bytes. 07:28:53 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:28:53 INFO - Using the following test package requirements: 07:28:53 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:53 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:28:53 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:53 INFO - u'jsshell-linux-x86_64.zip'], 07:28:53 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:28:53 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:53 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:28:53 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:28:53 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:28:53 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:53 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:28:53 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:28:53 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')]} 07:28:53 INFO - https://queue.taskcluster.net/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/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 07:28:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/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 07:28:54 INFO - Downloaded 22524052 bytes. 07:28:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:28:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:28:55 INFO - Return code: 0 07:28:55 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:55 INFO - https://queue.taskcluster.net/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/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 07:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/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 07:28:56 INFO - Downloaded 22524052 bytes. 07:28:56 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 07:28:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:56 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 07:28:57 INFO - Return code: 0 07:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:57 INFO - https://queue.taskcluster.net/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:28:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/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 07:28:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/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 07:28:58 INFO - Downloaded 11130997 bytes. 07:28:58 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 07:28:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:58 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 07:28:59 INFO - Return code: 0 07:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:59 INFO - https://queue.taskcluster.net/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:28:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:28:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:28:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/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 07:28:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7G0AHU9ZTt6UuJdParsNvg/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 07:29:00 INFO - Downloaded 57347232 bytes. 07:29:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:29:00 INFO - mkdir: /builds/slave/test-pgo/properties 07:29:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:29:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:29:00 INFO - Contents: 07:29:00 INFO - build_url:https://queue.taskcluster.net/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:29:00 INFO - Running post-action listener: _resource_record_post_action 07:29:00 INFO - Running post-action listener: set_extra_try_arguments 07:29:00 INFO - ##### 07:29:00 INFO - ##### Running populate-webroot step. 07:29:00 INFO - ##### 07:29:00 INFO - Running pre-action listener: _resource_record_pre_action 07:29:00 INFO - Running main action method: populate_webroot 07:29:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:29:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:29:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:29:00 INFO - '../fennec_ids.txt'], 07:29:00 INFO - 'tests': ['tcheck2']}, 07:29:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:29:00 INFO - '--tppagecycles', 07:29:00 INFO - '7'], 07:29:00 INFO - 'tests': ['tsvgm']}}, 07:29:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:29:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:29:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:29:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:29:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:29:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:29:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:00 INFO - 'talos_options': ['--e10s'], 07:29:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:00 INFO - 'tests': ['damp', 'tps']}, 07:29:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:00 INFO - 'talos_options': ['--e10s'], 07:29:00 INFO - 'tests': ['damp', 'tps']}, 07:29:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:29:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:29:00 INFO - 'other': {'tests': ['a11yr', 07:29:00 INFO - 'ts_paint', 07:29:00 INFO - 'tpaint', 07:29:00 INFO - 'sessionrestore', 07:29:00 INFO - 'sessionrestore_no_auto_restore']}, 07:29:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:29:00 INFO - 'tests': ['a11yr', 07:29:00 INFO - 'ts_paint', 07:29:00 INFO - 'tpaint', 07:29:00 INFO - 'sessionrestore', 07:29:00 INFO - 'sessionrestore_no_auto_restore']}, 07:29:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:29:00 INFO - 'tests': ['a11yr', 07:29:00 INFO - 'ts_paint', 07:29:00 INFO - 'tpaint', 07:29:00 INFO - 'sessionrestore', 07:29:00 INFO - 'sessionrestore_no_auto_restore']}, 07:29:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:29:00 INFO - 'tests': ['a11yr', 07:29:00 INFO - 'ts_paint', 07:29:00 INFO - 'tpaint', 07:29:00 INFO - 'sessionrestore', 07:29:00 INFO - 'sessionrestore_no_auto_restore']}, 07:29:00 INFO - 'other_l64': {'tests': ['a11yr', 07:29:00 INFO - 'ts_paint', 07:29:00 INFO - 'tpaint', 07:29:00 INFO - 'sessionrestore', 07:29:00 INFO - 'sessionrestore_no_auto_restore']}, 07:29:00 INFO - 'other_nol64': {'tests': ['a11yr', 07:29:00 INFO - 'ts_paint', 07:29:00 INFO - 'tpaint', 07:29:00 INFO - 'sessionrestore', 07:29:00 INFO - 'sessionrestore_no_auto_restore']}, 07:29:00 INFO - 'svgr': {'tests': ['tsvgx', 07:29:00 INFO - 'tsvgr_opacity', 07:29:00 INFO - 'tart', 07:29:00 INFO - 'tscrollx', 07:29:00 INFO - 'cart']}, 07:29:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:29:00 INFO - 'tests': ['tsvgx', 07:29:00 INFO - 'tsvgr_opacity', 07:29:00 INFO - 'tart', 07:29:00 INFO - 'tscrollx', 07:29:00 INFO - 'cart']}, 07:29:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:00 INFO - 'tests': ['tp5o']}, 07:29:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:00 INFO - 'talos_options': ['--e10s'], 07:29:00 INFO - 'tests': ['tp5o']}, 07:29:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:00 INFO - 'talos_options': ['--xperf_path', 07:29:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:00 INFO - 'tests': ['tp5n']}, 07:29:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:00 INFO - 'talos_options': ['--e10s', 07:29:00 INFO - '--xperf_path', 07:29:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:00 INFO - 'tests': ['tp5n']}}, 07:29:00 INFO - 'talos.zip': {'path': '', 07:29:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:29:00 INFO - Running post-action listener: _resource_record_post_action 07:29:00 INFO - ##### 07:29:00 INFO - ##### Running create-virtualenv step. 07:29:00 INFO - ##### 07:29:00 INFO - Running pre-action listener: _resource_record_pre_action 07:29:00 INFO - Running main action method: create_virtualenv 07:29:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:29:00 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 07:29:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:29:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:29:00 INFO - Using real prefix '/usr' 07:29:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:29:01 INFO - Installing distribute.............................................................................................................................................................................................done. 07:29:03 INFO - Installing pip.................done. 07:29:03 INFO - Return code: 0 07:29:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:03 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 0x7f3ce897cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15737c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b7d70>, '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 0x15b8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b8fb0>, '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': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', '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 07:29:03 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 07:29:03 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 07:29:03 INFO - Using env: {'DISPLAY': ':0', 07:29:03 INFO - 'HOME': '/home/cltbld', 07:29:03 INFO - 'LANG': 'en_US.UTF-8', 07:29:03 INFO - 'LANGUAGE': 'en_US:en', 07:29:03 INFO - 'LOGNAME': 'cltbld', 07:29:03 INFO - 'MAIL': '/var/mail/cltbld', 07:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:03 INFO - 'MOZ_NO_REMOTE': '1', 07:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:03 INFO - 'NO_EM_RESTART': '1', 07:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:03 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:03 INFO - 'SHELL': '/bin/bash', 07:29:03 INFO - 'SHLVL': '1', 07:29:03 INFO - 'TERM': 'linux', 07:29:03 INFO - 'TMOUT': '86400', 07:29:03 INFO - 'USER': 'cltbld', 07:29:03 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', 07:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:03 INFO - '_': '/tools/buildbot/bin/python'} 07:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:03 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 07:29:03 INFO - Cleaning up... 07:29:03 INFO - Return code: 0 07:29:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:03 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 0x7f3ce897cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15737c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b7d70>, '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 0x15b8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b8fb0>, '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': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', '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 07:29:03 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 07:29:03 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 07:29:03 INFO - Using env: {'DISPLAY': ':0', 07:29:03 INFO - 'HOME': '/home/cltbld', 07:29:03 INFO - 'LANG': 'en_US.UTF-8', 07:29:03 INFO - 'LANGUAGE': 'en_US:en', 07:29:03 INFO - 'LOGNAME': 'cltbld', 07:29:03 INFO - 'MAIL': '/var/mail/cltbld', 07:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:03 INFO - 'MOZ_NO_REMOTE': '1', 07:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:03 INFO - 'NO_EM_RESTART': '1', 07:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:03 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:03 INFO - 'SHELL': '/bin/bash', 07:29:03 INFO - 'SHLVL': '1', 07:29:03 INFO - 'TERM': 'linux', 07:29:03 INFO - 'TMOUT': '86400', 07:29:03 INFO - 'USER': 'cltbld', 07:29:03 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', 07:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:03 INFO - '_': '/tools/buildbot/bin/python'} 07:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:03 INFO - Downloading/unpacking psutil>=0.7.1 07:29:03 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 07:29:03 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 07:29:03 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 07:29:03 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 07:29:03 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 07:29:03 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 07:29:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:29:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:29:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:29:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:05 INFO - Installing collected packages: psutil 07:29:05 INFO - Running setup.py install for psutil 07:29:05 INFO - building 'psutil._psutil_linux' extension 07:29:05 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 07:29:05 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 07:29:05 INFO - building 'psutil._psutil_posix' extension 07:29:05 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 07:29:05 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 07:29:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:05 INFO - Successfully installed psutil 07:29:05 INFO - Cleaning up... 07:29:05 INFO - Return code: 0 07:29:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:29:05 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')]} 07:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:05 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')]} 07:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:05 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 0x7f3ce897cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15737c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b7d70>, '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 0x15b8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b8fb0>, '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': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', '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 07:29:05 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 07:29:05 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 07:29:05 INFO - Using env: {'DISPLAY': ':0', 07:29:05 INFO - 'HOME': '/home/cltbld', 07:29:05 INFO - 'LANG': 'en_US.UTF-8', 07:29:05 INFO - 'LANGUAGE': 'en_US:en', 07:29:05 INFO - 'LOGNAME': 'cltbld', 07:29:05 INFO - 'MAIL': '/var/mail/cltbld', 07:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:05 INFO - 'MOZ_NO_REMOTE': '1', 07:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:05 INFO - 'NO_EM_RESTART': '1', 07:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:05 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:05 INFO - 'SHELL': '/bin/bash', 07:29:05 INFO - 'SHLVL': '1', 07:29:05 INFO - 'TERM': 'linux', 07:29:05 INFO - 'TMOUT': '86400', 07:29:05 INFO - 'USER': 'cltbld', 07:29:05 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', 07:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:05 INFO - '_': '/tools/buildbot/bin/python'} 07:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:29:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:29:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:29:07 INFO - Installing collected packages: mozsystemmonitor 07:29:07 INFO - Running setup.py install for mozsystemmonitor 07:29:07 INFO - Successfully installed mozsystemmonitor 07:29:07 INFO - Cleaning up... 07:29:07 INFO - Return code: 0 07:29:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:29:07 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')]} 07:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:07 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')]} 07:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:07 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 0x7f3ce897cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15737c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b7d70>, '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 0x15b8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b8fb0>, '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': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', '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 07:29:07 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 07:29:07 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 07:29:07 INFO - Using env: {'DISPLAY': ':0', 07:29:07 INFO - 'HOME': '/home/cltbld', 07:29:07 INFO - 'LANG': 'en_US.UTF-8', 07:29:07 INFO - 'LANGUAGE': 'en_US:en', 07:29:07 INFO - 'LOGNAME': 'cltbld', 07:29:07 INFO - 'MAIL': '/var/mail/cltbld', 07:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:07 INFO - 'MOZ_NO_REMOTE': '1', 07:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:07 INFO - 'NO_EM_RESTART': '1', 07:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:07 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:07 INFO - 'SHELL': '/bin/bash', 07:29:07 INFO - 'SHLVL': '1', 07:29:07 INFO - 'TERM': 'linux', 07:29:07 INFO - 'TMOUT': '86400', 07:29:07 INFO - 'USER': 'cltbld', 07:29:07 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', 07:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:07 INFO - '_': '/tools/buildbot/bin/python'} 07:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:08 INFO - Downloading/unpacking blobuploader==1.2.4 07:29:08 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 07:29:08 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 07:29:08 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 07:29:08 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 07:29:08 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 07:29:08 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 07:29:09 INFO - Downloading blobuploader-1.2.4.tar.gz 07:29:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:29:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:29:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:29:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:29:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:29:10 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 07:29:10 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 07:29:10 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 07:29:10 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 07:29:10 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 07:29:10 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 07:29:10 INFO - Downloading docopt-0.6.1.tar.gz 07:29:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:29:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:29:10 INFO - Installing collected packages: blobuploader, requests, docopt 07:29:10 INFO - Running setup.py install for blobuploader 07:29:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:29:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:29:10 INFO - Running setup.py install for requests 07:29:10 INFO - Running setup.py install for docopt 07:29:11 INFO - Successfully installed blobuploader requests docopt 07:29:11 INFO - Cleaning up... 07:29:11 INFO - Return code: 0 07:29:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:29: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')]} 07:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:11 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 0x7f3ce897cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15737c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b7d70>, '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 0x15b8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b8fb0>, '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': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', '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 07:29:11 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 07:29:11 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 07:29:11 INFO - Using env: {'DISPLAY': ':0', 07:29:11 INFO - 'HOME': '/home/cltbld', 07:29:11 INFO - 'LANG': 'en_US.UTF-8', 07:29:11 INFO - 'LANGUAGE': 'en_US:en', 07:29:11 INFO - 'LOGNAME': 'cltbld', 07:29:11 INFO - 'MAIL': '/var/mail/cltbld', 07:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:11 INFO - 'MOZ_NO_REMOTE': '1', 07:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:11 INFO - 'NO_EM_RESTART': '1', 07:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:11 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:11 INFO - 'SHELL': '/bin/bash', 07:29:11 INFO - 'SHLVL': '1', 07:29:11 INFO - 'TERM': 'linux', 07:29:11 INFO - 'TMOUT': '86400', 07:29:11 INFO - 'USER': 'cltbld', 07:29:11 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', 07:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:11 INFO - '_': '/tools/buildbot/bin/python'} 07:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:29:11 INFO - Running setup.py (path:/tmp/pip-55O87g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:29:11 INFO - Running setup.py (path:/tmp/pip-t22Yhp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:29:11 INFO - Running setup.py (path:/tmp/pip-F3nVh4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:29:11 INFO - Running setup.py (path:/tmp/pip-LhVO8d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:29:11 INFO - Running setup.py (path:/tmp/pip-yT0iJI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:29:11 INFO - Running setup.py (path:/tmp/pip-2Gn62K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:29:11 INFO - Running setup.py (path:/tmp/pip-64f_bJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:29:11 INFO - Running setup.py (path:/tmp/pip-Mj4zVR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:29:11 INFO - Running setup.py (path:/tmp/pip-X9Kgnw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:29:11 INFO - Running setup.py (path:/tmp/pip-ldzVmS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:29:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:29:12 INFO - Running setup.py (path:/tmp/pip-PpsnBm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:29:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:29:12 INFO - Running setup.py (path:/tmp/pip-MK9YMr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:29:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:29:12 INFO - Running setup.py (path:/tmp/pip-vb0lrg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:29:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:29:12 INFO - Running setup.py (path:/tmp/pip-wKTJ9c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:29:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:29:12 INFO - Running setup.py (path:/tmp/pip-pktxJg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:29:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:29:12 INFO - Running setup.py (path:/tmp/pip-g_JtzY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:29:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:29:12 INFO - Running setup.py (path:/tmp/pip-X_7Hmi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:29:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:29:12 INFO - Running setup.py install for manifestparser 07:29:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:29:12 INFO - Running setup.py install for mozcrash 07:29:12 INFO - Running setup.py install for mozdebug 07:29:12 INFO - Running setup.py install for mozdevice 07:29:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:29:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:29:12 INFO - Running setup.py install for mozfile 07:29:13 INFO - Running setup.py install for mozhttpd 07:29:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:29:13 INFO - Running setup.py install for mozinfo 07:29:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:29:13 INFO - Running setup.py install for mozInstall 07:29:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:29:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:29:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:29:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:29:13 INFO - Running setup.py install for mozleak 07:29:13 INFO - Running setup.py install for mozlog 07:29:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:29:13 INFO - Running setup.py install for moznetwork 07:29:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:29:13 INFO - Running setup.py install for mozprocess 07:29:13 INFO - Running setup.py install for mozprofile 07:29:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:29:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:29:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:29:13 INFO - Running setup.py install for mozrunner 07:29:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:29:14 INFO - Running setup.py install for mozscreenshot 07:29:14 INFO - Running setup.py install for moztest 07:29:14 INFO - Running setup.py install for mozversion 07:29:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:29:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:29:14 INFO - Cleaning up... 07:29:14 INFO - Return code: 0 07:29:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:14 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 0x7f3ce897cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15737c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b7d70>, '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 0x15b8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b8fb0>, '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': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', '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 07:29:14 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 07:29:14 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 07:29:14 INFO - Using env: {'DISPLAY': ':0', 07:29:14 INFO - 'HOME': '/home/cltbld', 07:29:14 INFO - 'LANG': 'en_US.UTF-8', 07:29:14 INFO - 'LANGUAGE': 'en_US:en', 07:29:14 INFO - 'LOGNAME': 'cltbld', 07:29:14 INFO - 'MAIL': '/var/mail/cltbld', 07:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:14 INFO - 'MOZ_NO_REMOTE': '1', 07:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:14 INFO - 'NO_EM_RESTART': '1', 07:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:14 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:14 INFO - 'SHELL': '/bin/bash', 07:29:14 INFO - 'SHLVL': '1', 07:29:14 INFO - 'TERM': 'linux', 07:29:14 INFO - 'TMOUT': '86400', 07:29:14 INFO - 'USER': 'cltbld', 07:29:14 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', 07:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:14 INFO - '_': '/tools/buildbot/bin/python'} 07:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:29:14 INFO - Running setup.py (path:/tmp/pip-h02ZTK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:29:14 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)) 07:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:29:14 INFO - Running setup.py (path:/tmp/pip-lM0362-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:29:14 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)) 07:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:29:14 INFO - Running setup.py (path:/tmp/pip-NG8hGw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:29:14 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)) 07:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:29:14 INFO - Running setup.py (path:/tmp/pip-vd8cbM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:29:14 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)) 07:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:29:14 INFO - Running setup.py (path:/tmp/pip-daNep4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:29:14 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)) 07:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:29:14 INFO - Running setup.py (path:/tmp/pip-pYItP0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:29:14 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)) 07:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:29:15 INFO - Running setup.py (path:/tmp/pip-bv4iFR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:29:15 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)) 07:29:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:29:15 INFO - Running setup.py (path:/tmp/pip-gXxEx9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:29:15 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)) 07:29:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:29:15 INFO - Running setup.py (path:/tmp/pip-Xl7kvJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:29:15 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)) 07:29:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:29:15 INFO - Running setup.py (path:/tmp/pip-Yes5TC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:29:15 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)) 07:29:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:29:15 INFO - Running setup.py (path:/tmp/pip-3Cpmli-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:29:15 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)) 07:29:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:29:15 INFO - Running setup.py (path:/tmp/pip-aPs0mn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:29:15 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)) 07:29:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:29:15 INFO - Running setup.py (path:/tmp/pip-rABoWI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:29:15 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)) 07:29:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:29:15 INFO - Running setup.py (path:/tmp/pip-IFv1Gz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:29:15 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)) 07:29:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:29:15 INFO - Running setup.py (path:/tmp/pip-vguYIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:29:15 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)) 07:29:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:29:15 INFO - Running setup.py (path:/tmp/pip-MFdH04-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:29:15 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)) 07:29:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:29:15 INFO - Running setup.py (path:/tmp/pip-6CQcWv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:29:15 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)) 07:29:15 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)) 07:29:15 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)) 07:29:15 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)) 07:29:15 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)) 07:29:15 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)) 07:29:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:29:15 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 07:29:15 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 07:29:15 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 07:29:15 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 07:29:15 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 07:29:15 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 07:29:17 INFO - Downloading blessings-1.5.1.tar.gz 07:29:17 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 07:29:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:29:17 INFO - Installing collected packages: blessings 07:29:17 INFO - Running setup.py install for blessings 07:29:17 INFO - Successfully installed blessings 07:29:17 INFO - Cleaning up... 07:29:17 INFO - Return code: 0 07:29:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:29:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:29:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:29:17 INFO - Reading from file tmpfile_stdout 07:29:17 INFO - Current package versions: 07:29:17 INFO - argparse == 1.2.1 07:29:17 INFO - blessings == 1.5.1 07:29:17 INFO - blobuploader == 1.2.4 07:29:17 INFO - docopt == 0.6.1 07:29:17 INFO - manifestparser == 1.1 07:29:17 INFO - mozInstall == 1.12 07:29:17 INFO - mozcrash == 0.16 07:29:17 INFO - mozdebug == 0.1 07:29:17 INFO - mozdevice == 0.47 07:29:17 INFO - mozfile == 1.2 07:29:17 INFO - mozhttpd == 0.7 07:29:17 INFO - mozinfo == 0.9 07:29:17 INFO - mozleak == 0.1 07:29:17 INFO - mozlog == 3.0 07:29:17 INFO - moznetwork == 0.27 07:29:17 INFO - mozprocess == 0.22 07:29:17 INFO - mozprofile == 0.27 07:29:17 INFO - mozrunner == 6.11 07:29:17 INFO - mozscreenshot == 0.1 07:29:17 INFO - mozsystemmonitor == 0.0 07:29:17 INFO - moztest == 0.7 07:29:17 INFO - mozversion == 1.4 07:29:17 INFO - psutil == 3.1.1 07:29:17 INFO - requests == 1.2.3 07:29:17 INFO - wsgiref == 0.1.2 07:29:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f3ce897cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15737c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b7d70>, '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 0x15b8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b8fb0>, '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': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', '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 07:29:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 07:29:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 07:29:17 INFO - Using env: {'DISPLAY': ':0', 07:29:17 INFO - 'HOME': '/home/cltbld', 07:29:17 INFO - 'LANG': 'en_US.UTF-8', 07:29:17 INFO - 'LANGUAGE': 'en_US:en', 07:29:17 INFO - 'LOGNAME': 'cltbld', 07:29:17 INFO - 'MAIL': '/var/mail/cltbld', 07:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:17 INFO - 'MOZ_NO_REMOTE': '1', 07:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:17 INFO - 'NO_EM_RESTART': '1', 07:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:17 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:17 INFO - 'SHELL': '/bin/bash', 07:29:17 INFO - 'SHLVL': '1', 07:29:17 INFO - 'TERM': 'linux', 07:29:17 INFO - 'TMOUT': '86400', 07:29:17 INFO - 'USER': 'cltbld', 07:29:17 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', 07:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:17 INFO - '_': '/tools/buildbot/bin/python'} 07:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:18 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)) 07:29:18 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)) 07:29:18 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)) 07:29:18 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)) 07:29:18 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)) 07:29:18 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)) 07:29:18 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)) 07:29:18 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)) 07:29:18 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)) 07:29:18 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)) 07:29:18 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)) 07:29:18 INFO - Cleaning up... 07:29:18 INFO - Return code: 0 07:29:18 INFO - Running post-action listener: _resource_record_post_action 07:29:18 INFO - Running post-action listener: _start_resource_monitoring 07:29:18 INFO - Starting resource monitoring. 07:29:18 INFO - ##### 07:29:18 INFO - ##### Running install step. 07:29:18 INFO - ##### 07:29:18 INFO - Running pre-action listener: _resource_record_pre_action 07:29:18 INFO - Running main action method: install 07:29:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:29:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:29:18 INFO - Reading from file tmpfile_stdout 07:29:18 INFO - Detecting whether we're running mozinstall >=1.0... 07:29:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:29:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:29:18 INFO - Reading from file tmpfile_stdout 07:29:18 INFO - Output received: 07:29:18 INFO - Usage: mozinstall [options] installer 07:29:18 INFO - Options: 07:29:18 INFO - -h, --help show this help message and exit 07:29:18 INFO - -d DEST, --destination=DEST 07:29:18 INFO - Directory to install application into. [default: 07:29:18 INFO - "/builds/slave/test-pgo"] 07:29:18 INFO - --app=APP Application being installed. [default: firefox] 07:29:18 INFO - mkdir: /builds/slave/test-pgo/build/application 07:29:18 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'] 07:29:18 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 07:29:33 INFO - Reading from file tmpfile_stdout 07:29:33 INFO - Output received: 07:29:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:29:33 INFO - Running post-action listener: _resource_record_post_action 07:29:33 INFO - ##### 07:29:33 INFO - ##### Running run-tests step. 07:29:33 INFO - ##### 07:29:33 INFO - Running pre-action listener: _resource_record_pre_action 07:29:33 INFO - Running main action method: run_tests 07:29:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:29:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:29:33 INFO - Python 2.7.3 07:29:33 INFO - Return code: 0 07:29:33 INFO - grabbing minidump binary from tooltool 07:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:33 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 0x15b7d70>, '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 0x15b8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b8fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:29:33 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 07:29:33 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 07:29:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:29:33 INFO - Return code: 0 07:29:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:29:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:29:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:29:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:29:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:29:33 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/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:29:33 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/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost 07:29:33 INFO - Using env: {'DISPLAY': ':0', 07:29:33 INFO - 'HOME': '/home/cltbld', 07:29:33 INFO - 'LANG': 'en_US.UTF-8', 07:29:33 INFO - 'LANGUAGE': 'en_US:en', 07:29:33 INFO - 'LOGNAME': 'cltbld', 07:29:33 INFO - 'MAIL': '/var/mail/cltbld', 07:29:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:29:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:33 INFO - 'MOZ_NO_REMOTE': '1', 07:29:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:33 INFO - 'NO_EM_RESTART': '1', 07:29:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:33 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:29:33 INFO - 'SHELL': '/bin/bash', 07:29:33 INFO - 'SHLVL': '1', 07:29:33 INFO - 'TERM': 'linux', 07:29:33 INFO - 'TMOUT': '86400', 07:29:33 INFO - 'USER': 'cltbld', 07:29:33 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360', 07:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:33 INFO - '_': '/tools/buildbot/bin/python'} 07:29:33 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/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] with output_timeout 3600 07:29:33 INFO - mozversion INFO | application_buildid: 20151120053001 07:29:33 INFO - mozversion INFO | application_changeset: 3d4f379b47fc12812f5e21657b63c6f426f5a063 07:29:33 INFO - mozversion INFO | application_display_name: Nightly 07:29:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:29:33 INFO - mozversion INFO | application_name: Firefox 07:29:33 INFO - mozversion INFO | application_remotingname: firefox 07:29:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:29:33 INFO - mozversion INFO | application_vendor: Mozilla 07:29:33 INFO - mozversion INFO | application_version: 45.0a1 07:29:33 INFO - mozversion INFO | platform_buildid: 20151120053001 07:29:33 INFO - mozversion INFO | platform_changeset: 3d4f379b47fc12812f5e21657b63c6f426f5a063 07:29:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:29:33 INFO - mozversion INFO | platform_version: 45.0a1 07:29:33 INFO - 2015-11-20 07:29:33,712 DEBUG : using testdate: 1448033373 07:29:33 INFO - 2015-11-20 07:29:33,712 DEBUG : actual date: 1448033373 07:29:33 INFO - 2015-11-20 07:29:33,720 INFO : starting webserver on 'localhost:50338' 07:29:33 INFO - 2015-11-20 07:29:33,721 INFO : Starting test suite talos-linux64-ix-044 07:29:33 INFO - 2015-11-20 07:29:33,721 INFO : Starting test dromaeo_css 07:29:33 INFO - 2015-11-20 07:29:33,721 DEBUG : operating with platform_type : linux_ 07:29:33 INFO - 2015-11-20 07:29:33,742 INFO : Initialising browser for dromaeo_css test... 07:29:33 INFO - 2015-11-20 07:29:33,749 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfG4Akx/profile http://localhost:50338/getInfo.html 07:29:37 INFO - 2015-11-20 07:29:37,991 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:29:37 INFO - 2015-11-20 07:29:37,991 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:29:37 INFO - 2015-11-20 07:29:37,991 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:29:37 INFO - 2015-11-20 07:29:37,991 DEBUG : BROWSER_OUTPUT: __metrics 07:29:38 INFO - 2015-11-20 07:29:38,257 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:29:39 INFO - 2015-11-20 07:29:39,571 INFO : Browser initialized. 07:29:39 INFO - 2015-11-20 07:29:39,572 INFO : Running cycle 1/1 for dromaeo_css test... 07:29:39 INFO - 2015-11-20 07:29:39,572 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfG4Akx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:29:51 INFO - 2015-11-20 07:29:51,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 141565952 07:29:51 INFO - 2015-11-20 07:29:51,267 DEBUG : BROWSER_OUTPUT: 07:30:41 INFO - 2015-11-20 07:30:41,922 DEBUG : BROWSER_OUTPUT: 1448033441921 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:32:51 INFO - 2015-11-20 07:32:51,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50338/tests/dromaeo/cssquery-ext.html) 07:32:52 INFO - 2015-11-20 07:32:52,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 260816896 07:32:52 INFO - 2015-11-20 07:32:52,868 DEBUG : BROWSER_OUTPUT: 07:35:55 INFO - 2015-11-20 07:35:55,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/dromaeo/cssquery-ext.html (next: http://localhost:50338/tests/dromaeo/cssquery-jquery.html) 07:35:55 INFO - 2015-11-20 07:35:55,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 216547328 07:35:55 INFO - 2015-11-20 07:35:55,813 DEBUG : BROWSER_OUTPUT: 07:38:57 INFO - 2015-11-20 07:38:57,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50338/tests/dromaeo/cssquery-mootools.html) 07:38:58 INFO - 2015-11-20 07:38:58,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 211386368 07:38:58 INFO - 2015-11-20 07:38:58,399 DEBUG : BROWSER_OUTPUT: 07:42:00 INFO - 2015-11-20 07:42:00,349 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50338/tests/dromaeo/cssquery-prototype.html) 07:42:00 INFO - 2015-11-20 07:42:00,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 200486912 07:42:00 INFO - 2015-11-20 07:42:00,913 DEBUG : BROWSER_OUTPUT: 07:45:03 INFO - 2015-11-20 07:45:03,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50338/tests/dromaeo/cssquery-yui.html) 07:45:03 INFO - 2015-11-20 07:45:03,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 205242368 07:45:03 INFO - 2015-11-20 07:45:03,943 DEBUG : BROWSER_OUTPUT: 07:48:06 INFO - 2015-11-20 07:48:06,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/dromaeo/cssquery-yui.html (next: http://localhost:50338/tests/dromaeo/cssquery-dojo.html) 07:48:06 INFO - 2015-11-20 07:48:06,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 272904192 07:48:06 INFO - 2015-11-20 07:48:06,810 DEBUG : BROWSER_OUTPUT: 07:48:06 INFO - 2015-11-20 07:48:06,811 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:48:06 INFO - 2015-11-20 07:48:06,811 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:48:06 INFO - 2015-11-20 07:48:06,812 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:48:06 INFO - 2015-11-20 07:48:06,812 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:48:06 INFO - 2015-11-20 07:48:06,815 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3204.1669166016836;3238.6599407062245;3269.6403395626476;3278.1968417737644;3293.44011518042;5311.176767601028;5379.919301210485;5487.533559647425;5502.779888804448;5526.281583394159;5411.134218525037;5417.106177480711;5441.211024401469;5484.204790305404;5502.669839809604;4950.28220907969;4959.504049595048;4983.72589507577;5038.420581633122;5040.16837221858;5059.11465493539;5102.081625307444;5152.381714194302;5166.509181627739;5169.612279079065;4920.803167873317;5106.591472682177;5113.386393632751;5189.403218629849;5204.687718736869;5014.222795466709;5019.397672279313;5041.143005689041;5090.898182036339;5114.028334616411;5044.268581055726;5052.444231134572;5067.34124563808;5067.569256613192;5106.514881086291;5197.948020519784;5348.331458567679;5392.379876314235;5404.891902161974;5408.4050754416985;5838.503727183194;5900.409959004065;5906.143609176688;5919.585629005971;5952.017917043682;5956.672383018932;6089.573729838913;6098.786542470993;6100.755969761204;6109.132269747648;5383.650062745909;5471.781128754885;5644.520215781664;5646.887062258773;5674.233978412903;5916.526677865761;6040.275166979991;6052.576319657582;6058.091286307089;6058.909116363258;5781.566382521328;5786.768529258782;5789.334226563915;5795.478406943395;5832.941670583325;5852.473277404969;5871.148683440877;5920.526357891358;5972.611780234271;5977.252843394575;5936.673482958392;5962.1056841473255;5966.463018328372;5976.282846058414;6024.578279520391;5972.343042265347;5976.61152025117;5984.910226346608;5995.910061349084;5998.4601385875485;4455.821767129279;4459.665525085632;4551.704139230939;4559.498455169929;4607;4000.219957108336;4003.6396724294955;4006.0385507478577;4037.899052523652;4050.5746896575433;5546.750396232179;5546.972265138648;5550.361708403585;5557.749901254453;5607.887842243133;5845.327787304429;5860.824175274749;5967.850803729854;5972.283326000907;5981.401859814071;5663.065594176997;5664.122061080539;5669.886602268014;5676.602637815396;5680.233168522197;5205.167173252337;5210.505002024802;5213.13983192769;5224.686518808883;5255.947440525622;6003.879922401527;6010.278766547867;6015.30823955242;6142.570020098639;6211.565190436717;5824.21373114641;5931.169636250842;5935.881282374415;5936.050231963038;5987.64074155552;6206.534509911865;6216.751329946752;6221.2845522765465;6221.5333849960525;6228.501719862491;5784.161296611884;5807.970960145172;5877.588568800314;5910.852228694317;5924.170616113834;6026.90959635597;6049.576529643059;6063.909041364295;6064.48451881595;6071.2714474263375;5903.557233207613;5907.5273978080795;5912.733926973383;5912.940870591239;5916.911246331222;5678.68767217807;5737.684427356368;5794.420557944172;5867.706614669335;5883.294004719461;5683.829485115453;5693.772249109989;5695;5695.231143795535;5696.145578163143;5782.306123265235;5815.04051831443;5815.273090863642;5817.243758311392;5877.823665290048;5431.83704488866;5506.889862202814;5690.146478028329;5836.503897168788;5847.678377689098 07:48:06 INFO - 2015-11-20 07:48:06,815 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.3980101490388;585.3911931591146;588.9263842019748;604.7127614383168;610.893093708601;30975.2256193595;31692.52461213081;31737.841310793443;39122;39539.80230098846;43423.348649770276;43919.34120988188;44050.559494405046;44185.558144418545;44198.779006105004;8752.693655722034;8914.50970196639;8923.196912277894;8926.553672316391;8926.73219803407;7930.444868859182;8108.594570271493;10371.740706482324;10730.248882578222;10743.731406714856;10416.531256093456;10539.47302634869;10547;10556.894431055667;10559.577616895314;7860.567668778215;8128.065272493621;10390.324628899136;10505.947470262638;10507.317024393466;10467.685969420854;10749.462526873625;10749.51627176771;10750.408727519984;10753.139748820076;40346;40501.594984050374;40664;40711.59288407108;40760.59239407627;3198.856051477666;3361.1765117546115;3628.2924829658227;3913.66733827625;3932.646061854447;30317.242068948453;30607.2348191297;30625.846870765727;30723.655106940158;31646.841765791254;3709.406494960793;3725.2177042820767;3753.6997040236715;3819.4079917612817;3924.921501569981;280479;280795;281481;281503;282107;56076;56978;57767.711161444764;58068.70965645145;58560;54200;54243.18635220475;54446.45553544414;54484;54566.45433545614;14320.283985800877;14534.709305814036;14555.927220364043;14559.199244041467;14578.05242659245;10730.087942524817;10781.460926953621;10785.083267922315;10786.191035672357;10845.186611004206;19007.239710411704;19008.144633491527;19017.429477115707;19021.14404851785;19057.714134287995;7094.964525177341;7238.819029524304;7400.111986561539;7424;7494.812629684193;936.784539555906;956.168133723651;1037.2687255484866;1043.4678314059731;1087.7552550676035;29002.5958466452;29212.415751684846;29277.56083658747;29297.98390516728;29458;1059.2214722179192;1067.5996501312009;1072.7961687279549;1083.0631503749357;1127.3574062784135;14927.477538286108;15040.398384064514;15274;15536.611584710472;15564.299606517734;249953;250175;250961;252918;254473;49747.751261243466;49817.75091124521;50050.74974625104;50176.247356289685;50237.24644130341;1324.0996122636507;1352.8579499152447;1376.3256004557895;1385.2588864957402;1386.1960063163342;26754.46491070129;29004.41991160207;29189.562156567245;29447.263818403855;29527.409451811272;54079.459205407446;55405.168922467004;55460.445395545525;55504;55525.55795536267;275328;280046;403683;413010;415955;31801.68198317987;31827;31855.522167167048;31950.201244969063;31955;42919.57080429281;44372.33441498445;45123.09753804971;45624;45868.77065614784;35592.82203588966;36005.819970899975;36742.26515469622;37436.812815935744;37787;36270.274594507435;36456.27087458289;37266;37461.81269093637;37772.81113594415;35991.10022249465;36339.818300909385;36665.63334366729;36983.445248321834;37027;31905;32700.50949235716;33448.1637959053;33453.83273083619;33466.49800252949;24891;25870.741292586834;27164.72835271701;27516.312092197855;33185.66814331826 07:48:06 INFO - 2015-11-20 07:48:06,817 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.3352298248243;360.9927801443973;361.9004773687237;363.9126609613693;365.21296605814473;14294.14235145892;14323.641908952255;17037.659246815056;17395.130243487823;18191.90904045481;11096.722581935455;11345.149113816455;15983;16412.589685257873;16489.587760306;4880.585150262223;4985.950140498585;4990.500949905017;4995.200767877141;4995.35060442142;3696.7042636589144;3707.4994875691705;4928.457869634337;4946.554810067093;5408.35099788024;5525.778968841261;5533.114701647737;5546.861328466801;5572.442755724415;5574.442555744414;5416.377116631598;5450.754716037788;6114.052321890092;6128.38716128388;6160.44555989963;5445.264889239941;5451.836444906659;5464.0711079116645;5477.370102438231;5482.835514934558;13417.194968301934;13465.057445978786;13501.189928604315;15093.698126037418;16067.437639682556;2069.8240649544655;2083.229205194088;2087.9977610746773;2104.8105670489576;2223.055201539339;9882.407055576688;9942.105210531015;9987.550560224807;11867.881321186764;13079.215247085205;1805.1064722962217;1827.1321122466854;1838.6506563752978;1868.467486766265;1880.786892454373;63145.68427157835;64161.03758443674;65343.3465665342;66361.66819165922;66828.3317166827;9777.364471309342;10253.84619230712;10289.176865850714;10303.484825758682;10325.277230593936;13444.193348399127;13460.730785384434;13558.389872455764;13561.728765424636;13615.31923403826;6967.1291088613925;7004.719811207597;7035.296470353026;7050.5769653820935;7187.2453392393045;6351.015592583157;6376.39424254695;6387.552871299057;6429.710663020175;6509.088727578142;4354.521002689701;4419.40338054365;4436.800343984529;4462.152191083684;4472.038511719996;1674.1127202582406;1772.1670814717063;1800.8379245867934;1830.5515148788631;2821.971780282212;926.9860952085725;945.6784693204344;949.662869681267;952.7951490429591;1058.7035630023606;16723.49829505117;16895.324187032627;17076.829231707772;17212.913935430242;17424.651506970044;868.8653258744905;878.2798105553385;932.7061975477703;977.6089564174245;1027.3271007490107;9266.860997085048;9637.084476974676;9797.265205109645;10016.699499015042;10166.69499914989;488099;506631;511264;513350;538245;78865;82916.58541707373;83478.5826070878;85413;87197;1105.530149686396;1126.4761885723178;1128.3004537186996;1143.4625725908809;1162.442027826648;15529.534113976599;15718.528444146694;15865.920670396574;15952.680946381239;16279.267432965307;36655;36950;37575;37676.43485347777;38726;45832.31251531163;47713.76143119262;49477.257841133134;49646.50353496419;49718.50281497139;9600.935798803292;9800.264980126376;9855.950720246354;9896.851547226654;9898.950505247427;11671.35807530594;14711.411543538139;17484.038377889337;17544.210510526802;17727.468175954225;13780.242086685328;14113.858861411254;14340.139591624536;14818.777718334019;14961;2859.5996560481135;13496.460141594227;13748.968827337789;13908.443662253396;14116.858831411966;11621.535138594361;11827.467763950815;14591;14641.487547936198;14688.339024744126;9018.016036471965;9383.108604682544;9537.427754334762;9691.321607487409;9723.854142188015;10118.8482172766;10210.540525676213;10218.540165692413;12320.75358492843;14409.639759006108 07:48:06 INFO - 2015-11-20 07:48:06,820 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1345.7039451320707;1733.1247719901448;1737.6177241006978;1771.1675512509125;1785.6517978994093;6918.1006469159;7523.13483949346;7698.884516732253;7747.651355688993;7764.107127680319;7513.774586762393;7661.157272700012;7670.539767613947;7672.616369181546;7680.884786728204;1984.6923726822365;2060.093558834108;2238.0488292475634;2241.0363543676212;2270.0579259607243;2293.9311820645407;2303.608386574278;2309.226409152936;2309.815214782813;2310.549442858643;2189.791969762878;2254.0983606557343;2256.808171305441;2259.344790010895;2259.8757068361233;1988.8707234029814;2038.7859274776083;2229.554089182162;2270.750217476076;2274.8976296066553;2313.329134550995;2328.092044102801;2356.5169140326193;2360.5986982213067;2376.572217000939;7782.066152061732;7800.219978002211;7822.217778222132;7837;7849.254320839511;4717.646176536773;4783.210770222909;4804.303376010494;4806.134895718769;4806.327114204014;3069.0946170879643;3087.5677405163296;3109.362580670957;3131.091983324833;3175.7935734177204;1035.342557476008;1062.6015244283394;1068.1935138970105;1108.1190453589415;1135.233717240859;10715.196360272932;10724.571017159382;10784.73038174044;10823.458827058615;10872.021518063413;4117.402976568381;4140.91718165635;4240.893977650583;4256.042390462121;4258.701890867672;8738.126187381338;8742.956285218534;8746.169113934293;8746.475211487332;8746.518941458153;4778.474367819537;4778.904421911542;4783.784729687172;4792.113459010095;4792.7363994980615;4342.34864770287;4349.456317960255;4356.934645980313;4398.164348773723;4409.382686423904;3464.0993341730828;3509.4911237870365;3512.2799826035603;3532.593751718534;3548.556430446194;1083.2092572422175;1084.6800193942806;1088.6244245735209;1092.2954694222342;1093.606301731376;983.1250187333279;1016.3038318751679;1268.6701457621084;1271.4723389793317;1289.6066699656694;7364;7444.404447644176;7552.735654252185;7565.054368203974;7569.810754731066;1094.6442406218011;1101.9504122314354;1110.6667999600088;1121.388843080523;1125.4935279124427;5668;5685.687287199244;5703.828885133453;5704.743286552115;5724.112762521732;9222.077792220858;9258.074192580689;9317.254619630414;9486.19367353769;9506.95423503414;9270.490123043162;9368.812623747623;9375;9419.387739796892;9431.292653051049;7217.3504384604585;7290.963257199603;7336.37640800538;7349.4855360124275;7399.038125043818;7078.787636370917;7104.538205016657;7106.147262328554;7112.644367781487;7115.359617634438;8002.879956800536;8280.378971577034;8384.203500667427;8394.748157555283;8406.285465735236;8487;8500.53247071417;8677.045524992373;8678.869816952878;8698.826023479369;6552.901706474502;6660.800175994728;6667.8666426670225;6684.465242780663;6684.565503242274;7510.361619262424;7559.20628334017;7569.053868266466;7572.734954276574;7576.545407275581;6775.457963362821;6879.346462086094;6895.55178913369;6992.755253566101;7002.964985175246;6717.966410167918;6830.282820303796;6989.790306290819;7044.436445084483;7114.288571142844;5971.223740913653;6209;6475.222973243241;6517.087607734826;6525.608463492205;6129.662868542095;6131.540134489842;6148.723307451086;6161.507079433724;6215.192025036717;6250.156228909221;6286.4342209201395;6291.276503202191;6361.522885783492;6392.041193820778 07:48:06 INFO - 2015-11-20 07:48:06,821 DEBUG : BROWSER_OUTPUT: |4;prototype.html;342.44535763206477;342.50166008457694;344.46435792342896;344.8775684631957;348.0932171692739;5974.1337506061645;6049.455549000589;6104.725287362068;6127.7855275065385;6145.078238264268;6016.51867850572;6023.728932198051;6025.06611475221;6034.909476357858;6036.69816509175;4525.773711314421;4667.556582124701;4671.229247174212;4673.369095172142;4681.227597446435;4656.138614356338;4689.202835517953;4690.179218636742;4695.3426520287185;4705.129551033053;4642.280446530776;4656.161890859644;4656.324832899228;4657.51096134906;4657.743824089691;4440.134173836103;4548.158590660738;4560.384348112995;4643.071385722852;4643.605293550052;4041.7979101045125;4061.370487574401;4062.756234625932;4069.064115253508;4077.7145599808027;5590.217369568264;5788.652680839121;5823.737931793079;5832.88334233313;5840.97079514604;5265.6840589564745;5350.732463376816;5441.782328706847;5442.047641662693;5445.237666726662;6419.711112999927;6454.290028096905;6470.417662410358;6472.708728107246;6482.157319548475;4494.8876278092985;4498.122866041123;4500.729956202638;4503.1218912312115;4506.8647940561505;6485.4811615070685;6596.274409814917;6684.2647308795995;6736;6801.761938332184;4579.9542004579525;4612.423447069116;4613.677042606985;4618.214903466419;4620.353150558924;4670.065986802653;4670.509596492319;4672.532746725368;4672.672912896132;4677.532246775295;5290.603204759658;5427.267318911975;5427.972860135674;5435.619506634576;5437.374701909331;6508.153939987771;6512.772052978123;6525.869482610321;6533.967330163318;6570.080188773575;1638.2873450049267;1639.1558347451073;1651.9587010324597;1652.2151977810445;1653.4626246469945;1074.1889873145724;1090.8963648453544;1091.956321747137;1107.379867274329;1120.8767035626074;6361;6361.777337793155;6362.9045564316575;6363.395477429637;6365.904511432333;6765.661716914135;6778.796636100925;6780.864382712318;6786.491013174032;6788.321167883271;6226.719797609118;6361.395667411681;6365.8726825464155;6370.426661600385;6371.076193951851;3651.707863370924;3683.079230192452;3684.2631473705364;3688.870889518854;3690;6975.267596902354;7015.754448594274;7035.226125126232;7084.964575177091;7093.113360829896;6688.565243259172;6743.325667433218;6762.425193858478;6838.350356716104;7017.859642807115;7026.43788496919;7026.508144429841;7050.6827192776445;7057.2237053925055;7072.328128827753;6706.731730730716;6781.966090169518;6812.625305608239;6819.4544436443975;6829.351211634887;6700.061991321121;6745.190577130776;6748.966255168889;6752.628605426552;6756.358145976124;7054.329838665319;7055.2944705529035;7055.6824942876665;7062.258462861531;7066.823329416806;4610.331501932268;4649.1863923812525;4651.674382793172;4654.394928659252;4654.883627909194;6652.567583107082;6798.354156355336;6801.965990170018;6803.863922721419;6814.829629259309;6621.50338724588;6625.204975402982;6626.56927299724;6629.3039230882;6646.867062658623;6466.902996455151;6601.108850305147;6603.075569420189;6614.04096406028;6620.437262832713;6465.903011454926;6494.7077381517;6498.285188629153;6498.577592456475;6502.057201705821;6643.534952553275;6648.5346025777735;6650;6652.800415987528;6653.63405012729;6368.554201206057;6480.092787009728;6480.837979050373;6484.157059582224;6501.512386570931 07:48:06 INFO - 2015-11-20 07:48:06,822 DEBUG : BROWSER_OUTPUT: |5;yui.html;768.2739810878714;784.6665167303896;822.9218224268697;840.4579046514998;846.0904527632795;14182.361793719281;14423.423063077478;14428.567142985701;14433.783493247609;14453.205073720941;10769.62306319279;10838.566457341696;10843.728906777314;10863.782724345529;12024.218425802339;669.5681285570804;807.1807115777491;820.4953953318726;821.2321479416735;821.8438496685641;813.9796505087361;817.513579420244;820.9220124088232;821.1993306526149;821.2198411509061;705.5942832871094;710.303902175868;802.8594995875699;849.9787505312355;864.4769914201912;829.0134739659785;840.0549381945311;841.6338892581747;841.6801615386175;844.6072576252042;622.0855342646303;625.587112505744;626.0859145647361;627.3162253144095;627.595201095291;13038.282894440801;13204.273764942924;13206.273654948975;13219.669508262274;13226.537071202558;12077.516899324017;12152.57465988695;12227.69430764229;12295.077869159759;12375.814362784566;10500.78998420035;10577.04806567405;10614.734631634194;10813.18901082414;10892.727681807939;3499.65003499648;3560.9821950890337;3591.5510561179854;3653.8903832885057;3657.1771351445977;51101.488985110045;51560;51578.22632660513;51694.741526292506;51986.22020669731;10023.148032417326;10204.132648724793;10596.09933155675;10620.734481637866;10644.042036216622;18456.907715461337;18486.075696215135;18488.260469581066;18509.074546272634;18523.814761852478;7170.892436613455;7433.4053275737815;7475.524198343151;7479.8504029919095;7718.073831140299;4222.071144348239;4376.212281789309;4378.781060947003;4385.473743150842;4589.151007063637;3151.070434221864;3175.1109689287036;3182.9681703182673;3188.6333071696586;3193.1857376368876;561.4638020690231;568.6360729133359;571.3030103273999;573.8421933968192;574.8332983434841;548.8161465908886;661.1240106858336;676.9120014398195;682.5154140560159;697.7313734212365;8174.632141553644;8420.621072051772;8611.698590549426;8649.178328058824;8825.514596697243;579.2882181688548;672.5998031171544;697.7941507255372;699.4439420660588;703.6903762344552;4221.535631080578;4481.843135490308;4555.681102322806;4593.678442508993;4617.781906445762;56224.15663765047;57796.422035779105;57826.132608010914;58297.70851145802;58737;50976.551765487115;51650.74174629103;52154.956900862526;52355.214671779955;52447.475525244256;46367.53632463632;46999.5300047002;47322.526774731814;47427;47593.99999999931;9094.636214551609;9114.453132812052;9235.492047937429;9308.348415610842;9309.627614895327;34393.82803085969;34452;34806.47790283097;35427.64572354243;35739;41110.38334425046;41865.58134418738;43883.34174987442;45893.31160032535;46038.309425359315;10783.51474183648;11349;11379.829302560634;11476.655700329004;11698.94150529276;12502;12614.180078294881;12700.872991270338;13285.535006274735;13291.66770830737;11231.550737970716;11611.825822612498;11785.469653865424;12042.096842736655;12215.938920305342;11752.412379381169;11904.821427678418;12042.698932526757;12553.309567973483;12564.183328083645;7415.547899093045;10698.62554810578;10926.125909927028;10982.176336774613;11053.171012173958;9871.753206169904;9896.802063958536;10112.140468060297;10340.638077667547;10629.734256643645;9104.226140778108;9148.451092934445;9344.205742511962;10098.949505252427;10212.689580902856 07:48:06 INFO - 2015-11-20 07:48:06,822 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:48:06 INFO - 2015-11-20 07:48:06,822 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:48:06 INFO - 2015-11-20 07:48:06,822 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,922 07:48:06 INFO - 2015-11-20 07:48:06,822 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:48:06 INFO - 2015-11-20 07:48:06,823 DEBUG : BROWSER_OUTPUT: __startTimestamp1448034486811__endTimestamp 07:48:06 INFO - 2015-11-20 07:48:06,823 DEBUG : BROWSER_OUTPUT: 07:48:06 INFO - 2015-11-20 07:48:06,823 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:48:06 INFO - 2015-11-20 07:48:06,823 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:48:06 INFO - 2015-11-20 07:48:06,823 DEBUG : BROWSER_OUTPUT: 07:48:06 INFO - 2015-11-20 07:48:06,823 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5516.21 Median:5695.23 stddev:627.28 (11.0%) stddev-sans-first:602.41 07:48:06 INFO - 2015-11-20 07:48:06,824 DEBUG : BROWSER_OUTPUT: Values: 3204.2 3238.7 3269.6 3278.2 3293.4 5311.2 5379.9 5487.5 5502.8 5526.3 5411.1 5417.1 5441.2 5484.2 5502.7 4950.3 4959.5 4983.7 5038.4 5040.2 5059.1 5102.1 5152.4 5166.5 5169.6 4920.8 5106.6 5113.4 5189.4 5204.7 5014.2 5019.4 5041.1 5090.9 5114.0 5044.3 5052.4 5067.3 5067.6 5106.5 5197.9 5348.3 5392.4 5404.9 5408.4 5838.5 5900.4 5906.1 5919.6 5952.0 5956.7 6089.6 6098.8 6100.8 6109.1 5383.7 5471.8 5644.5 5646.9 5674.2 5916.5 6040.3 6052.6 6058.1 6058.9 5781.6 5786.8 5789.3 5795.5 5832.9 5852.5 5871.1 5920.5 5972.6 5977.3 5936.7 5962.1 5966.5 5976.3 6024.6 5972.3 5976.6 5984.9 5995.9 5998.5 4455.8 4459.7 4551.7 4559.5 4607.0 4000.2 4003.6 4006.0 4037.9 4050.6 5546.8 5547.0 5550.4 5557.7 5607.9 5845.3 5860.8 5967.9 5972.3 5981.4 5663.1 5664.1 5669.9 5676.6 5680.2 5205.2 5210.5 5213.1 5224.7 5255.9 6003.9 6010.3 6015.3 6142.6 6211.6 5824.2 5931.2 5935.9 5936.1 5987.6 6206.5 6216.8 6221.3 6221.5 6228.5 5784.2 5808.0 5877.6 5910.9 5924.2 6026.9 6049.6 6063.9 6064.5 6071.3 5903.6 5907.5 5912.7 5912.9 5916.9 5678.7 5737.7 5794.4 5867.7 5883.3 5683.8 5693.8 5695.0 5695.2 5696.1 5782.3 5815.0 5815.3 5817.2 5877.8 5431.8 5506.9 5690.1 5836.5 5847.7 07:48:06 INFO - 2015-11-20 07:48:06,825 DEBUG : BROWSER_OUTPUT: 07:48:06 INFO - 2015-11-20 07:48:06,825 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46969.37 Median:32943.09 stddev:79258.03 (240.6%) stddev-sans-first:79403.76 07:48:06 INFO - 2015-11-20 07:48:06,825 DEBUG : BROWSER_OUTPUT: Values: 557.4 585.4 588.9 604.7 610.9 30975.2 31692.5 31737.8 39122.0 39539.8 43423.3 43919.3 44050.6 44185.6 44198.8 8752.7 8914.5 8923.2 8926.6 8926.7 7930.4 8108.6 10371.7 10730.2 10743.7 10416.5 10539.5 10547.0 10556.9 10559.6 7860.6 8128.1 10390.3 10505.9 10507.3 10467.7 10749.5 10749.5 10750.4 10753.1 40346.0 40501.6 40664.0 40711.6 40760.6 3198.9 3361.2 3628.3 3913.7 3932.6 30317.2 30607.2 30625.8 30723.7 31646.8 3709.4 3725.2 3753.7 3819.4 3924.9 280479.0 280795.0 281481.0 281503.0 282107.0 56076.0 56978.0 57767.7 58068.7 58560.0 54200.0 54243.2 54446.5 54484.0 54566.5 14320.3 14534.7 14555.9 14559.2 14578.1 10730.1 10781.5 10785.1 10786.2 10845.2 19007.2 19008.1 19017.4 19021.1 19057.7 7095.0 7238.8 7400.1 7424.0 7494.8 936.8 956.2 1037.3 1043.5 1087.8 29002.6 29212.4 29277.6 29298.0 29458.0 1059.2 1067.6 1072.8 1083.1 1127.4 14927.5 15040.4 15274.0 15536.6 15564.3 249953.0 250175.0 250961.0 252918.0 254473.0 49747.8 49817.8 50050.7 50176.2 50237.2 1324.1 1352.9 1376.3 1385.3 1386.2 26754.5 29004.4 29189.6 29447.3 29527.4 54079.5 55405.2 55460.4 55504.0 55525.6 275328.0 280046.0 403683.0 413010.0 415955.0 31801.7 31827.0 31855.5 31950.2 31955.0 42919.6 44372.3 45123.1 45624.0 45868.8 35592.8 36005.8 36742.3 37436.8 37787.0 36270.3 36456.3 37266.0 37461.8 37772.8 35991.1 36339.8 36665.6 36983.4 37027.0 31905.0 32700.5 33448.2 33453.8 33466.5 24891.0 25870.7 27164.7 27516.3 33185.7 07:48:06 INFO - 2015-11-20 07:48:06,825 DEBUG : BROWSER_OUTPUT: 07:48:06 INFO - 2015-11-20 07:48:06,826 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28003.57 Median:36802.50 stddev:83865.56 (227.9%) stddev-sans-first:84075.14 07:48:06 INFO - 2015-11-20 07:48:06,826 DEBUG : BROWSER_OUTPUT: Values: 359.3 361.0 361.9 363.9 365.2 14294.1 14323.6 17037.7 17395.1 18191.9 11096.7 11345.1 15983.0 16412.6 16489.6 4880.6 4986.0 4990.5 4995.2 4995.4 3696.7 3707.5 4928.5 4946.6 5408.4 5525.8 5533.1 5546.9 5572.4 5574.4 5416.4 5450.8 6114.1 6128.4 6160.4 5445.3 5451.8 5464.1 5477.4 5482.8 13417.2 13465.1 13501.2 15093.7 16067.4 2069.8 2083.2 2088.0 2104.8 2223.1 9882.4 9942.1 9987.6 11867.9 13079.2 1805.1 1827.1 1838.7 1868.5 1880.8 63145.7 64161.0 65343.3 66361.7 66828.3 9777.4 10253.8 10289.2 10303.5 10325.3 13444.2 13460.7 13558.4 13561.7 13615.3 6967.1 7004.7 7035.3 7050.6 7187.2 6351.0 6376.4 6387.6 6429.7 6509.1 4354.5 4419.4 4436.8 4462.2 4472.0 1674.1 1772.2 1800.8 1830.6 2822.0 927.0 945.7 949.7 952.8 1058.7 16723.5 16895.3 17076.8 17212.9 17424.7 868.9 878.3 932.7 977.6 1027.3 9266.9 9637.1 9797.3 10016.7 10166.7 488099.0 506631.0 511264.0 513350.0 538245.0 78865.0 82916.6 83478.6 85413.0 87197.0 1105.5 1126.5 1128.3 1143.5 1162.4 15529.5 15718.5 15865.9 15952.7 16279.3 36655.0 36950.0 37575.0 37676.4 38726.0 45832.3 47713.8 49477.3 49646.5 49718.5 9600.9 9800.3 9856.0 9896.9 9899.0 11671.4 14711.4 17484.0 17544.2 17727.5 13780.2 14113.9 14340.1 14818.8 14961.0 2859.6 13496.5 13749.0 13908.4 14116.9 11621.5 11827.5 14591.0 14641.5 14688.3 9018.0 9383.1 9537.4 9691.3 9723.9 10118.8 10210.5 10218.5 12320.8 14409.6 07:48:06 INFO - 2015-11-20 07:48:06,826 DEBUG : BROWSER_OUTPUT: 07:48:06 INFO - 2015-11-20 07:48:06,826 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5409.61 Median:6130.60 stddev:2794.60 (45.6%) stddev-sans-first:2785.75 07:48:06 INFO - 2015-11-20 07:48:06,828 DEBUG : BROWSER_OUTPUT: Values: 1345.7 1733.1 1737.6 1771.2 1785.7 6918.1 7523.1 7698.9 7747.7 7764.1 7513.8 7661.2 7670.5 7672.6 7680.9 1984.7 2060.1 2238.0 2241.0 2270.1 2293.9 2303.6 2309.2 2309.8 2310.5 2189.8 2254.1 2256.8 2259.3 2259.9 1988.9 2038.8 2229.6 2270.8 2274.9 2313.3 2328.1 2356.5 2360.6 2376.6 7782.1 7800.2 7822.2 7837.0 7849.3 4717.6 4783.2 4804.3 4806.1 4806.3 3069.1 3087.6 3109.4 3131.1 3175.8 1035.3 1062.6 1068.2 1108.1 1135.2 10715.2 10724.6 10784.7 10823.5 10872.0 4117.4 4140.9 4240.9 4256.0 4258.7 8738.1 8743.0 8746.2 8746.5 8746.5 4778.5 4778.9 4783.8 4792.1 4792.7 4342.3 4349.5 4356.9 4398.2 4409.4 3464.1 3509.5 3512.3 3532.6 3548.6 1083.2 1084.7 1088.6 1092.3 1093.6 983.1 1016.3 1268.7 1271.5 1289.6 7364.0 7444.4 7552.7 7565.1 7569.8 1094.6 1102.0 1110.7 1121.4 1125.5 5668.0 5685.7 5703.8 5704.7 5724.1 9222.1 9258.1 9317.3 9486.2 9507.0 9270.5 9368.8 9375.0 9419.4 9431.3 7217.4 7291.0 7336.4 7349.5 7399.0 7078.8 7104.5 7106.1 7112.6 7115.4 8002.9 8280.4 8384.2 8394.7 8406.3 8487.0 8500.5 8677.0 8678.9 8698.8 6552.9 6660.8 6667.9 6684.5 6684.6 7510.4 7559.2 7569.1 7572.7 7576.5 6775.5 6879.3 6895.6 6992.8 7003.0 6718.0 6830.3 6989.8 7044.4 7114.3 5971.2 6209.0 6475.2 6517.1 6525.6 6129.7 6131.5 6148.7 6161.5 6215.2 6250.2 6286.4 6291.3 6361.5 6392.0 07:48:06 INFO - 2015-11-20 07:48:06,828 DEBUG : BROWSER_OUTPUT: 07:48:06 INFO - 2015-11-20 07:48:06,828 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5463.75 Median:6293.86 stddev:1662.57 (26.4%) stddev-sans-first:1622.19 07:48:06 INFO - 2015-11-20 07:48:06,828 DEBUG : BROWSER_OUTPUT: Values: 342.4 342.5 344.5 344.9 348.1 5974.1 6049.5 6104.7 6127.8 6145.1 6016.5 6023.7 6025.1 6034.9 6036.7 4525.8 4667.6 4671.2 4673.4 4681.2 4656.1 4689.2 4690.2 4695.3 4705.1 4642.3 4656.2 4656.3 4657.5 4657.7 4440.1 4548.2 4560.4 4643.1 4643.6 4041.8 4061.4 4062.8 4069.1 4077.7 5590.2 5788.7 5823.7 5832.9 5841.0 5265.7 5350.7 5441.8 5442.0 5445.2 6419.7 6454.3 6470.4 6472.7 6482.2 4494.9 4498.1 4500.7 4503.1 4506.9 6485.5 6596.3 6684.3 6736.0 6801.8 4580.0 4612.4 4613.7 4618.2 4620.4 4670.1 4670.5 4672.5 4672.7 4677.5 5290.6 5427.3 5428.0 5435.6 5437.4 6508.2 6512.8 6525.9 6534.0 6570.1 1638.3 1639.2 1652.0 1652.2 1653.5 1074.2 1090.9 1092.0 1107.4 1120.9 6361.0 6361.8 6362.9 6363.4 6365.9 6765.7 6778.8 6780.9 6786.5 6788.3 6226.7 6361.4 6365.9 6370.4 6371.1 3651.7 3683.1 3684.3 3688.9 3690.0 6975.3 7015.8 7035.2 7085.0 7093.1 6688.6 6743.3 6762.4 6838.4 7017.9 7026.4 7026.5 7050.7 7057.2 7072.3 6706.7 6782.0 6812.6 6819.5 6829.4 6700.1 6745.2 6749.0 6752.6 6756.4 7054.3 7055.3 7055.7 7062.3 7066.8 4610.3 4649.2 4651.7 4654.4 4654.9 6652.6 6798.4 6802.0 6803.9 6814.8 6621.5 6625.2 6626.6 6629.3 6646.9 6466.9 6601.1 6603.1 6614.0 6620.4 6465.9 6494.7 6498.3 6498.6 6502.1 6643.5 6648.5 6650.0 6652.8 6653.6 6368.6 6480.1 6480.8 6484.2 6501.5 07:48:06 INFO - 2015-11-20 07:48:06,828 DEBUG : BROWSER_OUTPUT: 07:48:06 INFO - 2015-11-20 07:48:06,828 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13976.05 Median:25243.50 stddev:16212.14 (64.2%) stddev-sans-first:16227.28 07:48:06 INFO - 2015-11-20 07:48:06,828 DEBUG : BROWSER_OUTPUT: Values: 768.3 784.7 822.9 840.5 846.1 14182.4 14423.4 14428.6 14433.8 14453.2 10769.6 10838.6 10843.7 10863.8 12024.2 669.6 807.2 820.5 821.2 821.8 814.0 817.5 820.9 821.2 821.2 705.6 710.3 802.9 850.0 864.5 829.0 840.1 841.6 841.7 844.6 622.1 625.6 626.1 627.3 627.6 13038.3 13204.3 13206.3 13219.7 13226.5 12077.5 12152.6 12227.7 12295.1 12375.8 10500.8 10577.0 10614.7 10813.2 10892.7 3499.7 3561.0 3591.6 3653.9 3657.2 51101.5 51560.0 51578.2 51694.7 51986.2 10023.1 10204.1 10596.1 10620.7 10644.0 18456.9 18486.1 18488.3 18509.1 18523.8 7170.9 7433.4 7475.5 7479.9 7718.1 4222.1 4376.2 4378.8 4385.5 4589.2 3151.1 3175.1 3183.0 3188.6 3193.2 561.5 568.6 571.3 573.8 574.8 548.8 661.1 676.9 682.5 697.7 8174.6 8420.6 8611.7 8649.2 8825.5 579.3 672.6 697.8 699.4 703.7 4221.5 4481.8 4555.7 4593.7 4617.8 56224.2 57796.4 57826.1 58297.7 58737.0 50976.6 51650.7 52155.0 52355.2 52447.5 46367.5 46999.5 47322.5 47427.0 47594.0 9094.6 9114.5 9235.5 9308.3 9309.6 34393.8 34452.0 34806.5 35427.6 35739.0 41110.4 41865.6 43883.3 45893.3 46038.3 10783.5 11349.0 11379.8 11476.7 11698.9 12502.0 12614.2 12700.9 13285.5 13291.7 11231.6 11611.8 11785.5 12042.1 12215.9 11752.4 11904.8 12042.7 12553.3 12564.2 7415.5 10698.6 10926.1 10982.2 11053.2 9871.8 9896.8 10112.1 10340.6 10629.7 9104.2 9148.5 9344.2 10098.9 10212.7 07:48:06 INFO - 2015-11-20 07:48:06,828 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:48:06 INFO - 2015-11-20 07:48:06,829 DEBUG : BROWSER_OUTPUT: 07:48:07 INFO - 2015-11-20 07:48:07,509 INFO : Browser exited with error code: 0 07:48:07 INFO - 2015-11-20 07:48:07,526 INFO : Completed test dromaeo_css (00:18:33) 07:48:07 INFO - 2015-11-20 07:48:07,526 INFO : Starting test kraken 07:48:07 INFO - 2015-11-20 07:48:07,526 DEBUG : operating with platform_type : linux_ 07:48:07 INFO - 2015-11-20 07:48:07,526 INFO : Initialising browser for kraken test... 07:48:07 INFO - 2015-11-20 07:48:07,532 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDyaly7/profile http://localhost:50338/getInfo.html 07:48:11 INFO - 2015-11-20 07:48:11,552 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:48:11 INFO - 2015-11-20 07:48:11,552 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:48:11 INFO - 2015-11-20 07:48:11,552 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:48:11 INFO - 2015-11-20 07:48:11,552 DEBUG : BROWSER_OUTPUT: __metrics 07:48:11 INFO - 2015-11-20 07:48:11,649 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:48:12 INFO - 2015-11-20 07:48:12,952 INFO : Browser initialized. 07:48:12 INFO - 2015-11-20 07:48:12,952 INFO : Running cycle 1/1 for kraken test... 07:48:12 INFO - 2015-11-20 07:48:12,952 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDyaly7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:48:24 INFO - 2015-11-20 07:48:24,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 141774848 07:48:24 INFO - 2015-11-20 07:48:24,717 DEBUG : BROWSER_OUTPUT: 07:48:27 INFO - 2015-11-20 07:48:27,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50338/tests/kraken/driver.html?testName=audio-beat-detection) 07:48:27 INFO - 2015-11-20 07:48:27,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 176812032 07:48:27 INFO - 2015-11-20 07:48:27,765 DEBUG : BROWSER_OUTPUT: 07:48:30 INFO - 2015-11-20 07:48:30,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50338/tests/kraken/driver.html?testName=audio-dft) 07:48:30 INFO - 2015-11-20 07:48:30,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 167026688 07:48:30 INFO - 2015-11-20 07:48:30,915 DEBUG : BROWSER_OUTPUT: 07:48:33 INFO - 2015-11-20 07:48:33,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50338/tests/kraken/driver.html?testName=audio-fft) 07:48:34 INFO - 2015-11-20 07:48:34,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 152895488 07:48:34 INFO - 2015-11-20 07:48:34,363 DEBUG : BROWSER_OUTPUT: 07:48:36 INFO - 2015-11-20 07:48:36,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50338/tests/kraken/driver.html?testName=audio-oscillator) 07:48:36 INFO - 2015-11-20 07:48:36,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 154099712 07:48:36 INFO - 2015-11-20 07:48:36,904 DEBUG : BROWSER_OUTPUT: 07:48:39 INFO - 2015-11-20 07:48:39,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:48:39 INFO - 2015-11-20 07:48:39,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 155029504 07:48:39 INFO - 2015-11-20 07:48:39,610 DEBUG : BROWSER_OUTPUT: 07:48:42 INFO - 2015-11-20 07:48:42,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50338/tests/kraken/driver.html?testName=imaging-darkroom) 07:48:43 INFO - 2015-11-20 07:48:43,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 157249536 07:48:43 INFO - 2015-11-20 07:48:43,066 DEBUG : BROWSER_OUTPUT: 07:48:46 INFO - 2015-11-20 07:48:46,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50338/tests/kraken/driver.html?testName=imaging-desaturate) 07:48:47 INFO - 2015-11-20 07:48:47,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 155779072 07:48:47 INFO - 2015-11-20 07:48:47,009 DEBUG : BROWSER_OUTPUT: 07:48:49 INFO - 2015-11-20 07:48:49,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50338/tests/kraken/driver.html?testName=json-parse-financial) 07:48:50 INFO - 2015-11-20 07:48:50,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 155557888 07:48:50 INFO - 2015-11-20 07:48:50,345 DEBUG : BROWSER_OUTPUT: 07:48:51 INFO - 2015-11-20 07:48:51,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:48:52 INFO - 2015-11-20 07:48:52,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 164139008 07:48:52 INFO - 2015-11-20 07:48:52,461 DEBUG : BROWSER_OUTPUT: 07:48:54 INFO - 2015-11-20 07:48:54,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:48:54 INFO - 2015-11-20 07:48:54,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 164868096 07:48:54 INFO - 2015-11-20 07:48:54,868 DEBUG : BROWSER_OUTPUT: 07:48:56 INFO - 2015-11-20 07:48:56,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:48:57 INFO - 2015-11-20 07:48:57,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 170946560 07:48:57 INFO - 2015-11-20 07:48:57,534 DEBUG : BROWSER_OUTPUT: 07:48:59 INFO - 2015-11-20 07:48:59,896 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:49:00 INFO - 2015-11-20 07:49:00,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 180269056 07:49:00 INFO - 2015-11-20 07:49:00,483 DEBUG : BROWSER_OUTPUT: 07:49:03 INFO - 2015-11-20 07:49:03,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:49:03 INFO - 2015-11-20 07:49:03,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 179937280 07:49:03 INFO - 2015-11-20 07:49:03,640 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50338/tests/kraken/driver.html?testName=ai-astar) 07:49:05 INFO - 2015-11-20 07:49:05,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 238112768 07:49:05 INFO - 2015-11-20 07:49:05,555 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,556 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:49:05 INFO - 2015-11-20 07:49:05,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:49:05 INFO - 2015-11-20 07:49:05,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:49:05 INFO - 2015-11-20 07:49:05,556 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:49:05 INFO - 2015-11-20 07:49:05,557 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;103;109;110;110;99;109;113;110 07:49:05 INFO - 2015-11-20 07:49:05,557 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;123;148;160;125;147;145;132;167;123 07:49:05 INFO - 2015-11-20 07:49:05,557 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;161;161;160;160;162;159;160 07:49:05 INFO - 2015-11-20 07:49:05,557 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;85;92;71;72;72;128;93;71 07:49:05 INFO - 2015-11-20 07:49:05,557 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;134;90;92;90;132;90;91;132 07:49:05 INFO - 2015-11-20 07:49:05,558 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;109;110;111;110;110;110;109 07:49:05 INFO - 2015-11-20 07:49:05,558 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;146;146;146;146;145;147;145 07:49:05 INFO - 2015-11-20 07:49:05,558 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;97 07:49:05 INFO - 2015-11-20 07:49:05,558 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;58;61;60;59;59;66;56;56 07:49:05 INFO - 2015-11-20 07:49:05,558 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;69;68;69;69;69 07:49:05 INFO - 2015-11-20 07:49:05,558 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;90;91;84;83;84;93;93;85;93 07:49:05 INFO - 2015-11-20 07:49:05,558 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;122;113;113;120;117;119;131;115;115 07:49:05 INFO - 2015-11-20 07:49:05,559 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;148;146;150;151;149;149;152;147;137 07:49:05 INFO - 2015-11-20 07:49:05,559 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;68;66;65;65;65;65;65;66;64 07:49:05 INFO - 2015-11-20 07:49:05,559 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:49:05 INFO - 2015-11-20 07:49:05,559 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:49:05 INFO - 2015-11-20 07:49:05,559 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,922 07:49:05 INFO - 2015-11-20 07:49:05,559 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:49:05 INFO - 2015-11-20 07:49:05,559 DEBUG : BROWSER_OUTPUT: __startTimestamp1448034545555__endTimestamp 07:49:05 INFO - 2015-11-20 07:49:05,560 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,563 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:49:05 INFO - 2015-11-20 07:49:05,563 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:49:05 INFO - 2015-11-20 07:49:05,563 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,563 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:4.04 (3.7%) stddev-sans-first:4.27 07:49:05 INFO - 2015-11-20 07:49:05,563 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 103.0 109.0 110.0 110.0 99.0 109.0 113.0 110.0 07:49:05 INFO - 2015-11-20 07:49:05,563 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,563 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.70 Median:147.50 stddev:16.16 (11.0%) stddev-sans-first:16.29 07:49:05 INFO - 2015-11-20 07:49:05,563 DEBUG : BROWSER_OUTPUT: Values: 157.0 123.0 148.0 160.0 125.0 147.0 145.0 132.0 167.0 123.0 07:49:05 INFO - 2015-11-20 07:49:05,563 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 161.0 161.0 160.0 160.0 162.0 159.0 160.0 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.90 Median:72.50 stddev:18.14 (25.0%) stddev-sans-first:18.88 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 85.0 92.0 71.0 72.0 72.0 128.0 93.0 71.0 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.20 Median:90.00 stddev:20.35 (22.6%) stddev-sans-first:21.02 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 134.0 90.0 92.0 90.0 132.0 90.0 91.0 132.0 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 109.0 110.0 111.0 110.0 110.0 110.0 109.0 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 07:49:05 INFO - 2015-11-20 07:49:05,564 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 146.0 146.0 146.0 146.0 145.0 147.0 145.0 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.50 stddev:2.84 (4.8%) stddev-sans-first:3.00 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 58.0 61.0 60.0 59.0 59.0 66.0 56.0 56.0 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 69.0 68.0 69.0 69.0 69.0 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:90.50 stddev:4.59 (5.1%) stddev-sans-first:4.36 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: Values: 82.0 90.0 91.0 84.0 83.0 84.0 93.0 93.0 85.0 93.0 07:49:05 INFO - 2015-11-20 07:49:05,565 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,566 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:119.00 stddev:5.36 (4.5%) stddev-sans-first:5.68 07:49:05 INFO - 2015-11-20 07:49:05,566 DEBUG : BROWSER_OUTPUT: Values: 119.0 122.0 113.0 113.0 120.0 117.0 119.0 131.0 115.0 115.0 07:49:05 INFO - 2015-11-20 07:49:05,566 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,566 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:149.00 stddev:5.36 (3.6%) stddev-sans-first:4.42 07:49:05 INFO - 2015-11-20 07:49:05,566 DEBUG : BROWSER_OUTPUT: Values: 137.0 148.0 146.0 150.0 151.0 149.0 149.0 152.0 147.0 137.0 07:49:05 INFO - 2015-11-20 07:49:05,566 DEBUG : BROWSER_OUTPUT: 07:49:05 INFO - 2015-11-20 07:49:05,566 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 07:49:05 INFO - 2015-11-20 07:49:05,566 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 66.0 65.0 65.0 65.0 65.0 65.0 66.0 64.0 07:49:05 INFO - 2015-11-20 07:49:05,566 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:49:05 INFO - 2015-11-20 07:49:05,566 DEBUG : BROWSER_OUTPUT: 07:49:06 INFO - 2015-11-20 07:49:06,417 INFO : Browser exited with error code: 0 07:49:06 INFO - 2015-11-20 07:49:06,466 INFO : Completed test kraken (00:00:58) 07:49:06 INFO - 2015-11-20 07:49:06,467 INFO : Starting test v8_7 07:49:06 INFO - 2015-11-20 07:49:06,467 DEBUG : operating with platform_type : linux_ 07:49:06 INFO - 2015-11-20 07:49:06,467 INFO : Initialising browser for v8_7 test... 07:49:06 INFO - 2015-11-20 07:49:06,473 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZTippE/profile http://localhost:50338/getInfo.html 07:49:10 INFO - 2015-11-20 07:49:10,361 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:49:10 INFO - 2015-11-20 07:49:10,361 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:49:10 INFO - 2015-11-20 07:49:10,361 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:49:10 INFO - 2015-11-20 07:49:10,361 DEBUG : BROWSER_OUTPUT: __metrics 07:49:10 INFO - 2015-11-20 07:49:10,527 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:49:11 INFO - 2015-11-20 07:49:11,792 INFO : Browser initialized. 07:49:11 INFO - 2015-11-20 07:49:11,792 INFO : Running cycle 1/1 for v8_7 test... 07:49:11 INFO - 2015-11-20 07:49:11,793 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZTippE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:49:23 INFO - 2015-11-20 07:49:23,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 141709312 07:49:23 INFO - 2015-11-20 07:49:23,489 DEBUG : BROWSER_OUTPUT: 07:49:44 INFO - 2015-11-20 07:49:44,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/v8_7/run.html (next: http://localhost:50338/tests/v8_7/run.html) 07:49:45 INFO - 2015-11-20 07:49:45,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 589176832 07:49:45 INFO - 2015-11-20 07:49:45,218 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2015-11-20 07:49:45,219 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:49:45 INFO - 2015-11-20 07:49:45,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:49:45 INFO - 2015-11-20 07:49:45,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:49:45 INFO - 2015-11-20 07:49:45,220 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:49:45 INFO - 2015-11-20 07:49:45,220 DEBUG : BROWSER_OUTPUT: |0;Richards;163.90755613833798 07:49:45 INFO - 2015-11-20 07:49:45,220 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;195.38882375928097 07:49:45 INFO - 2015-11-20 07:49:45,220 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.2524161455372 07:49:45 INFO - 2015-11-20 07:49:45,220 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 07:49:45 INFO - 2015-11-20 07:49:45,220 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1102.5358324145534 07:49:45 INFO - 2015-11-20 07:49:45,220 DEBUG : BROWSER_OUTPUT: |5;Earley;791.1392405063291 07:49:45 INFO - 2015-11-20 07:49:45,221 DEBUG : BROWSER_OUTPUT: |6;Boyer;12444.444444444445 07:49:45 INFO - 2015-11-20 07:49:45,221 DEBUG : BROWSER_OUTPUT: |7;RegExp;25743.589743589742 07:49:45 INFO - 2015-11-20 07:49:45,221 DEBUG : BROWSER_OUTPUT: |8;Splay;664.2527978933509 07:49:45 INFO - 2015-11-20 07:49:45,221 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 07:49:45 INFO - 2015-11-20 07:49:45,221 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:49:45 INFO - 2015-11-20 07:49:45,221 DEBUG : BROWSER_OUTPUT: __startTimestamp1448034585218__endTimestamp 07:49:45 INFO - 2015-11-20 07:49:45,222 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2015-11-20 07:49:45,223 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:49:45 INFO - 2015-11-20 07:49:45,223 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:49:45 INFO - 2015-11-20 07:49:45,223 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2015-11-20 07:49:45,223 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.91 Median:163.91 stddev:0.00 (0.0%) 07:49:45 INFO - 2015-11-20 07:49:45,223 DEBUG : BROWSER_OUTPUT: Values: 163.9 07:49:45 INFO - 2015-11-20 07:49:45,224 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2015-11-20 07:49:45,224 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:195.39 Median:195.39 stddev:0.00 (0.0%) 07:49:45 INFO - 2015-11-20 07:49:45,224 DEBUG : BROWSER_OUTPUT: Values: 195.4 07:49:45 INFO - 2015-11-20 07:49:45,224 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2015-11-20 07:49:45,224 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.25 Median:284.25 stddev:0.00 (0.0%) 07:49:45 INFO - 2015-11-20 07:49:45,224 DEBUG : BROWSER_OUTPUT: Values: 284.3 07:49:45 INFO - 2015-11-20 07:49:45,224 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2015-11-20 07:49:45,225 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 07:49:45 INFO - 2015-11-20 07:49:45,225 DEBUG : BROWSER_OUTPUT: Values: 5035.2 07:49:45 INFO - 2015-11-20 07:49:45,225 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2015-11-20 07:49:45,225 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1102.54 Median:1102.54 stddev:0.00 (0.0%) 07:49:45 INFO - 2015-11-20 07:49:45,225 DEBUG : BROWSER_OUTPUT: Values: 1102.5 07:49:45 INFO - 2015-11-20 07:49:45,225 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2015-11-20 07:49:45,225 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 07:49:45 INFO - 2015-11-20 07:49:45,226 DEBUG : BROWSER_OUTPUT: Values: 791.1 07:49:45 INFO - 2015-11-20 07:49:45,226 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2015-11-20 07:49:45,226 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 07:49:45 INFO - 2015-11-20 07:49:45,226 DEBUG : BROWSER_OUTPUT: Values: 12444.4 07:49:45 INFO - 2015-11-20 07:49:45,226 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2015-11-20 07:49:45,226 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25743.59 Median:25743.59 stddev:0.00 (0.0%) 07:49:45 INFO - 2015-11-20 07:49:45,226 DEBUG : BROWSER_OUTPUT: Values: 25743.6 07:49:45 INFO - 2015-11-20 07:49:45,227 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2015-11-20 07:49:45,227 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:664.25 Median:664.25 stddev:0.00 (0.0%) 07:49:45 INFO - 2015-11-20 07:49:45,227 DEBUG : BROWSER_OUTPUT: Values: 664.3 07:49:45 INFO - 2015-11-20 07:49:45,227 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2015-11-20 07:49:45,227 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 07:49:45 INFO - 2015-11-20 07:49:45,227 DEBUG : BROWSER_OUTPUT: Values: 4840.6 07:49:45 INFO - 2015-11-20 07:49:45,227 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:49:45 INFO - 2015-11-20 07:49:45,227 DEBUG : BROWSER_OUTPUT: 07:49:46 INFO - 2015-11-20 07:49:46,110 INFO : Browser exited with error code: 0 07:49:46 INFO - 2015-11-20 07:49:46,124 INFO : Completed test v8_7 (00:00:39) 07:49:46 INFO - 2015-11-20 07:49:46,141 INFO : Completed test suite (00:20:12) 07:49:46 INFO - 2015-11-20 07:49:46,141 DEBUG : Working with test: dromaeo_css 07:49:46 INFO - 2015-11-20 07:49:46,142 DEBUG : Generating results file: dromaeo_css 07:49:46 INFO - 2015-11-20 07:49:46,143 DEBUG : Working with test: kraken 07:49:46 INFO - 2015-11-20 07:49:46,143 DEBUG : Generating results file: kraken 07:49:46 INFO - 2015-11-20 07:49:46,143 INFO : javascript benchmark 07:49:46 INFO - 2015-11-20 07:49:46,143 DEBUG : Working with test: v8_7 07:49:46 INFO - 2015-11-20 07:49:46,143 DEBUG : Generating results file: v8_7 07:49:46 INFO - 2015-11-20 07:49:46,144 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:49:46 INFO - 2015-11-20 07:49:46,195 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 07:49:46 INFO - 2015-11-20 07:49:46,196 DEBUG : process_Request line: dromaeo_css 7072.41 graph.html#tests=[[72,64,35]] 07:49:46 INFO - 2015-11-20 07:49:46,196 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:49:46 INFO - 2015-11-20 07:49:46,224 DEBUG : process_Request line: kraken 1496.00 graph.html#tests=[[232,64,35]] 07:49:46 INFO - 2015-11-20 07:49:46,224 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:49:46 INFO - 2015-11-20 07:49:46,254 DEBUG : process_Request line: v8_7 20796.33 graph.html#tests=[[230,64,35]] 07:49:46 INFO - 2015-11-20 07:49:46,255 INFO : javascript benchmark 07:49:46 INFO - 2015-11-20 07:49:46,259 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3204.1669166016836, 3238.6599407062245, 3269.6403395626476, 3278.1968417737644, 3293.44011518042, 5311.176767601028, 5379.919301210485, 5487.533559647425, 5502.779888804448, 5526.281583394159, 5411.134218525037, 5417.106177480711, 5441.211024401469, 5484.204790305404, 5502.669839809604, 4950.28220907969, 4959.504049595048, 4983.72589507577, 5038.420581633122, 5040.16837221858, 5059.11465493539, 5102.081625307444, 5152.381714194302, 5166.509181627739, 5169.612279079065, 4920.803167873317, 5106.591472682177, 5113.386393632751, 5189.403218629849, 5204.687718736869, 5014.222795466709, 5019.397672279313, 5041.143005689041, 5090.898182036339, 5114.028334616411, 5044.268581055726, 5052.444231134572, 5067.34124563808, 5067.569256613192, 5106.514881086291, 5197.948020519784, 5348.331458567679, 5392.379876314235, 5404.891902161974, 5408.4050754416985, 5838.503727183194, 5900.409959004065, 5906.143609176688, 5919.585629005971, 5952.017917043682, 5956.672383018932, 6089.573729838913, 6098.786542470993, 6100.755969761204, 6109.132269747648, 5383.650062745909, 5471.781128754885, 5644.520215781664, 5646.887062258773, 5674.233978412903, 5916.526677865761, 6040.275166979991, 6052.576319657582, 6058.091286307089, 6058.909116363258, 5781.566382521328, 5786.768529258782, 5789.334226563915, 5795.478406943395, 5832.941670583325, 5852.473277404969, 5871.148683440877, 5920.526357891358, 5972.611780234271, 5977.252843394575, 5936.673482958392, 5962.1056841473255, 5966.463018328372, 5976.282846058414, 6024.578279520391, 5972.343042265347, 5976.61152025117, 5984.910226346608, 5995.910061349084, 5998.4601385875485, 4455.821767129279, 4459.665525085632, 4551.704139230939, 4559.498455169929, 4607.0, 4000.219957108336, 4003.6396724294955, 4006.0385507478577, 4037.899052523652, 4050.5746896575433, 5546.750396232179, 5546.972265138648, 5550.361708403585, 5557.749901254453, 5607.887842243133, 5845.327787304429, 5860.824175274749, 5967.850803729854, 5972.283326000907, 5981.401859814071, 5663.065594176997, 5664.122061080539, 5669.886602268014, 5676.602637815396, 5680.233168522197, 5205.167173252337, 5210.505002024802, 5213.13983192769, 5224.686518808883, 5255.947440525622, 6003.879922401527, 6010.278766547867, 6015.30823955242, 6142.570020098639, 6211.565190436717, 5824.21373114641, 5931.169636250842, 5935.881282374415, 5936.050231963038, 5987.64074155552, 6206.534509911865, 6216.751329946752, 6221.2845522765465, 6221.5333849960525, 6228.501719862491, 5784.161296611884, 5807.970960145172, 5877.588568800314, 5910.852228694317, 5924.170616113834, 6026.90959635597, 6049.576529643059, 6063.909041364295, 6064.48451881595, 6071.2714474263375, 5903.557233207613, 5907.5273978080795, 5912.733926973383, 5912.940870591239, 5916.911246331222, 5678.68767217807, 5737.684427356368, 5794.420557944172, 5867.706614669335, 5883.294004719461, 5683.829485115453, 5693.772249109989, 5695.0, 5695.231143795535, 5696.145578163143, 5782.306123265235, 5815.04051831443, 5815.273090863642, 5817.243758311392, 5877.823665290048, 5431.83704488866, 5506.889862202814, 5690.146478028329, 5836.503897168788, 5847.678377689098], "unit": "ms", "name": "dojo.html", "value": 5474.208027979579}, {"lowerIsBetter": false, "replicates": [557.3980101490388, 585.3911931591146, 588.9263842019748, 604.7127614383168, 610.893093708601, 30975.2256193595, 31692.52461213081, 31737.841310793443, 39122.0, 39539.80230098846, 43423.348649770276, 43919.34120988188, 44050.559494405046, 44185.558144418545, 44198.779006105004, 8752.693655722034, 8914.50970196639, 8923.196912277894, 8926.553672316391, 8926.73219803407, 7930.444868859182, 8108.594570271493, 10371.740706482324, 10730.248882578222, 10743.731406714856, 10416.531256093456, 10539.47302634869, 10547.0, 10556.894431055667, 10559.577616895314, 7860.567668778215, 8128.065272493621, 10390.324628899136, 10505.947470262638, 10507.317024393466, 10467.685969420854, 10749.462526873625, 10749.51627176771, 10750.408727519984, 10753.139748820076, 40346.0, 40501.594984050374, 40664.0, 40711.59288407108, 40760.59239407627, 3198.856051477666, 3361.1765117546115, 3628.2924829658227, 3913.66733827625, 3932.646061854447, 30317.242068948453, 30607.2348191297, 30625.846870765727, 30723.655106940158, 31646.841765791254, 3709.406494960793, 3725.2177042820767, 3753.6997040236715, 3819.4079917612817, 3924.921501569981, 280479.0, 280795.0, 281481.0, 281503.0, 282107.0, 56076.0, 56978.0, 57767.711161444764, 58068.70965645145, 58560.0, 54200.0, 54243.18635220475, 54446.45553544414, 54484.0, 54566.45433545614, 14320.283985800877, 14534.709305814036, 14555.927220364043, 14559.199244041467, 14578.05242659245, 10730.087942524817, 10781.460926953621, 10785.083267922315, 10786.191035672357, 10845.186611004206, 19007.239710411704, 19008.144633491527, 19017.429477115707, 19021.14404851785, 19057.714134287995, 7094.964525177341, 7238.819029524304, 7400.111986561539, 7424.0, 7494.812629684193, 936.784539555906, 956.168133723651, 1037.2687255484866, 1043.4678314059731, 1087.7552550676035, 29002.5958466452, 29212.415751684846, 29277.56083658747, 29297.98390516728, 29458.0, 1059.2214722179192, 1067.5996501312009, 1072.7961687279549, 1083.0631503749357, 1127.3574062784135, 14927.477538286108, 15040.398384064514, 15274.0, 15536.611584710472, 15564.299606517734, 249953.0, 250175.0, 250961.0, 252918.0, 254473.0, 49747.751261243466, 49817.75091124521, 50050.74974625104, 50176.247356289685, 50237.24644130341, 1324.0996122636507, 1352.8579499152447, 1376.3256004557895, 1385.2588864957402, 1386.1960063163342, 26754.46491070129, 29004.41991160207, 29189.562156567245, 29447.263818403855, 29527.409451811272, 54079.459205407446, 55405.168922467004, 55460.445395545525, 55504.0, 55525.55795536267, 275328.0, 280046.0, 403683.0, 413010.0, 415955.0, 31801.68198317987, 31827.0, 31855.522167167048, 31950.201244969063, 31955.0, 42919.57080429281, 44372.33441498445, 45123.09753804971, 45624.0, 45868.77065614784, 35592.82203588966, 36005.819970899975, 36742.26515469622, 37436.812815935744, 37787.0, 36270.274594507435, 36456.27087458289, 37266.0, 37461.81269093637, 37772.81113594415, 35991.10022249465, 36339.818300909385, 36665.63334366729, 36983.445248321834, 37027.0, 31905.0, 32700.50949235716, 33448.1637959053, 33453.83273083619, 33466.49800252949, 24891.0, 25870.741292586834, 27164.72835271701, 27516.312092197855, 33185.66814331826], "unit": "ms", "name": "ext.html", "value": 18860.547724385116}, {"lowerIsBetter": false, "replicates": [359.3352298248243, 360.9927801443973, 361.9004773687237, 363.9126609613693, 365.21296605814473, 14294.14235145892, 14323.641908952255, 17037.659246815056, 17395.130243487823, 18191.90904045481, 11096.722581935455, 11345.149113816455, 15983.0, 16412.589685257873, 16489.587760306, 4880.585150262223, 4985.950140498585, 4990.500949905017, 4995.200767877141, 4995.35060442142, 3696.7042636589144, 3707.4994875691705, 4928.457869634337, 4946.554810067093, 5408.35099788024, 5525.778968841261, 5533.114701647737, 5546.861328466801, 5572.442755724415, 5574.442555744414, 5416.377116631598, 5450.754716037788, 6114.052321890092, 6128.38716128388, 6160.44555989963, 5445.264889239941, 5451.836444906659, 5464.0711079116645, 5477.370102438231, 5482.835514934558, 13417.194968301934, 13465.057445978786, 13501.189928604315, 15093.698126037418, 16067.437639682556, 2069.8240649544655, 2083.229205194088, 2087.9977610746773, 2104.8105670489576, 2223.055201539339, 9882.407055576688, 9942.105210531015, 9987.550560224807, 11867.881321186764, 13079.215247085205, 1805.1064722962217, 1827.1321122466854, 1838.6506563752978, 1868.467486766265, 1880.786892454373, 63145.68427157835, 64161.03758443674, 65343.3465665342, 66361.66819165922, 66828.3317166827, 9777.364471309342, 10253.84619230712, 10289.176865850714, 10303.484825758682, 10325.277230593936, 13444.193348399127, 13460.730785384434, 13558.389872455764, 13561.728765424636, 13615.31923403826, 6967.1291088613925, 7004.719811207597, 7035.296470353026, 7050.5769653820935, 7187.2453392393045, 6351.015592583157, 6376.39424254695, 6387.552871299057, 6429.710663020175, 6509.088727578142, 4354.521002689701, 4419.40338054365, 4436.800343984529, 4462.152191083684, 4472.038511719996, 1674.1127202582406, 1772.1670814717063, 1800.8379245867934, 1830.5515148788631, 2821.971780282212, 926.9860952085725, 945.6784693204344, 949.662869681267, 952.7951490429591, 1058.7035630023606, 16723.49829505117, 16895.324187032627, 17076.829231707772, 17212.913935430242, 17424.651506970044, 868.8653258744905, 878.2798105553385, 932.7061975477703, 977.6089564174245, 1027.3271007490107, 9266.860997085048, 9637.084476974676, 9797.265205109645, 10016.699499015042, 10166.69499914989, 488099.0, 506631.0, 511264.0, 513350.0, 538245.0, 78865.0, 82916.58541707373, 83478.5826070878, 85413.0, 87197.0, 1105.530149686396, 1126.4761885723178, 1128.3004537186996, 1143.4625725908809, 1162.442027826648, 15529.534113976599, 15718.528444146694, 15865.920670396574, 15952.680946381239, 16279.267432965307, 36655.0, 36950.0, 37575.0, 37676.43485347777, 38726.0, 45832.31251531163, 47713.76143119262, 49477.257841133134, 49646.50353496419, 49718.50281497139, 9600.935798803292, 9800.264980126376, 9855.950720246354, 9896.851547226654, 9898.950505247427, 11671.35807530594, 14711.411543538139, 17484.038377889337, 17544.210510526802, 17727.468175954225, 13780.242086685328, 14113.858861411254, 14340.139591624536, 14818.777718334019, 14961.0, 2859.5996560481135, 13496.460141594227, 13748.968827337789, 13908.443662253396, 14116.858831411966, 11621.535138594361, 11827.467763950815, 14591.0, 14641.487547936198, 14688.339024744126, 9018.016036471965, 9383.108604682544, 9537.427754334762, 9691.321607487409, 9723.854142188015, 10118.8482172766, 10210.540525676213, 10218.540165692413, 12320.75358492843, 14409.639759006108], "unit": "ms", "name": "jquery.html", "value": 8671.486703456281}, {"lowerIsBetter": false, "replicates": [1345.7039451320707, 1733.1247719901448, 1737.6177241006978, 1771.1675512509125, 1785.6517978994093, 6918.1006469159, 7523.13483949346, 7698.884516732253, 7747.651355688993, 7764.107127680319, 7513.774586762393, 7661.157272700012, 7670.539767613947, 7672.616369181546, 7680.884786728204, 1984.6923726822365, 2060.093558834108, 2238.0488292475634, 2241.0363543676212, 2270.0579259607243, 2293.9311820645407, 2303.608386574278, 2309.226409152936, 2309.815214782813, 2310.549442858643, 2189.791969762878, 2254.0983606557343, 2256.808171305441, 2259.344790010895, 2259.8757068361233, 1988.8707234029814, 2038.7859274776083, 2229.554089182162, 2270.750217476076, 2274.8976296066553, 2313.329134550995, 2328.092044102801, 2356.5169140326193, 2360.5986982213067, 2376.572217000939, 7782.066152061732, 7800.219978002211, 7822.217778222132, 7837.0, 7849.254320839511, 4717.646176536773, 4783.210770222909, 4804.303376010494, 4806.134895718769, 4806.327114204014, 3069.0946170879643, 3087.5677405163296, 3109.362580670957, 3131.091983324833, 3175.7935734177204, 1035.342557476008, 1062.6015244283394, 1068.1935138970105, 1108.1190453589415, 1135.233717240859, 10715.196360272932, 10724.571017159382, 10784.73038174044, 10823.458827058615, 10872.021518063413, 4117.402976568381, 4140.91718165635, 4240.893977650583, 4256.042390462121, 4258.701890867672, 8738.126187381338, 8742.956285218534, 8746.169113934293, 8746.475211487332, 8746.518941458153, 4778.474367819537, 4778.904421911542, 4783.784729687172, 4792.113459010095, 4792.7363994980615, 4342.34864770287, 4349.456317960255, 4356.934645980313, 4398.164348773723, 4409.382686423904, 3464.0993341730828, 3509.4911237870365, 3512.2799826035603, 3532.593751718534, 3548.556430446194, 1083.2092572422175, 1084.6800193942806, 1088.6244245735209, 1092.2954694222342, 1093.606301731376, 983.1250187333279, 1016.3038318751679, 1268.6701457621084, 1271.4723389793317, 1289.6066699656694, 7364.0, 7444.404447644176, 7552.735654252185, 7565.054368203974, 7569.810754731066, 1094.6442406218011, 1101.9504122314354, 1110.6667999600088, 1121.388843080523, 1125.4935279124427, 5668.0, 5685.687287199244, 5703.828885133453, 5704.743286552115, 5724.112762521732, 9222.077792220858, 9258.074192580689, 9317.254619630414, 9486.19367353769, 9506.95423503414, 9270.490123043162, 9368.812623747623, 9375.0, 9419.387739796892, 9431.292653051049, 7217.3504384604585, 7290.963257199603, 7336.37640800538, 7349.4855360124275, 7399.038125043818, 7078.787636370917, 7104.538205016657, 7106.147262328554, 7112.644367781487, 7115.359617634438, 8002.879956800536, 8280.378971577034, 8384.203500667427, 8394.748157555283, 8406.285465735236, 8487.0, 8500.53247071417, 8677.045524992373, 8678.869816952878, 8698.826023479369, 6552.901706474502, 6660.800175994728, 6667.8666426670225, 6684.465242780663, 6684.565503242274, 7510.361619262424, 7559.20628334017, 7569.053868266466, 7572.734954276574, 7576.545407275581, 6775.457963362821, 6879.346462086094, 6895.55178913369, 6992.755253566101, 7002.964985175246, 6717.966410167918, 6830.282820303796, 6989.790306290819, 7044.436445084483, 7114.288571142844, 5971.223740913653, 6209.0, 6475.222973243241, 6517.087607734826, 6525.608463492205, 6129.662868542095, 6131.540134489842, 6148.723307451086, 6161.507079433724, 6215.192025036717, 6250.156228909221, 6286.4342209201395, 6291.276503202191, 6361.522885783492, 6392.041193820778], "unit": "ms", "name": "mootools.html", "value": 4457.987750569902}, {"lowerIsBetter": false, "replicates": [342.44535763206477, 342.50166008457694, 344.46435792342896, 344.8775684631957, 348.0932171692739, 5974.1337506061645, 6049.455549000589, 6104.725287362068, 6127.7855275065385, 6145.078238264268, 6016.51867850572, 6023.728932198051, 6025.06611475221, 6034.909476357858, 6036.69816509175, 4525.773711314421, 4667.556582124701, 4671.229247174212, 4673.369095172142, 4681.227597446435, 4656.138614356338, 4689.202835517953, 4690.179218636742, 4695.3426520287185, 4705.129551033053, 4642.280446530776, 4656.161890859644, 4656.324832899228, 4657.51096134906, 4657.743824089691, 4440.134173836103, 4548.158590660738, 4560.384348112995, 4643.071385722852, 4643.605293550052, 4041.7979101045125, 4061.370487574401, 4062.756234625932, 4069.064115253508, 4077.7145599808027, 5590.217369568264, 5788.652680839121, 5823.737931793079, 5832.88334233313, 5840.97079514604, 5265.6840589564745, 5350.732463376816, 5441.782328706847, 5442.047641662693, 5445.237666726662, 6419.711112999927, 6454.290028096905, 6470.417662410358, 6472.708728107246, 6482.157319548475, 4494.8876278092985, 4498.122866041123, 4500.729956202638, 4503.1218912312115, 4506.8647940561505, 6485.4811615070685, 6596.274409814917, 6684.2647308795995, 6736.0, 6801.761938332184, 4579.9542004579525, 4612.423447069116, 4613.677042606985, 4618.214903466419, 4620.353150558924, 4670.065986802653, 4670.509596492319, 4672.532746725368, 4672.672912896132, 4677.532246775295, 5290.603204759658, 5427.267318911975, 5427.972860135674, 5435.619506634576, 5437.374701909331, 6508.153939987771, 6512.772052978123, 6525.869482610321, 6533.967330163318, 6570.080188773575, 1638.2873450049267, 1639.1558347451073, 1651.9587010324597, 1652.2151977810445, 1653.4626246469945, 1074.1889873145724, 1090.8963648453544, 1091.956321747137, 1107.379867274329, 1120.8767035626074, 6361.0, 6361.777337793155, 6362.9045564316575, 6363.395477429637, 6365.904511432333, 6765.661716914135, 6778.796636100925, 6780.864382712318, 6786.491013174032, 6788.321167883271, 6226.719797609118, 6361.395667411681, 6365.8726825464155, 6370.426661600385, 6371.076193951851, 3651.707863370924, 3683.079230192452, 3684.2631473705364, 3688.870889518854, 3690.0, 6975.267596902354, 7015.754448594274, 7035.226125126232, 7084.964575177091, 7093.113360829896, 6688.565243259172, 6743.325667433218, 6762.425193858478, 6838.350356716104, 7017.859642807115, 7026.43788496919, 7026.508144429841, 7050.6827192776445, 7057.2237053925055, 7072.328128827753, 6706.731730730716, 6781.966090169518, 6812.625305608239, 6819.4544436443975, 6829.351211634887, 6700.061991321121, 6745.190577130776, 6748.966255168889, 6752.628605426552, 6756.358145976124, 7054.329838665319, 7055.2944705529035, 7055.6824942876665, 7062.258462861531, 7066.823329416806, 4610.331501932268, 4649.1863923812525, 4651.674382793172, 4654.394928659252, 4654.883627909194, 6652.567583107082, 6798.354156355336, 6801.965990170018, 6803.863922721419, 6814.829629259309, 6621.50338724588, 6625.204975402982, 6626.56927299724, 6629.3039230882, 6646.867062658623, 6466.902996455151, 6601.108850305147, 6603.075569420189, 6614.04096406028, 6620.437262832713, 6465.903011454926, 6494.7077381517, 6498.285188629153, 6498.577592456475, 6502.057201705821, 6643.534952553275, 6648.5346025777735, 6650.0, 6652.800415987528, 6653.63405012729, 6368.554201206057, 6480.092787009728, 6480.837979050373, 6484.157059582224, 6501.512386570931], "unit": "ms", "name": "prototype.html", "value": 4922.390102781564}, {"lowerIsBetter": false, "replicates": [768.2739810878714, 784.6665167303896, 822.9218224268697, 840.4579046514998, 846.0904527632795, 14182.361793719281, 14423.423063077478, 14428.567142985701, 14433.783493247609, 14453.205073720941, 10769.62306319279, 10838.566457341696, 10843.728906777314, 10863.782724345529, 12024.218425802339, 669.5681285570804, 807.1807115777491, 820.4953953318726, 821.2321479416735, 821.8438496685641, 813.9796505087361, 817.513579420244, 820.9220124088232, 821.1993306526149, 821.2198411509061, 705.5942832871094, 710.303902175868, 802.8594995875699, 849.9787505312355, 864.4769914201912, 829.0134739659785, 840.0549381945311, 841.6338892581747, 841.6801615386175, 844.6072576252042, 622.0855342646303, 625.587112505744, 626.0859145647361, 627.3162253144095, 627.595201095291, 13038.282894440801, 13204.273764942924, 13206.273654948975, 13219.669508262274, 13226.537071202558, 12077.516899324017, 12152.57465988695, 12227.69430764229, 12295.077869159759, 12375.814362784566, 10500.78998420035, 10577.04806567405, 10614.734631634194, 10813.18901082414, 10892.727681807939, 3499.65003499648, 3560.9821950890337, 3591.5510561179854, 3653.8903832885057, 3657.1771351445977, 51101.488985110045, 51560.0, 51578.22632660513, 51694.741526292506, 51986.22020669731, 10023.148032417326, 10204.132648724793, 10596.09933155675, 10620.734481637866, 10644.042036216622, 18456.907715461337, 18486.075696215135, 18488.260469581066, 18509.074546272634, 18523.814761852478, 7170.892436613455, 7433.4053275737815, 7475.524198343151, 7479.8504029919095, 7718.073831140299, 4222.071144348239, 4376.212281789309, 4378.781060947003, 4385.473743150842, 4589.151007063637, 3151.070434221864, 3175.1109689287036, 3182.9681703182673, 3188.6333071696586, 3193.1857376368876, 561.4638020690231, 568.6360729133359, 571.3030103273999, 573.8421933968192, 574.8332983434841, 548.8161465908886, 661.1240106858336, 676.9120014398195, 682.5154140560159, 697.7313734212365, 8174.632141553644, 8420.621072051772, 8611.698590549426, 8649.178328058824, 8825.514596697243, 579.2882181688548, 672.5998031171544, 697.7941507255372, 699.4439420660588, 703.6903762344552, 4221.535631080578, 4481.843135490308, 4555.681102322806, 4593.678442508993, 4617.781906445762, 56224.15663765047, 57796.422035779105, 57826.132608010914, 58297.70851145802, 58737.0, 50976.551765487115, 51650.74174629103, 52154.956900862526, 52355.214671779955, 52447.475525244256, 46367.53632463632, 46999.5300047002, 47322.526774731814, 47427.0, 47593.99999999931, 9094.636214551609, 9114.453132812052, 9235.492047937429, 9308.348415610842, 9309.627614895327, 34393.82803085969, 34452.0, 34806.47790283097, 35427.64572354243, 35739.0, 41110.38334425046, 41865.58134418738, 43883.34174987442, 45893.31160032535, 46038.309425359315, 10783.51474183648, 11349.0, 11379.829302560634, 11476.655700329004, 11698.94150529276, 12502.0, 12614.180078294881, 12700.872991270338, 13285.535006274735, 13291.66770830737, 11231.550737970716, 11611.825822612498, 11785.469653865424, 12042.096842736655, 12215.938920305342, 11752.412379381169, 11904.821427678418, 12042.698932526757, 12553.309567973483, 12564.183328083645, 7415.547899093045, 10698.62554810578, 10926.125909927028, 10982.176336774613, 11053.171012173958, 9871.753206169904, 9896.802063958536, 10112.140468060297, 10340.638077667547, 10629.734256643645, 9104.226140778108, 9148.451092934445, 9344.205742511962, 10098.949505252427, 10212.689580902856], "unit": "ms", "name": "yui.html", "value": 6369.16444794922}], "name": "dromaeo_css", "value": 7072.409384454081}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 103.0, 109.0, 110.0, 110.0, 99.0, 109.0, 113.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [157.0, 123.0, 148.0, 160.0, 125.0, 147.0, 145.0, 132.0, 167.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.7}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 161.0, 161.0, 160.0, 160.0, 162.0, 159.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 85.0, 92.0, 71.0, 72.0, 72.0, 128.0, 93.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 82.9}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 134.0, 90.0, 92.0, 90.0, 132.0, 90.0, 91.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 109.0, 110.0, 111.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 58.0, 61.0, 60.0, 59.0, 59.0, 66.0, 56.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [82.0, 90.0, 91.0, 84.0, 83.0, 84.0, 93.0, 93.0, 85.0, 93.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 113.0, 113.0, 120.0, 117.0, 119.0, 131.0, 115.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [137.0, 148.0, 146.0, 150.0, 151.0, 149.0, 149.0, 152.0, 147.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1496.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.90755613833798], "unit": "score", "name": "Richards", "value": 215.377502}, {"lowerIsBetter": false, "replicates": [195.38882375928097], "unit": "score", "name": "DeltaBlue", "value": 338.39192399999996}, {"lowerIsBetter": false, "replicates": [284.2524161455372], "unit": "score", "name": "Encrypt", "value": 936.4247580000001}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [1102.5358324145534], "unit": "score", "name": "RayTrace", "value": 671.170023}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [25743.589743589742], "unit": "score", "name": "RegExp", "value": 35.38686752988046}, {"lowerIsBetter": false, "replicates": [664.2527978933509], "unit": "score", "name": "Splay", "value": 122.68070267591676}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20796.333709237715}]} 07:49:46 INFO - RETURN: dromaeo_css: 7072.41 07:49:46 INFO - RETURN: kraken: 1496.00 07:49:46 INFO - RETURN: v8_7: 20796.33 07:49:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20796.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1496.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "7072.41"}}} 07:49:46 INFO - Return code: 0 07:49:46 INFO - # TBPL SUCCESS # 07:49:46 INFO - Running post-action listener: _resource_record_post_action 07:49:46 INFO - Running post-run listener: _resource_record_post_run 07:49:47 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 200704; Write bytes: 505995264; Read time: 400; Write time: 664208 07:49:47 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 229830656; Read time: 232; Write time: 368704 07:49:47 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 196608; Write bytes: 265728000; Read time: 168; Write time: 221708 07:49:47 INFO - Running post-run listener: _upload_blobber_files 07:49:47 INFO - Blob upload gear active. 07:49:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:49:47 INFO - Copying logs to upload dir... 07:49:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.243812 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-20 07:49:45.449052) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 07:49:45.453163) ========= 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=0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010015 build_url: 'https://queue.taskcluster.net/v1/task/7G0AHU9ZTt6UuJdParsNvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 07:49:45.505116) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:49:45.505460) ========= 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=0cff312cb257a7829adc5a5d000001df-1448033330.692636-1929369360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:49:45.555916) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 07:49:45.556249) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 07:49:45.556539) ========= ========= Total master_lag: 0.21 =========