builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1448045209.69 results: success (0) buildid: 20151120083117 builduid: e0ff107b691f4c40a84da8d549aa918b revision: 1f9d9bfafd5143618083adcd50f5fcb0fead5530 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.689494) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.690015) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.690319) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006711 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.710794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.711074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.723880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.724152) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.773698) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.774021) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.774398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.774679) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 10:46:50-- 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% 211M=0s 2015-11-20 10:46:50 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192364 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.979182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:49.979512) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017098 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:50.028783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:50.029145) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1f9d9bfafd5143618083adcd50f5fcb0fead5530 --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 1f9d9bfafd5143618083adcd50f5fcb0fead5530 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 10:46:50,332 truncating revision to first 12 chars 2015-11-20 10:46:50,332 Setting DEBUG logging. 2015-11-20 10:46:50,332 attempt 1/10 2015-11-20 10:46:50,332 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1f9d9bfafd51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 10:46:50,603 unpacking tar archive at: fx-team-1f9d9bfafd51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566614 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:50.608555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:50.608890) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:50.616188) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:50.616453) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 10:46:50.616894) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-20 10:46:50.617199) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:46:50 INFO - MultiFileLogger online at 20151120 10:46:50 in /builds/slave/test-pgo 10:46:51 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 10:46:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:46:51 INFO - {'append_to_log': False, 10:46:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:46:51 INFO - 'blob_upload_branch': 'Fx-Team', 10:46:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:46:51 INFO - 'branch': 'Fx-Team', 10:46:51 INFO - 'buildbot_json_path': 'buildprops.json', 10:46:51 INFO - 'config_files': ('talos/linux_config.py',), 10:46:51 INFO - 'default_actions': ('clobber', 10:46:51 INFO - 'read-buildbot-config', 10:46:51 INFO - 'download-and-extract', 10:46:51 INFO - 'populate-webroot', 10:46:51 INFO - 'create-virtualenv', 10:46:51 INFO - 'install', 10:46:51 INFO - 'run-tests'), 10:46:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:46:51 INFO - 'download_minidump_stackwalk': True, 10:46:51 INFO - 'download_symbols': 'ondemand', 10:46:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:46:51 INFO - 'tooltool.py': '/tools/tooltool.py', 10:46:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:46:51 INFO - '/tools/misc-python/virtualenv.py')}, 10:46:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:46:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:46:51 INFO - 'installer_path': 'installer.exe', 10:46:51 INFO - 'log_level': 'info', 10:46:51 INFO - 'log_name': 'talos', 10:46:51 INFO - 'log_to_console': True, 10:46:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:46:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:46:51 INFO - 'opt_config_files': (), 10:46:51 INFO - 'pip_index': False, 10:46:51 INFO - 'sps_profile': False, 10:46:51 INFO - 'sps_profile_interval': 0, 10:46:51 INFO - 'suite': 'dromaeojs', 10:46:51 INFO - 'system_bits': '64', 10:46:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:46:51 INFO - 'title': 'talos-linux64-ix-041', 10:46:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:46:51 INFO - 'use_talos_json': True, 10:46:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:46:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:46:51 INFO - 'work_dir': 'build'} 10:46:51 INFO - ##### 10:46:51 INFO - ##### Running clobber step. 10:46:51 INFO - ##### 10:46:51 INFO - Running pre-action listener: _resource_record_pre_action 10:46:51 INFO - Running main action method: clobber 10:46:51 INFO - rmtree: /builds/slave/test-pgo/build 10:46:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:46:51 INFO - Running post-action listener: _resource_record_post_action 10:46:51 INFO - ##### 10:46:51 INFO - ##### Running read-buildbot-config step. 10:46:51 INFO - ##### 10:46:51 INFO - Running pre-action listener: _resource_record_pre_action 10:46:51 INFO - Running main action method: read_buildbot_config 10:46:51 INFO - Using buildbot properties: 10:46:51 INFO - { 10:46:51 INFO - "properties": { 10:46:51 INFO - "buildnumber": 503, 10:46:51 INFO - "product": "firefox", 10:46:51 INFO - "script_repo_revision": "production", 10:46:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:46:51 INFO - "repository": "", 10:46:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:46:51 INFO - "buildid": "20151120083117", 10:46:51 INFO - "slavename": "talos-linux64-ix-041", 10:46:51 INFO - "pgo_build": "True", 10:46:51 INFO - "basedir": "/builds/slave/test-pgo", 10:46:51 INFO - "project": "", 10:46:51 INFO - "platform": "ubuntu64_hw", 10:46:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:46:51 INFO - "slavebuilddir": "test", 10:46:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:46:51 INFO - "branch": "fx-team", 10:46:51 INFO - "repo_path": "integration/fx-team", 10:46:51 INFO - "stage_platform": "linux64-pgo", 10:46:51 INFO - "builduid": "e0ff107b691f4c40a84da8d549aa918b", 10:46:51 INFO - "revision": "1f9d9bfafd5143618083adcd50f5fcb0fead5530" 10:46:51 INFO - }, 10:46:51 INFO - "sourcestamp": { 10:46:51 INFO - "repository": "", 10:46:51 INFO - "hasPatch": false, 10:46:51 INFO - "project": "", 10:46:51 INFO - "branch": "fx-team-linux64-pgo-talos", 10:46:51 INFO - "changes": [ 10:46:51 INFO - { 10:46:51 INFO - "category": null, 10:46:51 INFO - "files": [ 10:46:51 INFO - { 10:46:51 INFO - "url": null, 10:46:51 INFO - "name": "https://queue.taskcluster.net/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:46:51 INFO - } 10:46:51 INFO - ], 10:46:51 INFO - "repository": "", 10:46:51 INFO - "rev": "1f9d9bfafd5143618083adcd50f5fcb0fead5530", 10:46:51 INFO - "who": "sendchange", 10:46:51 INFO - "when": 1448045150, 10:46:51 INFO - "number": 6689995, 10:46:51 INFO - "comments": "", 10:46:51 INFO - "project": "", 10:46:51 INFO - "at": "Fri 20 Nov 2015 10:45:50", 10:46:51 INFO - "branch": "fx-team-linux64-pgo-talos", 10:46:51 INFO - "revlink": "", 10:46:51 INFO - "properties": [ 10:46:51 INFO - [ 10:46:51 INFO - "buildid", 10:46:51 INFO - "20151120083117", 10:46:51 INFO - "Change" 10:46:51 INFO - ], 10:46:51 INFO - [ 10:46:51 INFO - "builduid", 10:46:51 INFO - "e0ff107b691f4c40a84da8d549aa918b", 10:46:51 INFO - "Change" 10:46:51 INFO - ], 10:46:51 INFO - [ 10:46:51 INFO - "pgo_build", 10:46:51 INFO - "True", 10:46:51 INFO - "Change" 10:46:51 INFO - ] 10:46:51 INFO - ], 10:46:51 INFO - "revision": "1f9d9bfafd5143618083adcd50f5fcb0fead5530" 10:46:51 INFO - } 10:46:51 INFO - ], 10:46:51 INFO - "revision": "1f9d9bfafd5143618083adcd50f5fcb0fead5530" 10:46:51 INFO - } 10:46:51 INFO - } 10:46:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:46:51 INFO - Running post-action listener: _resource_record_post_action 10:46:51 INFO - ##### 10:46:51 INFO - ##### Running download-and-extract step. 10:46:51 INFO - ##### 10:46:51 INFO - Running pre-action listener: _resource_record_pre_action 10:46:51 INFO - Running main action method: download_and_extract 10:46:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:51 INFO - https://queue.taskcluster.net/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:46:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/test_packages.json 10:46:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/test_packages.json 10:46:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:46:52 INFO - Downloaded 1302 bytes. 10:46:52 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:46:52 INFO - Using the following test package requirements: 10:46:52 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:52 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:46:52 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:52 INFO - u'jsshell-linux-x86_64.zip'], 10:46:52 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:46:52 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:52 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:46:52 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:46:52 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:46:52 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:52 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:46:52 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:46: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')]} 10:46:52 INFO - https://queue.taskcluster.net/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:46:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/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 10:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/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 10:46:53 INFO - Downloaded 22524703 bytes. 10:46:53 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 10:46:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:53 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 10:46:54 INFO - Return code: 0 10:46:54 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 10:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:54 INFO - https://queue.taskcluster.net/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:46:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/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 10:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/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 10:46:56 INFO - Downloaded 22524703 bytes. 10:46: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 10:46:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46: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 10:46:57 INFO - Return code: 0 10:46: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')]} 10:46:57 INFO - https://queue.taskcluster.net/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:46:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:46:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:46:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/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 10:46:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/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 10:46:59 INFO - Downloaded 11130997 bytes. 10:46:59 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 10:46:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:46:59 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 10:46:59 INFO - Return code: 0 10:46: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')]} 10:46:59 INFO - https://queue.taskcluster.net/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:46:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:46:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:46:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/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 10:46:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Du_MZj_WS3WcA5-230WF5A/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 10:47:00 INFO - Downloaded 57349215 bytes. 10:47:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:00 INFO - mkdir: /builds/slave/test-pgo/properties 10:47:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:47:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:47:00 INFO - Contents: 10:47:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:00 INFO - Running post-action listener: _resource_record_post_action 10:47:00 INFO - Running post-action listener: set_extra_try_arguments 10:47:00 INFO - ##### 10:47:00 INFO - ##### Running populate-webroot step. 10:47:00 INFO - ##### 10:47:00 INFO - Running pre-action listener: _resource_record_pre_action 10:47:00 INFO - Running main action method: populate_webroot 10:47:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:47:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:47:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:47:00 INFO - '../fennec_ids.txt'], 10:47:00 INFO - 'tests': ['tcheck2']}, 10:47:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:47:00 INFO - '--tppagecycles', 10:47:00 INFO - '7'], 10:47:00 INFO - 'tests': ['tsvgm']}}, 10:47:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:47:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:47:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:47:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:47:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:47:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:47:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:47:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:00 INFO - 'talos_options': ['--e10s'], 10:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:47:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:00 INFO - 'tests': ['damp', 'tps']}, 10:47:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:00 INFO - 'talos_options': ['--e10s'], 10:47:00 INFO - 'tests': ['damp', 'tps']}, 10:47:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:47:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:47:00 INFO - 'other': {'tests': ['a11yr', 10:47:00 INFO - 'ts_paint', 10:47:00 INFO - 'tpaint', 10:47:00 INFO - 'sessionrestore', 10:47:00 INFO - 'sessionrestore_no_auto_restore']}, 10:47:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:47:00 INFO - 'tests': ['a11yr', 10:47:00 INFO - 'ts_paint', 10:47:00 INFO - 'tpaint', 10:47:00 INFO - 'sessionrestore', 10:47:00 INFO - 'sessionrestore_no_auto_restore']}, 10:47:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:47:00 INFO - 'tests': ['a11yr', 10:47:00 INFO - 'ts_paint', 10:47:00 INFO - 'tpaint', 10:47:00 INFO - 'sessionrestore', 10:47:00 INFO - 'sessionrestore_no_auto_restore']}, 10:47:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:47:00 INFO - 'tests': ['a11yr', 10:47:00 INFO - 'ts_paint', 10:47:00 INFO - 'tpaint', 10:47:00 INFO - 'sessionrestore', 10:47:00 INFO - 'sessionrestore_no_auto_restore']}, 10:47:00 INFO - 'other_l64': {'tests': ['a11yr', 10:47:00 INFO - 'ts_paint', 10:47:00 INFO - 'tpaint', 10:47:00 INFO - 'sessionrestore', 10:47:00 INFO - 'sessionrestore_no_auto_restore']}, 10:47:00 INFO - 'other_nol64': {'tests': ['a11yr', 10:47:00 INFO - 'ts_paint', 10:47:00 INFO - 'tpaint', 10:47:00 INFO - 'sessionrestore', 10:47:00 INFO - 'sessionrestore_no_auto_restore']}, 10:47:00 INFO - 'svgr': {'tests': ['tsvgx', 10:47:00 INFO - 'tsvgr_opacity', 10:47:00 INFO - 'tart', 10:47:00 INFO - 'tscrollx', 10:47:00 INFO - 'cart']}, 10:47:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:47:00 INFO - 'tests': ['tsvgx', 10:47:00 INFO - 'tsvgr_opacity', 10:47:00 INFO - 'tart', 10:47:00 INFO - 'tscrollx', 10:47:00 INFO - 'cart']}, 10:47:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:00 INFO - 'tests': ['tp5o']}, 10:47:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:00 INFO - 'talos_options': ['--e10s'], 10:47:00 INFO - 'tests': ['tp5o']}, 10:47:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:00 INFO - 'talos_options': ['--xperf_path', 10:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:47:00 INFO - 'tests': ['tp5n']}, 10:47:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:00 INFO - 'talos_options': ['--e10s', 10:47:00 INFO - '--xperf_path', 10:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:47:00 INFO - 'tests': ['tp5n']}}, 10:47:00 INFO - 'talos.zip': {'path': '', 10:47:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:47:00 INFO - Running post-action listener: _resource_record_post_action 10:47:00 INFO - ##### 10:47:00 INFO - ##### Running create-virtualenv step. 10:47:00 INFO - ##### 10:47:00 INFO - Running pre-action listener: _resource_record_pre_action 10:47:00 INFO - Running main action method: create_virtualenv 10:47:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:47: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 10:47:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:47:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:47:00 INFO - Using real prefix '/usr' 10:47:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:47:01 INFO - Installing distribute.............................................................................................................................................................................................done. 10:47:03 INFO - Installing pip.................done. 10:47:03 INFO - Return code: 0 10:47:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:47: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')]} 10:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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 0x7f5c1861dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208d70>, '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 0x2209b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', '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 10:47: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 10:47: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 10:47:03 INFO - Using env: {'DISPLAY': ':0', 10:47:03 INFO - 'HOME': '/home/cltbld', 10:47:03 INFO - 'LANG': 'en_US.UTF-8', 10:47:03 INFO - 'LANGUAGE': 'en_US:en', 10:47:03 INFO - 'LOGNAME': 'cltbld', 10:47:03 INFO - 'MAIL': '/var/mail/cltbld', 10:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:03 INFO - 'MOZ_NO_REMOTE': '1', 10:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:03 INFO - 'NO_EM_RESTART': '1', 10:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:47:03 INFO - 'PWD': '/builds/slave/test-pgo', 10:47:03 INFO - 'SHELL': '/bin/bash', 10:47:03 INFO - 'SHLVL': '1', 10:47:03 INFO - 'TERM': 'linux', 10:47:03 INFO - 'TMOUT': '86400', 10:47:03 INFO - 'USER': 'cltbld', 10:47:03 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', 10:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:03 INFO - '_': '/tools/buildbot/bin/python'} 10:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47: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 10:47:03 INFO - Cleaning up... 10:47:03 INFO - Return code: 0 10:47:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:47: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')]} 10:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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 0x7f5c1861dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208d70>, '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 0x2209b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', '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 10:47: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 10:47: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 10:47:03 INFO - Using env: {'DISPLAY': ':0', 10:47:03 INFO - 'HOME': '/home/cltbld', 10:47:03 INFO - 'LANG': 'en_US.UTF-8', 10:47:03 INFO - 'LANGUAGE': 'en_US:en', 10:47:03 INFO - 'LOGNAME': 'cltbld', 10:47:03 INFO - 'MAIL': '/var/mail/cltbld', 10:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:03 INFO - 'MOZ_NO_REMOTE': '1', 10:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:03 INFO - 'NO_EM_RESTART': '1', 10:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:47:03 INFO - 'PWD': '/builds/slave/test-pgo', 10:47:03 INFO - 'SHELL': '/bin/bash', 10:47:03 INFO - 'SHLVL': '1', 10:47:03 INFO - 'TERM': 'linux', 10:47:03 INFO - 'TMOUT': '86400', 10:47:03 INFO - 'USER': 'cltbld', 10:47:03 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', 10:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:03 INFO - '_': '/tools/buildbot/bin/python'} 10:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:03 INFO - Downloading/unpacking psutil>=0.7.1 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:47:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:47:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:05 INFO - Installing collected packages: psutil 10:47:05 INFO - Running setup.py install for psutil 10:47:05 INFO - building 'psutil._psutil_linux' extension 10:47: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 10:47: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 10:47:05 INFO - building 'psutil._psutil_posix' extension 10:47: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 10:47: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 10:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:05 INFO - Successfully installed psutil 10:47:05 INFO - Cleaning up... 10:47:05 INFO - Return code: 0 10:47:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:47: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')]} 10:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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 0x7f5c1861dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208d70>, '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 0x2209b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', '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 10:47: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 10:47: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 10:47:05 INFO - Using env: {'DISPLAY': ':0', 10:47:05 INFO - 'HOME': '/home/cltbld', 10:47:05 INFO - 'LANG': 'en_US.UTF-8', 10:47:05 INFO - 'LANGUAGE': 'en_US:en', 10:47:05 INFO - 'LOGNAME': 'cltbld', 10:47:05 INFO - 'MAIL': '/var/mail/cltbld', 10:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:05 INFO - 'MOZ_NO_REMOTE': '1', 10:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:05 INFO - 'NO_EM_RESTART': '1', 10:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:47:05 INFO - 'PWD': '/builds/slave/test-pgo', 10:47:05 INFO - 'SHELL': '/bin/bash', 10:47:05 INFO - 'SHLVL': '1', 10:47:05 INFO - 'TERM': 'linux', 10:47:05 INFO - 'TMOUT': '86400', 10:47:05 INFO - 'USER': 'cltbld', 10:47:05 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', 10:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:05 INFO - '_': '/tools/buildbot/bin/python'} 10:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:47:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:47:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:47: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) 10:47:07 INFO - Installing collected packages: mozsystemmonitor 10:47:07 INFO - Running setup.py install for mozsystemmonitor 10:47:08 INFO - Successfully installed mozsystemmonitor 10:47:08 INFO - Cleaning up... 10:47:08 INFO - Return code: 0 10:47:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:08 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 0x7f5c1861dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208d70>, '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 0x2209b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', '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 10:47:08 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 10:47:08 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 10:47:08 INFO - Using env: {'DISPLAY': ':0', 10:47:08 INFO - 'HOME': '/home/cltbld', 10:47:08 INFO - 'LANG': 'en_US.UTF-8', 10:47:08 INFO - 'LANGUAGE': 'en_US:en', 10:47:08 INFO - 'LOGNAME': 'cltbld', 10:47:08 INFO - 'MAIL': '/var/mail/cltbld', 10:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:08 INFO - 'MOZ_NO_REMOTE': '1', 10:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:08 INFO - 'NO_EM_RESTART': '1', 10:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:47:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:47:08 INFO - 'SHELL': '/bin/bash', 10:47:08 INFO - 'SHLVL': '1', 10:47:08 INFO - 'TERM': 'linux', 10:47:08 INFO - 'TMOUT': '86400', 10:47:08 INFO - 'USER': 'cltbld', 10:47:08 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', 10:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:08 INFO - '_': '/tools/buildbot/bin/python'} 10:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:08 INFO - Downloading/unpacking blobuploader==1.2.4 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47:09 INFO - Downloading blobuploader-1.2.4.tar.gz 10:47:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:47:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:47:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:47:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:47:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47:10 INFO - Downloading docopt-0.6.1.tar.gz 10:47:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:47:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:47:10 INFO - Installing collected packages: blobuploader, requests, docopt 10:47:10 INFO - Running setup.py install for blobuploader 10:47:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:47:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:47:10 INFO - Running setup.py install for requests 10:47:11 INFO - Running setup.py install for docopt 10:47:11 INFO - Successfully installed blobuploader requests docopt 10:47:11 INFO - Cleaning up... 10:47:11 INFO - Return code: 0 10:47:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:47: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')]} 10:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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 0x7f5c1861dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208d70>, '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 0x2209b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', '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 10:47: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 10:47: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 10:47:11 INFO - Using env: {'DISPLAY': ':0', 10:47:11 INFO - 'HOME': '/home/cltbld', 10:47:11 INFO - 'LANG': 'en_US.UTF-8', 10:47:11 INFO - 'LANGUAGE': 'en_US:en', 10:47:11 INFO - 'LOGNAME': 'cltbld', 10:47:11 INFO - 'MAIL': '/var/mail/cltbld', 10:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:11 INFO - 'MOZ_NO_REMOTE': '1', 10:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:11 INFO - 'NO_EM_RESTART': '1', 10:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:47:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:47:11 INFO - 'SHELL': '/bin/bash', 10:47:11 INFO - 'SHLVL': '1', 10:47:11 INFO - 'TERM': 'linux', 10:47:11 INFO - 'TMOUT': '86400', 10:47:11 INFO - 'USER': 'cltbld', 10:47:11 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', 10:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:11 INFO - '_': '/tools/buildbot/bin/python'} 10:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:47:11 INFO - Running setup.py (path:/tmp/pip-XvAAFH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:47:11 INFO - Running setup.py (path:/tmp/pip-YsWDCj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:47:11 INFO - Running setup.py (path:/tmp/pip-wxgcrx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:47:11 INFO - Running setup.py (path:/tmp/pip-m_RwfI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:47:11 INFO - Running setup.py (path:/tmp/pip-m4TTUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:47:11 INFO - Running setup.py (path:/tmp/pip-Y4WueY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:47:11 INFO - Running setup.py (path:/tmp/pip-q01ZEr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:47:11 INFO - Running setup.py (path:/tmp/pip-e3eXqh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:47:11 INFO - Running setup.py (path:/tmp/pip-Kua4ei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:47:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:47:12 INFO - Running setup.py (path:/tmp/pip-tLHHJQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:47:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:47:12 INFO - Running setup.py (path:/tmp/pip-DdliJk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:47:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:47:12 INFO - Running setup.py (path:/tmp/pip-4uN15z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:47:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:47:12 INFO - Running setup.py (path:/tmp/pip-z_c4Ux-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:47:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:47:12 INFO - Running setup.py (path:/tmp/pip-QujA4s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:47:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:47:12 INFO - Running setup.py (path:/tmp/pip-rVKy26-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:47:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:47:12 INFO - Running setup.py (path:/tmp/pip-KwOCoa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:47:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:47:12 INFO - Running setup.py (path:/tmp/pip-s1cKkY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:47:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:47:12 INFO - Running setup.py install for manifestparser 10:47:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:47:12 INFO - Running setup.py install for mozcrash 10:47:12 INFO - Running setup.py install for mozdebug 10:47:12 INFO - Running setup.py install for mozdevice 10:47:13 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Running setup.py install for mozfile 10:47:13 INFO - Running setup.py install for mozhttpd 10:47:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Running setup.py install for mozinfo 10:47:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Running setup.py install for mozInstall 10:47:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Running setup.py install for mozleak 10:47:13 INFO - Running setup.py install for mozlog 10:47:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Running setup.py install for moznetwork 10:47:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Running setup.py install for mozprocess 10:47:13 INFO - Running setup.py install for mozprofile 10:47:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:47:13 INFO - Running setup.py install for mozrunner 10:47:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:47:14 INFO - Running setup.py install for mozscreenshot 10:47:14 INFO - Running setup.py install for moztest 10:47:14 INFO - Running setup.py install for mozversion 10:47:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:47:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:47:14 INFO - Cleaning up... 10:47:14 INFO - Return code: 0 10:47:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:47: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')]} 10:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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 0x7f5c1861dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208d70>, '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 0x2209b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', '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 10:47: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 10:47: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 10:47:14 INFO - Using env: {'DISPLAY': ':0', 10:47:14 INFO - 'HOME': '/home/cltbld', 10:47:14 INFO - 'LANG': 'en_US.UTF-8', 10:47:14 INFO - 'LANGUAGE': 'en_US:en', 10:47:14 INFO - 'LOGNAME': 'cltbld', 10:47:14 INFO - 'MAIL': '/var/mail/cltbld', 10:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:14 INFO - 'MOZ_NO_REMOTE': '1', 10:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:14 INFO - 'NO_EM_RESTART': '1', 10:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:47:14 INFO - 'PWD': '/builds/slave/test-pgo', 10:47:14 INFO - 'SHELL': '/bin/bash', 10:47:14 INFO - 'SHLVL': '1', 10:47:14 INFO - 'TERM': 'linux', 10:47:14 INFO - 'TMOUT': '86400', 10:47:14 INFO - 'USER': 'cltbld', 10:47:14 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', 10:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:14 INFO - '_': '/tools/buildbot/bin/python'} 10:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:47:14 INFO - Running setup.py (path:/tmp/pip-zFVj0O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:47: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)) 10:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:47:14 INFO - Running setup.py (path:/tmp/pip-5p9WMQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:47: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)) 10:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:47:14 INFO - Running setup.py (path:/tmp/pip-jXyvOv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:47: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)) 10:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:47:14 INFO - Running setup.py (path:/tmp/pip-n4rLly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:47: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)) 10:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:47:14 INFO - Running setup.py (path:/tmp/pip-l9FlWb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:47:15 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)) 10:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:47:15 INFO - Running setup.py (path:/tmp/pip-16rWiz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:47:15 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)) 10:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:47:15 INFO - Running setup.py (path:/tmp/pip-7gCYXO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:47: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)) 10:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:47:15 INFO - Running setup.py (path:/tmp/pip-XxaBTl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:47: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)) 10:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:47:15 INFO - Running setup.py (path:/tmp/pip-c4yhQ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:47: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)) 10:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:47:15 INFO - Running setup.py (path:/tmp/pip-BSVAHy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:47: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)) 10:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:47:15 INFO - Running setup.py (path:/tmp/pip-O2RBRG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:47: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)) 10:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:47:15 INFO - Running setup.py (path:/tmp/pip-zTawjS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:47: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)) 10:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:47:15 INFO - Running setup.py (path:/tmp/pip-blJpX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:47: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)) 10:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:47:15 INFO - Running setup.py (path:/tmp/pip-U5DsUw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:47: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)) 10:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:47:15 INFO - Running setup.py (path:/tmp/pip-ISqCgA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:47: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)) 10:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:47:15 INFO - Running setup.py (path:/tmp/pip-Q7LXk7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:47: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)) 10:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:47:15 INFO - Running setup.py (path:/tmp/pip-fBZ58h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:47: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)) 10:47: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)) 10:47: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)) 10:47: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)) 10:47: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)) 10:47: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)) 10:47:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47:17 INFO - Downloading blessings-1.5.1.tar.gz 10:47: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 10:47:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:47:17 INFO - Installing collected packages: blessings 10:47:17 INFO - Running setup.py install for blessings 10:47:17 INFO - Successfully installed blessings 10:47:17 INFO - Cleaning up... 10:47:17 INFO - Return code: 0 10:47:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:47:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:47:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:47:17 INFO - Reading from file tmpfile_stdout 10:47:17 INFO - Current package versions: 10:47:17 INFO - argparse == 1.2.1 10:47:17 INFO - blessings == 1.5.1 10:47:17 INFO - blobuploader == 1.2.4 10:47:17 INFO - docopt == 0.6.1 10:47:17 INFO - manifestparser == 1.1 10:47:17 INFO - mozInstall == 1.12 10:47:17 INFO - mozcrash == 0.16 10:47:17 INFO - mozdebug == 0.1 10:47:17 INFO - mozdevice == 0.47 10:47:17 INFO - mozfile == 1.2 10:47:17 INFO - mozhttpd == 0.7 10:47:17 INFO - mozinfo == 0.9 10:47:17 INFO - mozleak == 0.1 10:47:17 INFO - mozlog == 3.0 10:47:17 INFO - moznetwork == 0.27 10:47:17 INFO - mozprocess == 0.22 10:47:17 INFO - mozprofile == 0.27 10:47:17 INFO - mozrunner == 6.11 10:47:17 INFO - mozscreenshot == 0.1 10:47:17 INFO - mozsystemmonitor == 0.0 10:47:17 INFO - moztest == 0.7 10:47:17 INFO - mozversion == 1.4 10:47:17 INFO - psutil == 3.1.1 10:47:17 INFO - requests == 1.2.3 10:47:17 INFO - wsgiref == 0.1.2 10:47:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:47: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')]} 10:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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 0x7f5c1861dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21126c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208d70>, '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 0x2209b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', '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 10:47: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 10:47: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 10:47:17 INFO - Using env: {'DISPLAY': ':0', 10:47:17 INFO - 'HOME': '/home/cltbld', 10:47:18 INFO - 'LANG': 'en_US.UTF-8', 10:47:18 INFO - 'LANGUAGE': 'en_US:en', 10:47:18 INFO - 'LOGNAME': 'cltbld', 10:47:18 INFO - 'MAIL': '/var/mail/cltbld', 10:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:18 INFO - 'MOZ_NO_REMOTE': '1', 10:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:18 INFO - 'NO_EM_RESTART': '1', 10:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:47:18 INFO - 'PWD': '/builds/slave/test-pgo', 10:47:18 INFO - 'SHELL': '/bin/bash', 10:47:18 INFO - 'SHLVL': '1', 10:47:18 INFO - 'TERM': 'linux', 10:47:18 INFO - 'TMOUT': '86400', 10:47:18 INFO - 'USER': 'cltbld', 10:47:18 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', 10:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:18 INFO - '_': '/tools/buildbot/bin/python'} 10:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47: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)) 10:47: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)) 10:47: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)) 10:47: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)) 10:47: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)) 10:47: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)) 10:47: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)) 10:47: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)) 10:47: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)) 10:47: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)) 10:47: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)) 10:47:18 INFO - Cleaning up... 10:47:18 INFO - Return code: 0 10:47:18 INFO - Running post-action listener: _resource_record_post_action 10:47:18 INFO - Running post-action listener: _start_resource_monitoring 10:47:18 INFO - Starting resource monitoring. 10:47:18 INFO - ##### 10:47:18 INFO - ##### Running install step. 10:47:18 INFO - ##### 10:47:18 INFO - Running pre-action listener: _resource_record_pre_action 10:47:18 INFO - Running main action method: install 10:47:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:47:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:47:18 INFO - Reading from file tmpfile_stdout 10:47:18 INFO - Detecting whether we're running mozinstall >=1.0... 10:47:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:47:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:47:18 INFO - Reading from file tmpfile_stdout 10:47:18 INFO - Output received: 10:47:18 INFO - Usage: mozinstall [options] installer 10:47:18 INFO - Options: 10:47:18 INFO - -h, --help show this help message and exit 10:47:18 INFO - -d DEST, --destination=DEST 10:47:18 INFO - Directory to install application into. [default: 10:47:18 INFO - "/builds/slave/test-pgo"] 10:47:18 INFO - --app=APP Application being installed. [default: firefox] 10:47:18 INFO - mkdir: /builds/slave/test-pgo/build/application 10:47: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'] 10:47: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 10:47:32 INFO - Reading from file tmpfile_stdout 10:47:32 INFO - Output received: 10:47:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:47:32 INFO - Running post-action listener: _resource_record_post_action 10:47:32 INFO - ##### 10:47:32 INFO - ##### Running run-tests step. 10:47:32 INFO - ##### 10:47:32 INFO - Running pre-action listener: _resource_record_pre_action 10:47:32 INFO - Running main action method: run_tests 10:47:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:47:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:47:32 INFO - Python 2.7.3 10:47:32 INFO - Return code: 0 10:47:32 INFO - grabbing minidump binary from tooltool 10:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:32 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 0x2208d70>, '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 0x2209b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:47:32 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 10:47:32 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 10:47:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:47:33 INFO - Return code: 0 10:47:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:47:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:47:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:47:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:47:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:47: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/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:47: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/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 10:47:33 INFO - Using env: {'DISPLAY': ':0', 10:47:33 INFO - 'HOME': '/home/cltbld', 10:47:33 INFO - 'LANG': 'en_US.UTF-8', 10:47:33 INFO - 'LANGUAGE': 'en_US:en', 10:47:33 INFO - 'LOGNAME': 'cltbld', 10:47:33 INFO - 'MAIL': '/var/mail/cltbld', 10:47:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:47:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:33 INFO - 'MOZ_NO_REMOTE': '1', 10:47:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:33 INFO - 'NO_EM_RESTART': '1', 10:47:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:47:33 INFO - 'PWD': '/builds/slave/test-pgo', 10:47:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:47:33 INFO - 'SHELL': '/bin/bash', 10:47:33 INFO - 'SHLVL': '1', 10:47:33 INFO - 'TERM': 'linux', 10:47:33 INFO - 'TMOUT': '86400', 10:47:33 INFO - 'USER': 'cltbld', 10:47:33 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307', 10:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:33 INFO - '_': '/tools/buildbot/bin/python'} 10:47: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/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 10:47:33 INFO - mozversion INFO | application_buildid: 20151120083117 10:47:33 INFO - mozversion INFO | application_changeset: 1f9d9bfafd5143618083adcd50f5fcb0fead5530 10:47:33 INFO - mozversion INFO | application_display_name: Nightly 10:47:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:47:33 INFO - mozversion INFO | application_name: Firefox 10:47:33 INFO - mozversion INFO | application_remotingname: firefox 10:47:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:47:33 INFO - mozversion INFO | application_vendor: Mozilla 10:47:33 INFO - mozversion INFO | application_version: 45.0a1 10:47:33 INFO - mozversion INFO | platform_buildid: 20151120083117 10:47:33 INFO - mozversion INFO | platform_changeset: 1f9d9bfafd5143618083adcd50f5fcb0fead5530 10:47:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:47:33 INFO - mozversion INFO | platform_version: 45.0a1 10:47:33 INFO - 2015-11-20 10:47:33,223 DEBUG : using testdate: 1448045253 10:47:33 INFO - 2015-11-20 10:47:33,223 DEBUG : actual date: 1448045253 10:47:33 INFO - 2015-11-20 10:47:33,272 INFO : starting webserver on 'localhost:57323' 10:47:33 INFO - 2015-11-20 10:47:33,273 INFO : Starting test suite talos-linux64-ix-041 10:47:33 INFO - 2015-11-20 10:47:33,273 INFO : Starting test dromaeo_css 10:47:33 INFO - 2015-11-20 10:47:33,273 DEBUG : operating with platform_type : linux_ 10:47:33 INFO - 2015-11-20 10:47:33,274 INFO : Initialising browser for dromaeo_css test... 10:47:33 INFO - 2015-11-20 10:47:33,284 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplC0UEM/profile http://localhost:57323/getInfo.html 10:47:37 INFO - 2015-11-20 10:47:37,509 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:47:37 INFO - 2015-11-20 10:47:37,509 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:47:37 INFO - 2015-11-20 10:47:37,509 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:47:37 INFO - 2015-11-20 10:47:37,509 DEBUG : BROWSER_OUTPUT: __metrics 10:47:37 INFO - 2015-11-20 10:47:37,611 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:47:38 INFO - 2015-11-20 10:47:38,954 INFO : Browser initialized. 10:47:38 INFO - 2015-11-20 10:47:38,955 INFO : Running cycle 1/1 for dromaeo_css test... 10:47:38 INFO - 2015-11-20 10:47:38,955 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplC0UEM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:47:50 INFO - 2015-11-20 10:47:50,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 141365248 10:47:50 INFO - 2015-11-20 10:47:50,747 DEBUG : BROWSER_OUTPUT: 10:48:41 INFO - 2015-11-20 10:48:41,557 DEBUG : BROWSER_OUTPUT: 1448045321556 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] 10:50:50 INFO - 2015-11-20 10:50:50,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57323/tests/dromaeo/cssquery-ext.html) 10:50:51 INFO - 2015-11-20 10:50:51,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 282939392 10:50:51 INFO - 2015-11-20 10:50:51,619 DEBUG : BROWSER_OUTPUT: 10:53:53 INFO - 2015-11-20 10:53:53,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/dromaeo/cssquery-ext.html (next: http://localhost:57323/tests/dromaeo/cssquery-jquery.html) 10:53:54 INFO - 2015-11-20 10:53:54,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 222412800 10:53:54 INFO - 2015-11-20 10:53:54,488 DEBUG : BROWSER_OUTPUT: 10:56:56 INFO - 2015-11-20 10:56:56,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57323/tests/dromaeo/cssquery-mootools.html) 10:56:57 INFO - 2015-11-20 10:56:57,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 209637376 10:56:57 INFO - 2015-11-20 10:56:57,055 DEBUG : BROWSER_OUTPUT: 10:59:58 INFO - 2015-11-20 10:59:58,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57323/tests/dromaeo/cssquery-prototype.html) 10:59:59 INFO - 2015-11-20 10:59:59,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 208633856 10:59:59 INFO - 2015-11-20 10:59:59,474 DEBUG : BROWSER_OUTPUT: 11:03:02 INFO - 2015-11-20 11:03:02,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57323/tests/dromaeo/cssquery-yui.html) 11:03:02 INFO - 2015-11-20 11:03:02,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 203792384 11:03:02 INFO - 2015-11-20 11:03:02,643 DEBUG : BROWSER_OUTPUT: 11:06:05 INFO - 2015-11-20 11:06:05,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/dromaeo/cssquery-yui.html (next: http://localhost:57323/tests/dromaeo/cssquery-dojo.html) 11:06:05 INFO - 2015-11-20 11:06:05,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 232366080 11:06:05 INFO - 2015-11-20 11:06:05,537 DEBUG : BROWSER_OUTPUT: 11:06:05 INFO - 2015-11-20 11:06:05,537 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:06:05 INFO - 2015-11-20 11:06:05,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:06:05 INFO - 2015-11-20 11:06:05,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:06:05 INFO - 2015-11-20 11:06:05,537 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:06:05 INFO - 2015-11-20 11:06:05,538 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3190.505471651894;3262.054004338742;3298.4392653248947;3310.6358300586917;3329.750268729846;5330.28041214436;5436.048691478995;5470.179473079035;5475.28821253237;5490.423505531917;5431.538319242869;5432.348118225808;5450.209719590667;5456.699881506525;5568.1091025435935;4962.875928101799;4979.526944940225;4991.900161996758;5033.270175824503;5104.106781313274;288.27853121292;4891.706497610137;5047.369078865142;5075.873103172414;5086.135356989303;4975.626827987898;5042;5047.394312682465;5095.0064737376415;5096.79612815487;5045.495450454961;5072.771725272371;5074.010567939254;5075.390953085616;5123.718195499246;4941.728204948727;5029.597632189416;5056.064628043824;5063.063333283318;5067.949320506785;5213.947860521384;5258.13240815265;5275.446078161776;5294.41761406245;5323.0152421802095;5960.493358064569;5997.100434934751;5998.580099393044;6004.12940123684;6011.428914253139;5789.45000224978;5896.734646940855;5918.23063001807;6033.909491357633;6042.728077236491;5444.537214336786;5524.475174858382;5571.916421253684;5572.5263352615075;5577.888442231133;6062.242219722535;6123.6486823095165;6135.478484328793;6136.355682653347;6139.109829074849;5673.517750991212;5876.764929402776;5947.762089516457;5949.464548190684;5953.1070339449425;5811.680357580289;5880.353161152269;5887.793927212527;5929.318128415288;5969.582129250911;5835.795747148914;5855.882882342415;5866.2960444746905;5874.794382196603;5884;5743.971280143573;5877.94122058774;5898.8230353089475;5899.174115623816;5905.232319798484;4454.443194600675;4508.81964721414;4524.457065152137;4571.611413029863;4587.288970209556;4041.090754580196;4046.635802777764;4069.084455997377;4077.327241005201;4077.368007958771;5447.4824891635235;5527.944720552823;5537.667739935617;5538.556915446755;5552.444755524496;5857.062869940789;5974.85062873423;5978.192943952511;5995.46040856325;6015.819525414245;5531.059719847635;5543.944560554342;5544.805931792368;5554.750036248379;5561.6663000220115;5015.774290156952;5017.473165317662;5018.799248030111;5031.949680503221;5055.216441451581;5890.14592884038;5954.8809023819285;6024.518038556905;6041.395860414012;6097.146399504073;5974.133750606051;5981.192539007178;6027.909581356195;6075.453209211192;6078.057901025348;6097.146399503984;6144.723487442986;6146.385361463997;6146.416090471398;6164.075388691732;5703.458171473703;5797.333306669787;5828.76684932598;5864.501517371071;5891.23413956183;5830.62100963436;5917.408259174048;5923.4076592340425;5940.673262970578;5964.7912323068485;5807.216025836458;5883.588148829712;5885.61743486672;5887.911681324698;5888.646681199141;5633.126865335879;5707.800226992035;5863.413658634103;5874.383189765184;5879.323877754113;5686.687232202268;5719.28508936383;5764.135379692912;5764.798232061858;5821.76712931478;5816.912746308724;5870.412958704266;5874.765009399747;5874.882502350015;5932.288125424977;5504.972475137599;5647.661140331593;5725.770969161354;5731.312242530923;5735.025045742151 11:06:05 INFO - 2015-11-20 11:06:05,539 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.0011778915741;586.0535235594515;594.1740980037748;599.4874382403043;601.7623038899636;31896.521552176706;32695.836520817393;32698;32735.50896736548;32763;32452.83773581129;40873.7956310218;41428.792856035754;41503.16993660125;41545.37681934774;8824;8962.641494340218;8965.95517022414;8967.730968070935;8972.8654070189;7798.064232292133;7984.441089123764;8770.56147192641;8885.4668719877;8892.555372231394;10859.51132199049;11086.057685096777;11101.000909918106;11109.388983605899;11118.22172447929;10643.095336896335;10759.977802108866;10760.677179684622;10768;10768.569257229741;7917.2874441300555;8137.349012079019;10477.947610261976;10764.78470430587;11041.171912106623;40100;40551.39172912409;40641.18717625661;40703.38944915828;40741.796291018356;3193.2016995751064;3325.8004519728893;3427.503012063262;3699.3896007158787;4164.104717485755;30208.348905931383;30377.24056898573;30671.233219169477;30855.537166942515;30923.22691932697;3826.885193444173;3848.499695039655;3851.268259030775;3857;3881.5536213335545;269534;270019.999999998;270143;270401;270844;56940.71529642325;57619.13571296434;57630.4236957625;57765;57818.13272800911;62263.37736622666;62410;62417.37582624207;62537.68731156406;62704;13121;13219.206847589176;13263.403146858414;13267.867321326856;13271.867281327062;9694.321397502248;9713.514324283757;9715.36850104741;9721.611135554498;9806.068423499755;18347.80035509957;19497.317593884145;19611.21555137807;19619;19662.11520481582;7841.411894107965;8037.23646253605;8138.918610813935;8188.303994160563;8209;919.5034681272039;932.9393589416666;1000.7548150702979;1008.9495525223709;1138.7267055906523;27826.582601260998;28055.71944280572;28092.578611320845;28092.578611320845;28215.57676634852;925.509479975614;1039.4906495816995;1047.2721458586361;1067.604986155112;1077.8167711489066;13476.595702128952;13680;13687.384067716977;13899.513517026855;13981.79027314591;284170;288295;288381;288729;315162;40018.799906000866;53931;58607.70696146492;58765;58781.11828322493;1389.1942673249491;1396.5880065380736;1408.619672688348;1412.1738782811965;1438.2736717957364;27834.5824812632;29163.270918227216;31581;32033.199170020936;32772.34455310928;49698;50441.24338134858;50519.74740126276;50524.24213636872;50565;274345;276563;277224;277760;277831;42305.57694423016;42576.78711606546;42784.786076069424;42796.572034279256;43075.13849723051;44397.77801111103;44655.10689786251;45426.091478170914;45482.09035819199;45516.54483455256;38316.23367532578;38796.80601596974;39261.214775704895;39987.40018899777;40052.19895602013;38276;38292.80853595714;38625.2274954505;39020.804895975336;39280.21439571135;37549.24901502009;37558.2488350226;37602.435963460026;37621;39937.2012559753;33534.832325838215;33544;33981.320373592884;34645.48031779576;34781.826090869385;25750.613740793528;25879.611805823304;26048.21855344343;26085;26353.736462635894 11:06:05 INFO - 2015-11-20 11:06:05,542 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.8704661171349;338.9186595217148;342.7395179663455;344.7535012466088;345.047668435119;13484.325783710825;13827.585172444818;16106.51680449587;16150.192490375479;16715.91642041791;15666.216689165552;15671.84328156718;15754.842451575481;15769.290381932811;15811.604709882258;5061.949380506203;5295.788168473276;5297.417284098746;5298.36419629645;5312.123499622558;3812.3519001769764;3939.9212015759667;5247.212918062302;5805.158252053449;5961.970190149065;5840.269966254218;5859.4140585941495;5875.706214689249;5883.441073098049;5892.941070589282;5675.744591493372;5772.884542309152;5802.5938184327115;5806.245188125559;5823.5341172706085;5118.053160165381;5130.358705161855;5133.922991155136;5139.049275883974;5148.588112950955;19961.201551937906;19976.600467990706;20370.879601621906;20448.79551204484;20453.181872725072;1837.5314294854861;1958.8334991525737;2051.6922461630725;2071.637463443906;2099.590579836932;9011.819763604757;9239.815203695889;11011.61459348927;12194.085443591766;12328.691782705415;1806.2594336322045;1810.1220907859677;1851.1022154255174;1862.3574866670976;1945.737325461073;54696;55663.44336556623;58567.70716146392;58752.99999999957;58875.70562147162;9643.807123857623;9669.806603868024;9671.758206044906;9695.418274903528;9741.707748767549;12438.440270187863;12462.626121216377;12474;12490.687732806753;12531.24812511234;7238.638068096574;7285.089363829521;7319.085114360705;7325.120985481776;7381.778546643609;7010.509264351446;7020.297970202939;7067.787966361017;7079.610621415872;7112.324329188822;4145.79271036453;4164.604362585549;4165.625093741578;4184.91630167401;4185.121124563876;1675.7067513185389;1729.4465770953175;2807.4385122975486;2870.5263631500984;3028.5608586754797;796.6932730898645;896.0994200828126;981.6073570571685;985.8816941966867;1026.2764750850633;14913.403463861541;17326.3069477222;17428.215730292166;17529.211185496428;17872.28510859577;851.9787005324793;923.8429466990627;932.1750251027754;956.9090936361034;985.7239972807625;9738.951305243429;10140.543675534618;10173.965206958637;10178.796424071477;10182.694519164437;520052;539205;540430;557099;565778;75381.24618753852;79362.60318698485;79465;80483.59758201288;81715;1141.4920360439692;1158.2297771981707;1162.3026184289358;1175.2948231061466;1178.8762179971152;15608.453704120302;15672.451464199154;15824.92087539555;15857.603559911095;15882.841171588598;34316.82841585776;34540.30919381649;34831.82584087063;35537;36083.458748118275;40521.79739101286;41041.45940298141;41792.582074180085;41866.79066604647;42010.579894200666;9359.064093590587;9515.809683806423;9534.904650953402;9676.806463870824;9690.515474226402;11300.651292913211;11324.773504529698;13771.104878182887;14716.264186790404;18063;12806.35968201605;13952.302384880919;14133.222672753098;14327.78508322397;14537.41850325975;13741.725165496833;13982;14323.427062917366;14355.85644143587;14658.19379934114;14925;15257.237138142826;15458.072515649097;15468.381264749283;15558.299876505358;8917.464952102895;9105.726828195166;9248.213901818151;9255.398399104037;9689;14070.296485175904;14073.155610663393;14380.35288412003;14514.564563063124;14583.343749531085 11:06:05 INFO - 2015-11-20 11:06:05,543 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1355.8372995240572;1712.246611490944;1761.339497688367;1772.5923037701325;1784.6252287019724;6847.931520684791;7442.33019028288;7541.283578060089;7550.16948135706;7553.546787192772;7374.041374621292;7618.885716714254;7630.809229769245;7636.732714354998;7640.847183056336;1996.9900150499227;2041.6937459381063;2226.2319499772634;2283.885805709712;2304.8501847379866;2288.2105673542683;2304.4008557774932;2307.238611258289;2310.249169020067;2311.526137141882;2245.696830927828;2305.527366889792;2306.942326441844;2310.318456055459;2312.583734927712;2015.9697604535943;2059.1145807302855;2210.668399740036;2254.8083412909923;2258.446680563256;2252.1329288223988;2271.034810205656;2297.414159389362;2298.9999350282515;2299.5171014087064;7648.770536883902;7701.345385642171;7704.8844267336035;7710.537367757953;7716.575588342639;4605.194091034055;4684.344191813149;4695.483496815347;4709.764511774398;4711.952880471185;2995.7303842654046;3026.6670666226696;3063.908082757521;3065.509518477033;3146.9055928322186;1003.372891942536;1004.1013293102632;1006.2352612014921;1047.3401756893186;1048.7063622185801;10226.23303252259;10320.329178603366;10323.277370584137;10340.37957722539;10354.53404596795;4092;4144.44050053245;4203.894902627398;4219.029623186684;4255.404243405926;8567.443116197428;8576.142385761374;8592.5703714814;8592.914070859337;8593.52735599548;4642.582167604932;4671.182543054952;4673.322368256584;4673.766311684402;4683.414573178353;4252.808623611945;4297.226499230169;4298.656107511391;4300.978495107504;4306.332518459643;3414.590249170066;3462.7576069674883;3473.4442489201606;3474.3051389722154;3488.389531831919;1032.9276950613535;1049.7742985258205;1052.952617132231;1079.2607064161075;1079.83262594298;1273.6561128495255;1274.0253705914984;1282.9743405131844;1286.3053950866426;1295.3846922711637;6854.417374523221;6918.273581273894;6933.306669333027;6945.444364450832;6962.373386395248;499.5728652002558;502.7461132128252;503.3531911493713;506.06630766236236;506.8631469503213;5346.278252435949;5507.614466987353;5559.916601250903;5639.351474580394;5665.3768085510565;9135.634574617074;9202.723918282461;9316.813663726824;9330.300227482965;9334.39326443779;8799.428037177562;9097;9105.590248438835;9197.678081267124;9200.401973871676;7016.894746578805;7137.2149063602965;7221.927780722125;7224.4581656375985;7225.783226503213;6458.128152699325;6506.934930650633;6566.376194261537;6576.704048317742;6609.867802644017;7897.13131555517;7964.084130325086;8056.395770317366;8089.393295502979;8177.05963814169;8126.349892008743;8270;8294.170582941657;8396.328293736364;8409.495430274203;6434.613923164625;6533.575317604341;6542.018697195459;6544.3782840630065;6549.869002619826;7412.147603025721;7486.625668716433;7489.363404110712;7497.250274972459;7499.550026998398;6727.078626579569;6927.134108236471;6937.410320122846;7009.2990700929495;7094.574325540484;6158.630482171084;6415.390537898892;6514.967425162844;6757.45940324763;6780.288069752803;5751.281089863767;5767.971160144172;5776.277965254343;5776.624519406225;5781.219535362672;5978.730957107027;6266.68666566679;6288.622682639057;6293.024581189923;6298.874022519432;6131.4481696645735;6179.28938172116;6179.412955769195;6182.938170618237;6188.133661287513 11:06:05 INFO - 2015-11-20 11:06:05,547 DEBUG : BROWSER_OUTPUT: |4;prototype.html;323.5454186867451;328.41378140020066;330.433306878703;333.1404975164076;336.5439829031662;5967.582269241155;6106.694665266741;6156.599821011637;6171.382861713826;6171.845703857394;5969.701514924258;6062.120992456091;6078.756849726016;6110.266767987837;6122.173506576611;4694.4366675998845;4700.9892873032295;4702.459217190016;4703.482616912137;4707.129181101507;4447.799849006802;4510.887227819314;4593.954060459386;4661.720296782204;4708.0113176233035;4596.563326483995;4604.102200070971;4605;4613.261878099504;4626.398568186131;4665.5567721066445;4671.065786842645;4678.836240731592;4685.5314468553215;4688.953110468886;4114.629683328485;4118.052847845012;4131.277026520377;4134.607212314825;4138.461999939988;5650.0959846424375;5763.740631671585;5769.365369809318;5770.624909380919;5779.595428320019;5470.863228419282;5475.06923822951;5477.3427188737605;5482.91775623366;5485.0949593317055;6225.564210505267;6441.033844923252;6442.742290308382;6449.645269510175;6461.547691661585;4489.326601009842;4490.977545112286;4582.495925448198;4582.6104781093645;4585.3122031695175;6679.1317128773435;6685.632290224035;6696.732130714766;6699.799006029827;6721.966390168018;4608.423947006624;4612.677112602153;4620.168369693421;4622.791974361162;4624.075184963021;4601.769911504478;4685.109829132454;4703.341532185496;4705.788239529229;4743.098811225925;5432.6468779529205;5451.863703407446;5452.482014208644;5454.318210223722;5456.563474921997;6511.15355003856;6516.348365163446;6518.739250430024;6519.282878883319;6550.967245163839;1657.3039323483924;1693.6866679664302;1694.3984885365765;1695.7286834106483;1696.6097797506395;1049.6850944716555;1066.4855904615465;1071.8124328242527;1074.398336931321;1117.1509652664033;6048.60684055535;6125.326214116443;6129.969350153221;6132.478739307119;6135;6502.6098434093155;6613.60318380889;6619.669016549154;6625.3043430440075;6652.534322597372;6105.664188469588;6110.633361998294;6118.296395914527;6123.663198524035;6138.324784273726;3575.1419659281587;3605.260921511084;3609.242059167552;3614.3855544557487;3614.620464851153;6763.864722705518;6833.077534532775;6909.481788865855;6914.965425172943;6916.55042422241;6890.276520965226;6893.20728116263;7011.509194356346;7017.157941047005;7023.157221133497;6967.338102880219;7014.123234595676;7017.228104908558;7020.648967551602;7028.753993610301;6439.259485159267;6561.245456772342;6618.404343609098;6643.169603799525;6747.089142965637;6716.261211266855;6739.797806065826;6742;6755.628440435823;6756.054152418567;6955.095837541289;6990.650467476504;6990.965045174741;6997.440204783707;7004.334588214111;4502.7138219038625;4536.818527259004;4568.634509239187;4596.195665758546;4598.632109431171;6739.157605299338;6770.187577490733;6771.559848609824;6773.356531129535;6776.830579235559;6543.345665433419;6549.967250163719;6579.769708060195;6584.374484423972;6601.570897891622;6427.132337134427;6478.708458119301;6549;6579.769708060195;6598;6456.12842266288;6465.127207826883;6478.967605161944;6480.833449979049;6486.156799616019;6617.536772426077;6621.271660117287;6628.933710662832;6633.734650614115;6636.535442518977;6252.406021427957;6433.035044743326;6433.2601750797385;6434.356564343529;6438.163038804925 11:06:05 INFO - 2015-11-20 11:06:05,547 DEBUG : BROWSER_OUTPUT: |5;yui.html;731.8353370491639;740.5038624121838;755.090116409726;776.8990031295931;840.5251033166261;12151.878481215184;12250.877491225085;12285.63143105706;12335.938320308385;12378.752424951517;11454.48454819533;11570.65288041358;13517.662058448544;13737.381817818197;13954.372053257628;689.4277749467955;817.146082343952;831.6340810043591;832.138736407818;832.5504227717025;693.3309356471004;823.1028179284579;833.9958300208491;834.228338786623;836.1721895323616;859.9312055035582;871.6164887449534;872.8821609082788;873.166126349338;873.2141073034288;714.5783987447431;719.0903507063568;837.4723923927947;858.7552547523957;860.4149178558578;623.6351734235477;626.545754328113;627.0969803482969;627.1408170806025;627.2410383436048;12283.447244873912;12372.566960156351;12401;12440.94251988582;12441.502339906392;11922.284662920252;11934.16460847741;11990;12656.936715316457;12938.223706577635;9967.252456065824;9979.501024948724;10071.69784906454;10205.693829185137;10520.053195212467;3522.1370764162943;3572.624874388204;3574.696150827183;3581.71346292296;3697.2605478904056;49295.75352123217;49869.50130498685;49883;49901.25148122781;49925.25112123321;9388.530573471298;9531.428114313163;9553.856692149624;9576.712698619052;9740.512974351253;17537;17542.824571754376;17544.210510527057;17558.64882702339;17593.912030439766;6967.372936435644;7129.750458733919;7232.63836808168;7323.853522929511;7470.514416562906;4092.590740925943;4129.587041295847;4141.799952255906;4184.435101261291;4228.260054490452;3020.7432368248506;3068.1715936697415;3070.293832418556;3073.9077827665205;3075.2311922019494;537.4222710586135;543.4972650298458;555.8138023762085;557.6876948908624;558;644.1658052821514;669.2972379002126;673.5619452469014;683.1528904158807;691.9411849992706;7963.203679632106;8192.836143277102;8344.165583441607;8345.165483451729;8402.117777633383;508.6591983371076;542.3302221756128;560.6860158311358;622.539320902538;636.4113195294427;3624.2751449709635;3878.8642397516514;3899.688024958053;3958.6635136013188;4086.9182616347507;57027.718891244716;57097.429025710044;57491.712541437024;57848.71075644679;58509.122363164584;49983.25025124626;51100;51115.488845111075;51127.23309150366;51286.230706539434;45967;46632.7668361656;46642.766786165856;46917;46946;8234;8384.706535271236;8391.748247552583;8465.91534084676;8507.276881465144;33681.15797105092;33736.49395259122;34267;35072.824635876656;35180.64819351876;42692.78653606712;44435;46522;46651;47292.52707472881;9735.659251926148;9775.413475191226;10228.437435941094;10467.842982355423;10601.787964240517;11670.124740644655;11783.646490605295;11810.114241431755;11831.230969986924;11887.28676279426;10255.7436064099;10395.480225988822;10670.946645266724;10789.942289371395;10870.510827012646;10414.895851041392;10884.891151088388;11050.281731687415;11147.55409783632;11176;10538.262321637718;10728.302660327054;10956.671299861016;11179.66461006171;11280.2667826591;9482.857757133786;9604.519774011133;9709.9029009709;9888.456134912649;9915.801683966425;8518.446300990416;8876.720511735673;8930.240929521064;9418.858509200583;9565.378250413702 11:06:05 INFO - 2015-11-20 11:06:05,547 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:06:05 INFO - 2015-11-20 11:06:05,547 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:06:05 INFO - 2015-11-20 11:06:05,547 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,933 11:06:05 INFO - 2015-11-20 11:06:05,547 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:06:05 INFO - 2015-11-20 11:06:05,547 DEBUG : BROWSER_OUTPUT: __startTimestamp1448046365536__endTimestamp 11:06:05 INFO - 2015-11-20 11:06:05,547 DEBUG : BROWSER_OUTPUT: 11:06:05 INFO - 2015-11-20 11:06:05,547 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:06:05 INFO - 2015-11-20 11:06:05,548 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:06:05 INFO - 2015-11-20 11:06:05,548 DEBUG : BROWSER_OUTPUT: 11:06:05 INFO - 2015-11-20 11:06:05,548 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5464.08 Median:5719.29 stddev:740.71 (13.0%) stddev-sans-first:721.19 11:06:05 INFO - 2015-11-20 11:06:05,549 DEBUG : BROWSER_OUTPUT: Values: 3190.5 3262.1 3298.4 3310.6 3329.8 5330.3 5436.0 5470.2 5475.3 5490.4 5431.5 5432.3 5450.2 5456.7 5568.1 4962.9 4979.5 4991.9 5033.3 5104.1 288.3 4891.7 5047.4 5075.9 5086.1 4975.6 5042.0 5047.4 5095.0 5096.8 5045.5 5072.8 5074.0 5075.4 5123.7 4941.7 5029.6 5056.1 5063.1 5067.9 5213.9 5258.1 5275.4 5294.4 5323.0 5960.5 5997.1 5998.6 6004.1 6011.4 5789.5 5896.7 5918.2 6033.9 6042.7 5444.5 5524.5 5571.9 5572.5 5577.9 6062.2 6123.6 6135.5 6136.4 6139.1 5673.5 5876.8 5947.8 5949.5 5953.1 5811.7 5880.4 5887.8 5929.3 5969.6 5835.8 5855.9 5866.3 5874.8 5884.0 5744.0 5877.9 5898.8 5899.2 5905.2 4454.4 4508.8 4524.5 4571.6 4587.3 4041.1 4046.6 4069.1 4077.3 4077.4 5447.5 5527.9 5537.7 5538.6 5552.4 5857.1 5974.9 5978.2 5995.5 6015.8 5531.1 5543.9 5544.8 5554.8 5561.7 5015.8 5017.5 5018.8 5031.9 5055.2 5890.1 5954.9 6024.5 6041.4 6097.1 5974.1 5981.2 6027.9 6075.5 6078.1 6097.1 6144.7 6146.4 6146.4 6164.1 5703.5 5797.3 5828.8 5864.5 5891.2 5830.6 5917.4 5923.4 5940.7 5964.8 5807.2 5883.6 5885.6 5887.9 5888.6 5633.1 5707.8 5863.4 5874.4 5879.3 5686.7 5719.3 5764.1 5764.8 5821.8 5816.9 5870.4 5874.8 5874.9 5932.3 5505.0 5647.7 5725.8 5731.3 5735.0 11:06:05 INFO - 2015-11-20 11:06:05,549 DEBUG : BROWSER_OUTPUT: 11:06:05 INFO - 2015-11-20 11:06:05,549 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45963.44 Median:37553.75 stddev:72995.65 (194.4%) stddev-sans-first:73120.81 11:06:05 INFO - 2015-11-20 11:06:05,549 DEBUG : BROWSER_OUTPUT: Values: 558.0 586.1 594.2 599.5 601.8 31896.5 32695.8 32698.0 32735.5 32763.0 32452.8 40873.8 41428.8 41503.2 41545.4 8824.0 8962.6 8966.0 8967.7 8972.9 7798.1 7984.4 8770.6 8885.5 8892.6 10859.5 11086.1 11101.0 11109.4 11118.2 10643.1 10760.0 10760.7 10768.0 10768.6 7917.3 8137.3 10477.9 10764.8 11041.2 40100.0 40551.4 40641.2 40703.4 40741.8 3193.2 3325.8 3427.5 3699.4 4164.1 30208.3 30377.2 30671.2 30855.5 30923.2 3826.9 3848.5 3851.3 3857.0 3881.6 269534.0 270020.0 270143.0 270401.0 270844.0 56940.7 57619.1 57630.4 57765.0 57818.1 62263.4 62410.0 62417.4 62537.7 62704.0 13121.0 13219.2 13263.4 13267.9 13271.9 9694.3 9713.5 9715.4 9721.6 9806.1 18347.8 19497.3 19611.2 19619.0 19662.1 7841.4 8037.2 8138.9 8188.3 8209.0 919.5 932.9 1000.8 1008.9 1138.7 27826.6 28055.7 28092.6 28092.6 28215.6 925.5 1039.5 1047.3 1067.6 1077.8 13476.6 13680.0 13687.4 13899.5 13981.8 284170.0 288295.0 288381.0 288729.0 315162.0 40018.8 53931.0 58607.7 58765.0 58781.1 1389.2 1396.6 1408.6 1412.2 1438.3 27834.6 29163.3 31581.0 32033.2 32772.3 49698.0 50441.2 50519.7 50524.2 50565.0 274345.0 276563.0 277224.0 277760.0 277831.0 42305.6 42576.8 42784.8 42796.6 43075.1 44397.8 44655.1 45426.1 45482.1 45516.5 38316.2 38796.8 39261.2 39987.4 40052.2 38276.0 38292.8 38625.2 39020.8 39280.2 37549.2 37558.2 37602.4 37621.0 39937.2 33534.8 33544.0 33981.3 34645.5 34781.8 25750.6 25879.6 26048.2 26085.0 26353.7 11:06:05 INFO - 2015-11-20 11:06:05,549 DEBUG : BROWSER_OUTPUT: 11:06:05 INFO - 2015-11-20 11:06:05,549 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28618.54 Median:35184.41 stddev:88938.93 (252.8%) stddev-sans-first:89163.06 11:06:05 INFO - 2015-11-20 11:06:05,549 DEBUG : BROWSER_OUTPUT: Values: 332.9 338.9 342.7 344.8 345.0 13484.3 13827.6 16106.5 16150.2 16715.9 15666.2 15671.8 15754.8 15769.3 15811.6 5061.9 5295.8 5297.4 5298.4 5312.1 3812.4 3939.9 5247.2 5805.2 5962.0 5840.3 5859.4 5875.7 5883.4 5892.9 5675.7 5772.9 5802.6 5806.2 5823.5 5118.1 5130.4 5133.9 5139.0 5148.6 19961.2 19976.6 20370.9 20448.8 20453.2 1837.5 1958.8 2051.7 2071.6 2099.6 9011.8 9239.8 11011.6 12194.1 12328.7 1806.3 1810.1 1851.1 1862.4 1945.7 54696.0 55663.4 58567.7 58753.0 58875.7 9643.8 9669.8 9671.8 9695.4 9741.7 12438.4 12462.6 12474.0 12490.7 12531.2 7238.6 7285.1 7319.1 7325.1 7381.8 7010.5 7020.3 7067.8 7079.6 7112.3 4145.8 4164.6 4165.6 4184.9 4185.1 1675.7 1729.4 2807.4 2870.5 3028.6 796.7 896.1 981.6 985.9 1026.3 14913.4 17326.3 17428.2 17529.2 17872.3 852.0 923.8 932.2 956.9 985.7 9739.0 10140.5 10174.0 10178.8 10182.7 520052.0 539205.0 540430.0 557099.0 565778.0 75381.2 79362.6 79465.0 80483.6 81715.0 1141.5 1158.2 1162.3 1175.3 1178.9 15608.5 15672.5 15824.9 15857.6 15882.8 34316.8 34540.3 34831.8 35537.0 36083.5 40521.8 41041.5 41792.6 41866.8 42010.6 9359.1 9515.8 9534.9 9676.8 9690.5 11300.7 11324.8 13771.1 14716.3 18063.0 12806.4 13952.3 14133.2 14327.8 14537.4 13741.7 13982.0 14323.4 14355.9 14658.2 14925.0 15257.2 15458.1 15468.4 15558.3 8917.5 9105.7 9248.2 9255.4 9689.0 14070.3 14073.2 14380.4 14514.6 14583.3 11:06:05 INFO - 2015-11-20 11:06:05,549 DEBUG : BROWSER_OUTPUT: 11:06:05 INFO - 2015-11-20 11:06:05,549 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5254.25 Median:5759.63 stddev:2718.95 (47.2%) stddev-sans-first:2710.79 11:06:05 INFO - 2015-11-20 11:06:05,550 DEBUG : BROWSER_OUTPUT: Values: 1355.8 1712.2 1761.3 1772.6 1784.6 6847.9 7442.3 7541.3 7550.2 7553.5 7374.0 7618.9 7630.8 7636.7 7640.8 1997.0 2041.7 2226.2 2283.9 2304.9 2288.2 2304.4 2307.2 2310.2 2311.5 2245.7 2305.5 2306.9 2310.3 2312.6 2016.0 2059.1 2210.7 2254.8 2258.4 2252.1 2271.0 2297.4 2299.0 2299.5 7648.8 7701.3 7704.9 7710.5 7716.6 4605.2 4684.3 4695.5 4709.8 4712.0 2995.7 3026.7 3063.9 3065.5 3146.9 1003.4 1004.1 1006.2 1047.3 1048.7 10226.2 10320.3 10323.3 10340.4 10354.5 4092.0 4144.4 4203.9 4219.0 4255.4 8567.4 8576.1 8592.6 8592.9 8593.5 4642.6 4671.2 4673.3 4673.8 4683.4 4252.8 4297.2 4298.7 4301.0 4306.3 3414.6 3462.8 3473.4 3474.3 3488.4 1032.9 1049.8 1053.0 1079.3 1079.8 1273.7 1274.0 1283.0 1286.3 1295.4 6854.4 6918.3 6933.3 6945.4 6962.4 499.6 502.7 503.4 506.1 506.9 5346.3 5507.6 5559.9 5639.4 5665.4 9135.6 9202.7 9316.8 9330.3 9334.4 8799.4 9097.0 9105.6 9197.7 9200.4 7016.9 7137.2 7221.9 7224.5 7225.8 6458.1 6506.9 6566.4 6576.7 6609.9 7897.1 7964.1 8056.4 8089.4 8177.1 8126.3 8270.0 8294.2 8396.3 8409.5 6434.6 6533.6 6542.0 6544.4 6549.9 7412.1 7486.6 7489.4 7497.3 7499.6 6727.1 6927.1 6937.4 7009.3 7094.6 6158.6 6415.4 6515.0 6757.5 6780.3 5751.3 5768.0 5776.3 5776.6 5781.2 5978.7 6266.7 6288.6 6293.0 6298.9 6131.4 6179.3 6179.4 6182.9 6188.1 11:06:05 INFO - 2015-11-20 11:06:05,550 DEBUG : BROWSER_OUTPUT: 11:06:05 INFO - 2015-11-20 11:06:05,551 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5435.23 Median:6122.92 stddev:1642.20 (26.8%) stddev-sans-first:1601.36 11:06:05 INFO - 2015-11-20 11:06:05,551 DEBUG : BROWSER_OUTPUT: Values: 323.5 328.4 330.4 333.1 336.5 5967.6 6106.7 6156.6 6171.4 6171.8 5969.7 6062.1 6078.8 6110.3 6122.2 4694.4 4701.0 4702.5 4703.5 4707.1 4447.8 4510.9 4594.0 4661.7 4708.0 4596.6 4604.1 4605.0 4613.3 4626.4 4665.6 4671.1 4678.8 4685.5 4689.0 4114.6 4118.1 4131.3 4134.6 4138.5 5650.1 5763.7 5769.4 5770.6 5779.6 5470.9 5475.1 5477.3 5482.9 5485.1 6225.6 6441.0 6442.7 6449.6 6461.5 4489.3 4491.0 4582.5 4582.6 4585.3 6679.1 6685.6 6696.7 6699.8 6722.0 4608.4 4612.7 4620.2 4622.8 4624.1 4601.8 4685.1 4703.3 4705.8 4743.1 5432.6 5451.9 5452.5 5454.3 5456.6 6511.2 6516.3 6518.7 6519.3 6551.0 1657.3 1693.7 1694.4 1695.7 1696.6 1049.7 1066.5 1071.8 1074.4 1117.2 6048.6 6125.3 6130.0 6132.5 6135.0 6502.6 6613.6 6619.7 6625.3 6652.5 6105.7 6110.6 6118.3 6123.7 6138.3 3575.1 3605.3 3609.2 3614.4 3614.6 6763.9 6833.1 6909.5 6915.0 6916.6 6890.3 6893.2 7011.5 7017.2 7023.2 6967.3 7014.1 7017.2 7020.6 7028.8 6439.3 6561.2 6618.4 6643.2 6747.1 6716.3 6739.8 6742.0 6755.6 6756.1 6955.1 6990.7 6991.0 6997.4 7004.3 4502.7 4536.8 4568.6 4596.2 4598.6 6739.2 6770.2 6771.6 6773.4 6776.8 6543.3 6550.0 6579.8 6584.4 6601.6 6427.1 6478.7 6549.0 6579.8 6598.0 6456.1 6465.1 6479.0 6480.8 6486.2 6617.5 6621.3 6628.9 6633.7 6636.5 6252.4 6433.0 6433.3 6434.4 6438.2 11:06:05 INFO - 2015-11-20 11:06:05,551 DEBUG : BROWSER_OUTPUT: 11:06:05 INFO - 2015-11-20 11:06:05,551 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13614.64 Median:49954.25 stddev:16111.10 (32.3%) stddev-sans-first:16127.25 11:06:05 INFO - 2015-11-20 11:06:05,551 DEBUG : BROWSER_OUTPUT: Values: 731.8 740.5 755.1 776.9 840.5 12151.9 12250.9 12285.6 12335.9 12378.8 11454.5 11570.7 13517.7 13737.4 13954.4 689.4 817.1 831.6 832.1 832.6 693.3 823.1 834.0 834.2 836.2 859.9 871.6 872.9 873.2 873.2 714.6 719.1 837.5 858.8 860.4 623.6 626.5 627.1 627.1 627.2 12283.4 12372.6 12401.0 12440.9 12441.5 11922.3 11934.2 11990.0 12656.9 12938.2 9967.3 9979.5 10071.7 10205.7 10520.1 3522.1 3572.6 3574.7 3581.7 3697.3 49295.8 49869.5 49883.0 49901.3 49925.3 9388.5 9531.4 9553.9 9576.7 9740.5 17537.0 17542.8 17544.2 17558.6 17593.9 6967.4 7129.8 7232.6 7323.9 7470.5 4092.6 4129.6 4141.8 4184.4 4228.3 3020.7 3068.2 3070.3 3073.9 3075.2 537.4 543.5 555.8 557.7 558.0 644.2 669.3 673.6 683.2 691.9 7963.2 8192.8 8344.2 8345.2 8402.1 508.7 542.3 560.7 622.5 636.4 3624.3 3878.9 3899.7 3958.7 4086.9 57027.7 57097.4 57491.7 57848.7 58509.1 49983.3 51100.0 51115.5 51127.2 51286.2 45967.0 46632.8 46642.8 46917.0 46946.0 8234.0 8384.7 8391.7 8465.9 8507.3 33681.2 33736.5 34267.0 35072.8 35180.6 42692.8 44435.0 46522.0 46651.0 47292.5 9735.7 9775.4 10228.4 10467.8 10601.8 11670.1 11783.6 11810.1 11831.2 11887.3 10255.7 10395.5 10670.9 10789.9 10870.5 10414.9 10884.9 11050.3 11147.6 11176.0 10538.3 10728.3 10956.7 11179.7 11280.3 9482.9 9604.5 9709.9 9888.5 9915.8 8518.4 8876.7 8930.2 9418.9 9565.4 11:06:05 INFO - 2015-11-20 11:06:05,551 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:06:05 INFO - 2015-11-20 11:06:05,551 DEBUG : BROWSER_OUTPUT: 11:06:06 INFO - 2015-11-20 11:06:06,280 INFO : Browser exited with error code: 0 11:06:06 INFO - 2015-11-20 11:06:06,298 INFO : Completed test dromaeo_css (00:18:33) 11:06:06 INFO - 2015-11-20 11:06:06,298 INFO : Starting test kraken 11:06:06 INFO - 2015-11-20 11:06:06,298 DEBUG : operating with platform_type : linux_ 11:06:06 INFO - 2015-11-20 11:06:06,299 INFO : Initialising browser for kraken test... 11:06:06 INFO - 2015-11-20 11:06:06,305 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFCIk4w/profile http://localhost:57323/getInfo.html 11:06:10 INFO - 2015-11-20 11:06:10,425 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:06:10 INFO - 2015-11-20 11:06:10,426 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:06:10 INFO - 2015-11-20 11:06:10,426 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:06:10 INFO - 2015-11-20 11:06:10,426 DEBUG : BROWSER_OUTPUT: __metrics 11:06:10 INFO - 2015-11-20 11:06:10,587 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:06:11 INFO - 2015-11-20 11:06:11,875 INFO : Browser initialized. 11:06:11 INFO - 2015-11-20 11:06:11,875 INFO : Running cycle 1/1 for kraken test... 11:06:11 INFO - 2015-11-20 11:06:11,875 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFCIk4w/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:06:23 INFO - 2015-11-20 11:06:23,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 141582336 11:06:23 INFO - 2015-11-20 11:06:23,670 DEBUG : BROWSER_OUTPUT: 11:06:26 INFO - 2015-11-20 11:06:26,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57323/tests/kraken/driver.html?testName=audio-beat-detection) 11:06:26 INFO - 2015-11-20 11:06:26,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 179212288 11:06:26 INFO - 2015-11-20 11:06:26,715 DEBUG : BROWSER_OUTPUT: 11:06:29 INFO - 2015-11-20 11:06:29,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57323/tests/kraken/driver.html?testName=audio-dft) 11:06:29 INFO - 2015-11-20 11:06:29,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 169017344 11:06:29 INFO - 2015-11-20 11:06:29,865 DEBUG : BROWSER_OUTPUT: 11:06:32 INFO - 2015-11-20 11:06:32,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57323/tests/kraken/driver.html?testName=audio-fft) 11:06:33 INFO - 2015-11-20 11:06:33,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 151572480 11:06:33 INFO - 2015-11-20 11:06:33,269 DEBUG : BROWSER_OUTPUT: 11:06:35 INFO - 2015-11-20 11:06:35,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57323/tests/kraken/driver.html?testName=audio-oscillator) 11:06:35 INFO - 2015-11-20 11:06:35,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 154230784 11:06:35 INFO - 2015-11-20 11:06:35,828 DEBUG : BROWSER_OUTPUT: 11:06:37 INFO - 2015-11-20 11:06:37,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57323/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:06:38 INFO - 2015-11-20 11:06:38,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 154578944 11:06:38 INFO - 2015-11-20 11:06:38,541 DEBUG : BROWSER_OUTPUT: 11:06:41 INFO - 2015-11-20 11:06:41,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57323/tests/kraken/driver.html?testName=imaging-darkroom) 11:06:42 INFO - 2015-11-20 11:06:42,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 155459584 11:06:42 INFO - 2015-11-20 11:06:42,015 DEBUG : BROWSER_OUTPUT: 11:06:45 INFO - 2015-11-20 11:06:45,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57323/tests/kraken/driver.html?testName=imaging-desaturate) 11:06:45 INFO - 2015-11-20 11:06:45,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 156803072 11:06:45 INFO - 2015-11-20 11:06:45,983 DEBUG : BROWSER_OUTPUT: 11:06:48 INFO - 2015-11-20 11:06:48,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57323/tests/kraken/driver.html?testName=json-parse-financial) 11:06:49 INFO - 2015-11-20 11:06:49,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 156639232 11:06:49 INFO - 2015-11-20 11:06:49,309 DEBUG : BROWSER_OUTPUT: 11:06:50 INFO - 2015-11-20 11:06:50,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57323/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:06:51 INFO - 2015-11-20 11:06:51,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 165752832 11:06:51 INFO - 2015-11-20 11:06:51,403 DEBUG : BROWSER_OUTPUT: 11:06:53 INFO - 2015-11-20 11:06:53,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57323/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:06:53 INFO - 2015-11-20 11:06:53,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 164077568 11:06:53 INFO - 2015-11-20 11:06:53,775 DEBUG : BROWSER_OUTPUT: 11:06:55 INFO - 2015-11-20 11:06:55,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57323/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:06:56 INFO - 2015-11-20 11:06:56,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 170442752 11:06:56 INFO - 2015-11-20 11:06:56,400 DEBUG : BROWSER_OUTPUT: 11:06:58 INFO - 2015-11-20 11:06:58,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57323/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:06:59 INFO - 2015-11-20 11:06:59,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 179060736 11:06:59 INFO - 2015-11-20 11:06:59,361 DEBUG : BROWSER_OUTPUT: 11:07:01 INFO - 2015-11-20 11:07:01,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57323/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:07:02 INFO - 2015-11-20 11:07:02,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 178487296 11:07:02 INFO - 2015-11-20 11:07:02,552 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57323/tests/kraken/driver.html?testName=ai-astar) 11:07:04 INFO - 2015-11-20 11:07:04,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 238440448 11:07:04 INFO - 2015-11-20 11:07:04,468 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;108;103;108;110;111;98;108;108;107 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;124;151;163;132;151;154;124;172;125 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;165;161;161;161;161;161;162;161;161 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;84;83;97;71;73;72;98;94;71 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;137;90;90;89;132;91;90;141 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;109;110;109;109;110 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;146;148;149;148;147;148;146 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;95;95;96;95;96 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;58;59;59;59;61;68;57;59 11:07:04 INFO - 2015-11-20 11:07:04,472 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;70;68;68;69;69 11:07:04 INFO - 2015-11-20 11:07:04,473 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;91;84;85;84;84;84;92;95;85 11:07:04 INFO - 2015-11-20 11:07:04,473 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;130;121;115;119;117;122;124;123;121 11:07:04 INFO - 2015-11-20 11:07:04,473 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;153;163;156;157;144;152;151;165;143 11:07:04 INFO - 2015-11-20 11:07:04,473 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;68;67;70;68;67;66;66;66 11:07:04 INFO - 2015-11-20 11:07:04,473 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:07:04 INFO - 2015-11-20 11:07:04,473 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:07:04 INFO - 2015-11-20 11:07:04,473 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,898 11:07:04 INFO - 2015-11-20 11:07:04,473 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:07:04 INFO - 2015-11-20 11:07:04,473 DEBUG : BROWSER_OUTPUT: __startTimestamp1448046424469__endTimestamp 11:07:04 INFO - 2015-11-20 11:07:04,473 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,476 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:07:04 INFO - 2015-11-20 11:07:04,477 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:07:04 INFO - 2015-11-20 11:07:04,477 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,477 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.90 Median:108.00 stddev:3.75 (3.5%) stddev-sans-first:3.96 11:07:04 INFO - 2015-11-20 11:07:04,477 DEBUG : BROWSER_OUTPUT: Values: 108.0 108.0 103.0 108.0 110.0 111.0 98.0 108.0 108.0 107.0 11:07:04 INFO - 2015-11-20 11:07:04,477 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,477 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.50 Median:151.00 stddev:17.23 (11.4%) stddev-sans-first:18.19 11:07:04 INFO - 2015-11-20 11:07:04,477 DEBUG : BROWSER_OUTPUT: Values: 149.0 124.0 151.0 163.0 132.0 151.0 154.0 124.0 172.0 125.0 11:07:04 INFO - 2015-11-20 11:07:04,478 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,478 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 11:07:04 INFO - 2015-11-20 11:07:04,478 DEBUG : BROWSER_OUTPUT: Values: 161.0 165.0 161.0 161.0 161.0 161.0 161.0 162.0 161.0 161.0 11:07:04 INFO - 2015-11-20 11:07:04,478 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,478 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:83.50 stddev:11.31 (13.5%) stddev-sans-first:11.46 11:07:04 INFO - 2015-11-20 11:07:04,478 DEBUG : BROWSER_OUTPUT: Values: 72.0 84.0 83.0 97.0 71.0 73.0 72.0 98.0 94.0 71.0 11:07:04 INFO - 2015-11-20 11:07:04,478 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,478 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:90.00 stddev:22.58 (25.1%) stddev-sans-first:23.45 11:07:04 INFO - 2015-11-20 11:07:04,478 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 137.0 90.0 90.0 89.0 132.0 91.0 90.0 141.0 11:07:04 INFO - 2015-11-20 11:07:04,479 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,479 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:07:04 INFO - 2015-11-20 11:07:04,479 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 11:07:04 INFO - 2015-11-20 11:07:04,479 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,479 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 11:07:04 INFO - 2015-11-20 11:07:04,479 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 146.0 148.0 149.0 148.0 147.0 148.0 146.0 11:07:04 INFO - 2015-11-20 11:07:04,479 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,479 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:07:04 INFO - 2015-11-20 11:07:04,479 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 11:07:04 INFO - 2015-11-20 11:07:04,479 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,479 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.80 Median:59.00 stddev:3.05 (5.2%) stddev-sans-first:3.22 11:07:04 INFO - 2015-11-20 11:07:04,479 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 58.0 59.0 59.0 59.0 61.0 68.0 57.0 59.0 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 70.0 68.0 68.0 69.0 69.0 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.00 stddev:4.27 (5.0%) stddev-sans-first:4.31 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: Values: 83.0 91.0 84.0 85.0 84.0 84.0 84.0 92.0 95.0 85.0 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:121.50 stddev:4.31 (3.5%) stddev-sans-first:4.33 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: Values: 117.0 130.0 121.0 115.0 119.0 117.0 122.0 124.0 123.0 121.0 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:154.50 stddev:7.09 (4.6%) stddev-sans-first:7.50 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: Values: 152.0 153.0 163.0 156.0 157.0 144.0 152.0 151.0 165.0 143.0 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 67.0 70.0 68.0 67.0 66.0 66.0 66.0 11:07:04 INFO - 2015-11-20 11:07:04,481 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:07:04 INFO - 2015-11-20 11:07:04,481 DEBUG : BROWSER_OUTPUT: 11:07:05 INFO - 2015-11-20 11:07:05,350 INFO : Browser exited with error code: 0 11:07:05 INFO - 2015-11-20 11:07:05,422 INFO : Completed test kraken (00:00:59) 11:07:05 INFO - 2015-11-20 11:07:05,422 INFO : Starting test v8_7 11:07:05 INFO - 2015-11-20 11:07:05,422 DEBUG : operating with platform_type : linux_ 11:07:05 INFO - 2015-11-20 11:07:05,422 INFO : Initialising browser for v8_7 test... 11:07:05 INFO - 2015-11-20 11:07:05,428 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp01yBZ5/profile http://localhost:57323/getInfo.html 11:07:09 INFO - 2015-11-20 11:07:09,571 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:07:09 INFO - 2015-11-20 11:07:09,571 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:07:09 INFO - 2015-11-20 11:07:09,571 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:07:09 INFO - 2015-11-20 11:07:09,572 DEBUG : BROWSER_OUTPUT: __metrics 11:07:09 INFO - 2015-11-20 11:07:09,673 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:07:11 INFO - 2015-11-20 11:07:11,049 INFO : Browser initialized. 11:07:11 INFO - 2015-11-20 11:07:11,049 INFO : Running cycle 1/1 for v8_7 test... 11:07:11 INFO - 2015-11-20 11:07:11,049 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp01yBZ5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:07:22 INFO - 2015-11-20 11:07:22,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 142200832 11:07:22 INFO - 2015-11-20 11:07:22,803 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57323/tests/v8_7/run.html (next: http://localhost:57323/tests/v8_7/run.html) 11:07:44 INFO - 2015-11-20 11:07:44,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 513208320 11:07:44 INFO - 2015-11-20 11:07:44,489 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,489 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:07:44 INFO - 2015-11-20 11:07:44,489 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:07:44 INFO - 2015-11-20 11:07:44,489 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:07:44 INFO - 2015-11-20 11:07:44,489 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:07:44 INFO - 2015-11-20 11:07:44,489 DEBUG : BROWSER_OUTPUT: |0;Richards;163.3453119895459 11:07:44 INFO - 2015-11-20 11:07:44,489 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.1821603312006 11:07:44 INFO - 2015-11-20 11:07:44,490 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.0567734682406 11:07:44 INFO - 2015-11-20 11:07:44,490 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 11:07:44 INFO - 2015-11-20 11:07:44,490 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1102.5358324145534 11:07:44 INFO - 2015-11-20 11:07:44,490 DEBUG : BROWSER_OUTPUT: |5;Earley;785.5459544383347 11:07:44 INFO - 2015-11-20 11:07:44,490 DEBUG : BROWSER_OUTPUT: |6;Boyer;12084.33734939759 11:07:44 INFO - 2015-11-20 11:07:44,490 DEBUG : BROWSER_OUTPUT: |7;RegExp;26894.736842105263 11:07:44 INFO - 2015-11-20 11:07:44,490 DEBUG : BROWSER_OUTPUT: |8;Splay;581.3953488372093 11:07:44 INFO - 2015-11-20 11:07:44,490 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4878.048780487805 11:07:44 INFO - 2015-11-20 11:07:44,491 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:07:44 INFO - 2015-11-20 11:07:44,491 DEBUG : BROWSER_OUTPUT: __startTimestamp1448046464486__endTimestamp 11:07:44 INFO - 2015-11-20 11:07:44,491 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,491 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:07:44 INFO - 2015-11-20 11:07:44,491 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:07:44 INFO - 2015-11-20 11:07:44,491 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,492 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.35 Median:163.35 stddev:0.00 (0.0%) 11:07:44 INFO - 2015-11-20 11:07:44,492 DEBUG : BROWSER_OUTPUT: Values: 163.3 11:07:44 INFO - 2015-11-20 11:07:44,492 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,492 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.18 Median:188.18 stddev:0.00 (0.0%) 11:07:44 INFO - 2015-11-20 11:07:44,493 DEBUG : BROWSER_OUTPUT: Values: 188.2 11:07:44 INFO - 2015-11-20 11:07:44,493 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,493 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 11:07:44 INFO - 2015-11-20 11:07:44,494 DEBUG : BROWSER_OUTPUT: Values: 281.1 11:07:44 INFO - 2015-11-20 11:07:44,494 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,494 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 11:07:44 INFO - 2015-11-20 11:07:44,494 DEBUG : BROWSER_OUTPUT: Values: 5035.2 11:07:44 INFO - 2015-11-20 11:07:44,495 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,495 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1102.54 Median:1102.54 stddev:0.00 (0.0%) 11:07:44 INFO - 2015-11-20 11:07:44,495 DEBUG : BROWSER_OUTPUT: Values: 1102.5 11:07:44 INFO - 2015-11-20 11:07:44,495 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,495 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:785.55 Median:785.55 stddev:0.00 (0.0%) 11:07:44 INFO - 2015-11-20 11:07:44,496 DEBUG : BROWSER_OUTPUT: Values: 785.5 11:07:44 INFO - 2015-11-20 11:07:44,496 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,496 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12084.34 Median:12084.34 stddev:0.00 (0.0%) 11:07:44 INFO - 2015-11-20 11:07:44,496 DEBUG : BROWSER_OUTPUT: Values: 12084.3 11:07:44 INFO - 2015-11-20 11:07:44,497 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,497 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26894.74 Median:26894.74 stddev:0.00 (0.0%) 11:07:44 INFO - 2015-11-20 11:07:44,497 DEBUG : BROWSER_OUTPUT: Values: 26894.7 11:07:44 INFO - 2015-11-20 11:07:44,497 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,497 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:581.40 Median:581.40 stddev:0.00 (0.0%) 11:07:44 INFO - 2015-11-20 11:07:44,498 DEBUG : BROWSER_OUTPUT: Values: 581.4 11:07:44 INFO - 2015-11-20 11:07:44,498 DEBUG : BROWSER_OUTPUT: 11:07:44 INFO - 2015-11-20 11:07:44,498 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4878.05 Median:4878.05 stddev:0.00 (0.0%) 11:07:44 INFO - 2015-11-20 11:07:44,498 DEBUG : BROWSER_OUTPUT: Values: 4878.0 11:07:44 INFO - 2015-11-20 11:07:44,499 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:07:44 INFO - 2015-11-20 11:07:44,499 DEBUG : BROWSER_OUTPUT: 11:07:45 INFO - 2015-11-20 11:07:45,316 INFO : Browser exited with error code: 0 11:07:45 INFO - 2015-11-20 11:07:45,330 INFO : Completed test v8_7 (00:00:39) 11:07:45 INFO - 2015-11-20 11:07:45,469 INFO : Completed test suite (00:20:12) 11:07:45 INFO - 2015-11-20 11:07:45,469 DEBUG : Working with test: dromaeo_css 11:07:45 INFO - 2015-11-20 11:07:45,470 DEBUG : Generating results file: dromaeo_css 11:07:45 INFO - 2015-11-20 11:07:45,471 DEBUG : Working with test: kraken 11:07:45 INFO - 2015-11-20 11:07:45,471 DEBUG : Generating results file: kraken 11:07:45 INFO - 2015-11-20 11:07:45,471 INFO : javascript benchmark 11:07:45 INFO - 2015-11-20 11:07:45,471 DEBUG : Working with test: v8_7 11:07:45 INFO - 2015-11-20 11:07:45,471 DEBUG : Generating results file: v8_7 11:07:45 INFO - 2015-11-20 11:07:45,472 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:07:45 INFO - 2015-11-20 11:07:45,533 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:07:45 INFO - 2015-11-20 11:07:45,533 DEBUG : process_Request line: dromaeo_css 6979.41 graph.html#tests=[[72,64,35]] 11:07:45 INFO - 2015-11-20 11:07:45,533 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:07:45 INFO - 2015-11-20 11:07:45,565 DEBUG : process_Request line: kraken 1508.00 graph.html#tests=[[232,64,35]] 11:07:45 INFO - 2015-11-20 11:07:45,565 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:07:45 INFO - 2015-11-20 11:07:45,603 DEBUG : process_Request line: v8_7 21154.88 graph.html#tests=[[230,64,35]] 11:07:45 INFO - 2015-11-20 11:07:45,604 INFO : javascript benchmark 11:07:45 INFO - 2015-11-20 11:07:45,608 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3190.505471651894, 3262.054004338742, 3298.4392653248947, 3310.6358300586917, 3329.750268729846, 5330.28041214436, 5436.048691478995, 5470.179473079035, 5475.28821253237, 5490.423505531917, 5431.538319242869, 5432.348118225808, 5450.209719590667, 5456.699881506525, 5568.1091025435935, 4962.875928101799, 4979.526944940225, 4991.900161996758, 5033.270175824503, 5104.106781313274, 288.27853121292, 4891.706497610137, 5047.369078865142, 5075.873103172414, 5086.135356989303, 4975.626827987898, 5042.0, 5047.394312682465, 5095.0064737376415, 5096.79612815487, 5045.495450454961, 5072.771725272371, 5074.010567939254, 5075.390953085616, 5123.718195499246, 4941.728204948727, 5029.597632189416, 5056.064628043824, 5063.063333283318, 5067.949320506785, 5213.947860521384, 5258.13240815265, 5275.446078161776, 5294.41761406245, 5323.0152421802095, 5960.493358064569, 5997.100434934751, 5998.580099393044, 6004.12940123684, 6011.428914253139, 5789.45000224978, 5896.734646940855, 5918.23063001807, 6033.909491357633, 6042.728077236491, 5444.537214336786, 5524.475174858382, 5571.916421253684, 5572.5263352615075, 5577.888442231133, 6062.242219722535, 6123.6486823095165, 6135.478484328793, 6136.355682653347, 6139.109829074849, 5673.517750991212, 5876.764929402776, 5947.762089516457, 5949.464548190684, 5953.1070339449425, 5811.680357580289, 5880.353161152269, 5887.793927212527, 5929.318128415288, 5969.582129250911, 5835.795747148914, 5855.882882342415, 5866.2960444746905, 5874.794382196603, 5884.0, 5743.971280143573, 5877.94122058774, 5898.8230353089475, 5899.174115623816, 5905.232319798484, 4454.443194600675, 4508.81964721414, 4524.457065152137, 4571.611413029863, 4587.288970209556, 4041.090754580196, 4046.635802777764, 4069.084455997377, 4077.327241005201, 4077.368007958771, 5447.4824891635235, 5527.944720552823, 5537.667739935617, 5538.556915446755, 5552.444755524496, 5857.062869940789, 5974.85062873423, 5978.192943952511, 5995.46040856325, 6015.819525414245, 5531.059719847635, 5543.944560554342, 5544.805931792368, 5554.750036248379, 5561.6663000220115, 5015.774290156952, 5017.473165317662, 5018.799248030111, 5031.949680503221, 5055.216441451581, 5890.14592884038, 5954.8809023819285, 6024.518038556905, 6041.395860414012, 6097.146399504073, 5974.133750606051, 5981.192539007178, 6027.909581356195, 6075.453209211192, 6078.057901025348, 6097.146399503984, 6144.723487442986, 6146.385361463997, 6146.416090471398, 6164.075388691732, 5703.458171473703, 5797.333306669787, 5828.76684932598, 5864.501517371071, 5891.23413956183, 5830.62100963436, 5917.408259174048, 5923.4076592340425, 5940.673262970578, 5964.7912323068485, 5807.216025836458, 5883.588148829712, 5885.61743486672, 5887.911681324698, 5888.646681199141, 5633.126865335879, 5707.800226992035, 5863.413658634103, 5874.383189765184, 5879.323877754113, 5686.687232202268, 5719.28508936383, 5764.135379692912, 5764.798232061858, 5821.76712931478, 5816.912746308724, 5870.412958704266, 5874.765009399747, 5874.882502350015, 5932.288125424977, 5504.972475137599, 5647.661140331593, 5725.770969161354, 5731.312242530923, 5735.025045742151], "unit": "ms", "name": "dojo.html", "value": 5417.387542140419}, {"lowerIsBetter": false, "replicates": [558.0011778915741, 586.0535235594515, 594.1740980037748, 599.4874382403043, 601.7623038899636, 31896.521552176706, 32695.836520817393, 32698.0, 32735.50896736548, 32763.0, 32452.83773581129, 40873.7956310218, 41428.792856035754, 41503.16993660125, 41545.37681934774, 8824.0, 8962.641494340218, 8965.95517022414, 8967.730968070935, 8972.8654070189, 7798.064232292133, 7984.441089123764, 8770.56147192641, 8885.4668719877, 8892.555372231394, 10859.51132199049, 11086.057685096777, 11101.000909918106, 11109.388983605899, 11118.22172447929, 10643.095336896335, 10759.977802108866, 10760.677179684622, 10768.0, 10768.569257229741, 7917.2874441300555, 8137.349012079019, 10477.947610261976, 10764.78470430587, 11041.171912106623, 40100.0, 40551.39172912409, 40641.18717625661, 40703.38944915828, 40741.796291018356, 3193.2016995751064, 3325.8004519728893, 3427.503012063262, 3699.3896007158787, 4164.104717485755, 30208.348905931383, 30377.24056898573, 30671.233219169477, 30855.537166942515, 30923.22691932697, 3826.885193444173, 3848.499695039655, 3851.268259030775, 3857.0, 3881.5536213335545, 269534.0, 270019.999999998, 270143.0, 270401.0, 270844.0, 56940.71529642325, 57619.13571296434, 57630.4236957625, 57765.0, 57818.13272800911, 62263.37736622666, 62410.0, 62417.37582624207, 62537.68731156406, 62704.0, 13121.0, 13219.206847589176, 13263.403146858414, 13267.867321326856, 13271.867281327062, 9694.321397502248, 9713.514324283757, 9715.36850104741, 9721.611135554498, 9806.068423499755, 18347.80035509957, 19497.317593884145, 19611.21555137807, 19619.0, 19662.11520481582, 7841.411894107965, 8037.23646253605, 8138.918610813935, 8188.303994160563, 8209.0, 919.5034681272039, 932.9393589416666, 1000.7548150702979, 1008.9495525223709, 1138.7267055906523, 27826.582601260998, 28055.71944280572, 28092.578611320845, 28092.578611320845, 28215.57676634852, 925.509479975614, 1039.4906495816995, 1047.2721458586361, 1067.604986155112, 1077.8167711489066, 13476.595702128952, 13680.0, 13687.384067716977, 13899.513517026855, 13981.79027314591, 284170.0, 288295.0, 288381.0, 288729.0, 315162.0, 40018.799906000866, 53931.0, 58607.70696146492, 58765.0, 58781.11828322493, 1389.1942673249491, 1396.5880065380736, 1408.619672688348, 1412.1738782811965, 1438.2736717957364, 27834.5824812632, 29163.270918227216, 31581.0, 32033.199170020936, 32772.34455310928, 49698.0, 50441.24338134858, 50519.74740126276, 50524.24213636872, 50565.0, 274345.0, 276563.0, 277224.0, 277760.0, 277831.0, 42305.57694423016, 42576.78711606546, 42784.786076069424, 42796.572034279256, 43075.13849723051, 44397.77801111103, 44655.10689786251, 45426.091478170914, 45482.09035819199, 45516.54483455256, 38316.23367532578, 38796.80601596974, 39261.214775704895, 39987.40018899777, 40052.19895602013, 38276.0, 38292.80853595714, 38625.2274954505, 39020.804895975336, 39280.21439571135, 37549.24901502009, 37558.2488350226, 37602.435963460026, 37621.0, 39937.2012559753, 33534.832325838215, 33544.0, 33981.320373592884, 34645.48031779576, 34781.826090869385, 25750.613740793528, 25879.611805823304, 26048.21855344343, 26085.0, 26353.736462635894], "unit": "ms", "name": "ext.html", "value": 18856.255436825497}, {"lowerIsBetter": false, "replicates": [332.8704661171349, 338.9186595217148, 342.7395179663455, 344.7535012466088, 345.047668435119, 13484.325783710825, 13827.585172444818, 16106.51680449587, 16150.192490375479, 16715.91642041791, 15666.216689165552, 15671.84328156718, 15754.842451575481, 15769.290381932811, 15811.604709882258, 5061.949380506203, 5295.788168473276, 5297.417284098746, 5298.36419629645, 5312.123499622558, 3812.3519001769764, 3939.9212015759667, 5247.212918062302, 5805.158252053449, 5961.970190149065, 5840.269966254218, 5859.4140585941495, 5875.706214689249, 5883.441073098049, 5892.941070589282, 5675.744591493372, 5772.884542309152, 5802.5938184327115, 5806.245188125559, 5823.5341172706085, 5118.053160165381, 5130.358705161855, 5133.922991155136, 5139.049275883974, 5148.588112950955, 19961.201551937906, 19976.600467990706, 20370.879601621906, 20448.79551204484, 20453.181872725072, 1837.5314294854861, 1958.8334991525737, 2051.6922461630725, 2071.637463443906, 2099.590579836932, 9011.819763604757, 9239.815203695889, 11011.61459348927, 12194.085443591766, 12328.691782705415, 1806.2594336322045, 1810.1220907859677, 1851.1022154255174, 1862.3574866670976, 1945.737325461073, 54696.0, 55663.44336556623, 58567.70716146392, 58752.99999999957, 58875.70562147162, 9643.807123857623, 9669.806603868024, 9671.758206044906, 9695.418274903528, 9741.707748767549, 12438.440270187863, 12462.626121216377, 12474.0, 12490.687732806753, 12531.24812511234, 7238.638068096574, 7285.089363829521, 7319.085114360705, 7325.120985481776, 7381.778546643609, 7010.509264351446, 7020.297970202939, 7067.787966361017, 7079.610621415872, 7112.324329188822, 4145.79271036453, 4164.604362585549, 4165.625093741578, 4184.91630167401, 4185.121124563876, 1675.7067513185389, 1729.4465770953175, 2807.4385122975486, 2870.5263631500984, 3028.5608586754797, 796.6932730898645, 896.0994200828126, 981.6073570571685, 985.8816941966867, 1026.2764750850633, 14913.403463861541, 17326.3069477222, 17428.215730292166, 17529.211185496428, 17872.28510859577, 851.9787005324793, 923.8429466990627, 932.1750251027754, 956.9090936361034, 985.7239972807625, 9738.951305243429, 10140.543675534618, 10173.965206958637, 10178.796424071477, 10182.694519164437, 520052.0, 539205.0, 540430.0, 557099.0, 565778.0, 75381.24618753852, 79362.60318698485, 79465.0, 80483.59758201288, 81715.0, 1141.4920360439692, 1158.2297771981707, 1162.3026184289358, 1175.2948231061466, 1178.8762179971152, 15608.453704120302, 15672.451464199154, 15824.92087539555, 15857.603559911095, 15882.841171588598, 34316.82841585776, 34540.30919381649, 34831.82584087063, 35537.0, 36083.458748118275, 40521.79739101286, 41041.45940298141, 41792.582074180085, 41866.79066604647, 42010.579894200666, 9359.064093590587, 9515.809683806423, 9534.904650953402, 9676.806463870824, 9690.515474226402, 11300.651292913211, 11324.773504529698, 13771.104878182887, 14716.264186790404, 18063.0, 12806.35968201605, 13952.302384880919, 14133.222672753098, 14327.78508322397, 14537.41850325975, 13741.725165496833, 13982.0, 14323.427062917366, 14355.85644143587, 14658.19379934114, 14925.0, 15257.237138142826, 15458.072515649097, 15468.381264749283, 15558.299876505358, 8917.464952102895, 9105.726828195166, 9248.213901818151, 9255.398399104037, 9689.0, 14070.296485175904, 14073.155610663393, 14380.35288412003, 14514.564563063124, 14583.343749531085], "unit": "ms", "name": "jquery.html", "value": 8798.699052888927}, {"lowerIsBetter": false, "replicates": [1355.8372995240572, 1712.246611490944, 1761.339497688367, 1772.5923037701325, 1784.6252287019724, 6847.931520684791, 7442.33019028288, 7541.283578060089, 7550.16948135706, 7553.546787192772, 7374.041374621292, 7618.885716714254, 7630.809229769245, 7636.732714354998, 7640.847183056336, 1996.9900150499227, 2041.6937459381063, 2226.2319499772634, 2283.885805709712, 2304.8501847379866, 2288.2105673542683, 2304.4008557774932, 2307.238611258289, 2310.249169020067, 2311.526137141882, 2245.696830927828, 2305.527366889792, 2306.942326441844, 2310.318456055459, 2312.583734927712, 2015.9697604535943, 2059.1145807302855, 2210.668399740036, 2254.8083412909923, 2258.446680563256, 2252.1329288223988, 2271.034810205656, 2297.414159389362, 2298.9999350282515, 2299.5171014087064, 7648.770536883902, 7701.345385642171, 7704.8844267336035, 7710.537367757953, 7716.575588342639, 4605.194091034055, 4684.344191813149, 4695.483496815347, 4709.764511774398, 4711.952880471185, 2995.7303842654046, 3026.6670666226696, 3063.908082757521, 3065.509518477033, 3146.9055928322186, 1003.372891942536, 1004.1013293102632, 1006.2352612014921, 1047.3401756893186, 1048.7063622185801, 10226.23303252259, 10320.329178603366, 10323.277370584137, 10340.37957722539, 10354.53404596795, 4092.0, 4144.44050053245, 4203.894902627398, 4219.029623186684, 4255.404243405926, 8567.443116197428, 8576.142385761374, 8592.5703714814, 8592.914070859337, 8593.52735599548, 4642.582167604932, 4671.182543054952, 4673.322368256584, 4673.766311684402, 4683.414573178353, 4252.808623611945, 4297.226499230169, 4298.656107511391, 4300.978495107504, 4306.332518459643, 3414.590249170066, 3462.7576069674883, 3473.4442489201606, 3474.3051389722154, 3488.389531831919, 1032.9276950613535, 1049.7742985258205, 1052.952617132231, 1079.2607064161075, 1079.83262594298, 1273.6561128495255, 1274.0253705914984, 1282.9743405131844, 1286.3053950866426, 1295.3846922711637, 6854.417374523221, 6918.273581273894, 6933.306669333027, 6945.444364450832, 6962.373386395248, 499.5728652002558, 502.7461132128252, 503.3531911493713, 506.06630766236236, 506.8631469503213, 5346.278252435949, 5507.614466987353, 5559.916601250903, 5639.351474580394, 5665.3768085510565, 9135.634574617074, 9202.723918282461, 9316.813663726824, 9330.300227482965, 9334.39326443779, 8799.428037177562, 9097.0, 9105.590248438835, 9197.678081267124, 9200.401973871676, 7016.894746578805, 7137.2149063602965, 7221.927780722125, 7224.4581656375985, 7225.783226503213, 6458.128152699325, 6506.934930650633, 6566.376194261537, 6576.704048317742, 6609.867802644017, 7897.13131555517, 7964.084130325086, 8056.395770317366, 8089.393295502979, 8177.05963814169, 8126.349892008743, 8270.0, 8294.170582941657, 8396.328293736364, 8409.495430274203, 6434.613923164625, 6533.575317604341, 6542.018697195459, 6544.3782840630065, 6549.869002619826, 7412.147603025721, 7486.625668716433, 7489.363404110712, 7497.250274972459, 7499.550026998398, 6727.078626579569, 6927.134108236471, 6937.410320122846, 7009.2990700929495, 7094.574325540484, 6158.630482171084, 6415.390537898892, 6514.967425162844, 6757.45940324763, 6780.288069752803, 5751.281089863767, 5767.971160144172, 5776.277965254343, 5776.624519406225, 5781.219535362672, 5978.730957107027, 6266.68666566679, 6288.622682639057, 6293.024581189923, 6298.874022519432, 6131.4481696645735, 6179.28938172116, 6179.412955769195, 6182.938170618237, 6188.133661287513], "unit": "ms", "name": "mootools.html", "value": 4276.189510544308}, {"lowerIsBetter": false, "replicates": [323.5454186867451, 328.41378140020066, 330.433306878703, 333.1404975164076, 336.5439829031662, 5967.582269241155, 6106.694665266741, 6156.599821011637, 6171.382861713826, 6171.845703857394, 5969.701514924258, 6062.120992456091, 6078.756849726016, 6110.266767987837, 6122.173506576611, 4694.4366675998845, 4700.9892873032295, 4702.459217190016, 4703.482616912137, 4707.129181101507, 4447.799849006802, 4510.887227819314, 4593.954060459386, 4661.720296782204, 4708.0113176233035, 4596.563326483995, 4604.102200070971, 4605.0, 4613.261878099504, 4626.398568186131, 4665.5567721066445, 4671.065786842645, 4678.836240731592, 4685.5314468553215, 4688.953110468886, 4114.629683328485, 4118.052847845012, 4131.277026520377, 4134.607212314825, 4138.461999939988, 5650.0959846424375, 5763.740631671585, 5769.365369809318, 5770.624909380919, 5779.595428320019, 5470.863228419282, 5475.06923822951, 5477.3427188737605, 5482.91775623366, 5485.0949593317055, 6225.564210505267, 6441.033844923252, 6442.742290308382, 6449.645269510175, 6461.547691661585, 4489.326601009842, 4490.977545112286, 4582.495925448198, 4582.6104781093645, 4585.3122031695175, 6679.1317128773435, 6685.632290224035, 6696.732130714766, 6699.799006029827, 6721.966390168018, 4608.423947006624, 4612.677112602153, 4620.168369693421, 4622.791974361162, 4624.075184963021, 4601.769911504478, 4685.109829132454, 4703.341532185496, 4705.788239529229, 4743.098811225925, 5432.6468779529205, 5451.863703407446, 5452.482014208644, 5454.318210223722, 5456.563474921997, 6511.15355003856, 6516.348365163446, 6518.739250430024, 6519.282878883319, 6550.967245163839, 1657.3039323483924, 1693.6866679664302, 1694.3984885365765, 1695.7286834106483, 1696.6097797506395, 1049.6850944716555, 1066.4855904615465, 1071.8124328242527, 1074.398336931321, 1117.1509652664033, 6048.60684055535, 6125.326214116443, 6129.969350153221, 6132.478739307119, 6135.0, 6502.6098434093155, 6613.60318380889, 6619.669016549154, 6625.3043430440075, 6652.534322597372, 6105.664188469588, 6110.633361998294, 6118.296395914527, 6123.663198524035, 6138.324784273726, 3575.1419659281587, 3605.260921511084, 3609.242059167552, 3614.3855544557487, 3614.620464851153, 6763.864722705518, 6833.077534532775, 6909.481788865855, 6914.965425172943, 6916.55042422241, 6890.276520965226, 6893.20728116263, 7011.509194356346, 7017.157941047005, 7023.157221133497, 6967.338102880219, 7014.123234595676, 7017.228104908558, 7020.648967551602, 7028.753993610301, 6439.259485159267, 6561.245456772342, 6618.404343609098, 6643.169603799525, 6747.089142965637, 6716.261211266855, 6739.797806065826, 6742.0, 6755.628440435823, 6756.054152418567, 6955.095837541289, 6990.650467476504, 6990.965045174741, 6997.440204783707, 7004.334588214111, 4502.7138219038625, 4536.818527259004, 4568.634509239187, 4596.195665758546, 4598.632109431171, 6739.157605299338, 6770.187577490733, 6771.559848609824, 6773.356531129535, 6776.830579235559, 6543.345665433419, 6549.967250163719, 6579.769708060195, 6584.374484423972, 6601.570897891622, 6427.132337134427, 6478.708458119301, 6549.0, 6579.769708060195, 6598.0, 6456.12842266288, 6465.127207826883, 6478.967605161944, 6480.833449979049, 6486.156799616019, 6617.536772426077, 6621.271660117287, 6628.933710662832, 6633.734650614115, 6636.535442518977, 6252.406021427957, 6433.035044743326, 6433.2601750797385, 6434.356564343529, 6438.163038804925], "unit": "ms", "name": "prototype.html", "value": 4895.958498399163}, {"lowerIsBetter": false, "replicates": [731.8353370491639, 740.5038624121838, 755.090116409726, 776.8990031295931, 840.5251033166261, 12151.878481215184, 12250.877491225085, 12285.63143105706, 12335.938320308385, 12378.752424951517, 11454.48454819533, 11570.65288041358, 13517.662058448544, 13737.381817818197, 13954.372053257628, 689.4277749467955, 817.146082343952, 831.6340810043591, 832.138736407818, 832.5504227717025, 693.3309356471004, 823.1028179284579, 833.9958300208491, 834.228338786623, 836.1721895323616, 859.9312055035582, 871.6164887449534, 872.8821609082788, 873.166126349338, 873.2141073034288, 714.5783987447431, 719.0903507063568, 837.4723923927947, 858.7552547523957, 860.4149178558578, 623.6351734235477, 626.545754328113, 627.0969803482969, 627.1408170806025, 627.2410383436048, 12283.447244873912, 12372.566960156351, 12401.0, 12440.94251988582, 12441.502339906392, 11922.284662920252, 11934.16460847741, 11990.0, 12656.936715316457, 12938.223706577635, 9967.252456065824, 9979.501024948724, 10071.69784906454, 10205.693829185137, 10520.053195212467, 3522.1370764162943, 3572.624874388204, 3574.696150827183, 3581.71346292296, 3697.2605478904056, 49295.75352123217, 49869.50130498685, 49883.0, 49901.25148122781, 49925.25112123321, 9388.530573471298, 9531.428114313163, 9553.856692149624, 9576.712698619052, 9740.512974351253, 17537.0, 17542.824571754376, 17544.210510527057, 17558.64882702339, 17593.912030439766, 6967.372936435644, 7129.750458733919, 7232.63836808168, 7323.853522929511, 7470.514416562906, 4092.590740925943, 4129.587041295847, 4141.799952255906, 4184.435101261291, 4228.260054490452, 3020.7432368248506, 3068.1715936697415, 3070.293832418556, 3073.9077827665205, 3075.2311922019494, 537.4222710586135, 543.4972650298458, 555.8138023762085, 557.6876948908624, 558.0, 644.1658052821514, 669.2972379002126, 673.5619452469014, 683.1528904158807, 691.9411849992706, 7963.203679632106, 8192.836143277102, 8344.165583441607, 8345.165483451729, 8402.117777633383, 508.6591983371076, 542.3302221756128, 560.6860158311358, 622.539320902538, 636.4113195294427, 3624.2751449709635, 3878.8642397516514, 3899.688024958053, 3958.6635136013188, 4086.9182616347507, 57027.718891244716, 57097.429025710044, 57491.712541437024, 57848.71075644679, 58509.122363164584, 49983.25025124626, 51100.0, 51115.488845111075, 51127.23309150366, 51286.230706539434, 45967.0, 46632.7668361656, 46642.766786165856, 46917.0, 46946.0, 8234.0, 8384.706535271236, 8391.748247552583, 8465.91534084676, 8507.276881465144, 33681.15797105092, 33736.49395259122, 34267.0, 35072.824635876656, 35180.64819351876, 42692.78653606712, 44435.0, 46522.0, 46651.0, 47292.52707472881, 9735.659251926148, 9775.413475191226, 10228.437435941094, 10467.842982355423, 10601.787964240517, 11670.124740644655, 11783.646490605295, 11810.114241431755, 11831.230969986924, 11887.28676279426, 10255.7436064099, 10395.480225988822, 10670.946645266724, 10789.942289371395, 10870.510827012646, 10414.895851041392, 10884.891151088388, 11050.281731687415, 11147.55409783632, 11176.0, 10538.262321637718, 10728.302660327054, 10956.671299861016, 11179.66461006171, 11280.2667826591, 9482.857757133786, 9604.519774011133, 9709.9029009709, 9888.456134912649, 9915.801683966425, 8518.446300990416, 8876.720511735673, 8930.240929521064, 9418.858509200583, 9565.378250413702], "unit": "ms", "name": "yui.html", "value": 6142.071617832055}], "name": "dromaeo_css", "value": 6979.413403825579}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 108.0, 103.0, 108.0, 110.0, 111.0, 98.0, 108.0, 108.0, 107.0], "unit": "ms", "name": "ai-astar", "value": 106.9}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 151.0, 163.0, 132.0, 151.0, 154.0, 124.0, 172.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [161.0, 165.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 84.0, 83.0, 97.0, 71.0, 73.0, 72.0, 98.0, 94.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 137.0, 90.0, 90.0, 89.0, 132.0, 91.0, 90.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 104.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 146.0, 148.0, 149.0, 148.0, 147.0, 148.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 61.0, 68.0, 57.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 70.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 84.0, 85.0, 84.0, 84.0, 84.0, 92.0, 95.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [117.0, 130.0, 121.0, 115.0, 119.0, 117.0, 122.0, 124.0, 123.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [152.0, 153.0, 163.0, 156.0, 157.0, 144.0, 152.0, 151.0, 165.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 153.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 70.0, 68.0, 67.0, 66.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1508.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.3453119895459], "unit": "score", "name": "Richards", "value": 216.118844}, {"lowerIsBetter": false, "replicates": [188.1821603312006], "unit": "score", "name": "DeltaBlue", "value": 351.351052}, {"lowerIsBetter": false, "replicates": [281.0567734682406], "unit": "score", "name": "Encrypt", "value": 947.0719979999998}, {"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": [785.5459544383347], "unit": "score", "name": "Earley", "value": 848.4073989999999}, {"lowerIsBetter": false, "replicates": [12084.33734939759], "unit": "score", "name": "Boyer", "value": 55.150976071784655}, {"lowerIsBetter": false, "replicates": [26894.736842105263], "unit": "score", "name": "RegExp", "value": 33.87224070450098}, {"lowerIsBetter": false, "replicates": [581.3953488372093], "unit": "score", "name": "Splay", "value": 140.16451999999995}, {"lowerIsBetter": false, "replicates": [4878.048780487805], "unit": "score", "name": "NavierStokes", "value": 304.2200000000002}], "name": "v8_7", "value": 21154.87836846127}]} 11:07:45 INFO - RETURN: dromaeo_css: 6979.41 11:07:45 INFO - RETURN: kraken: 1508.00 11:07:45 INFO - RETURN: v8_7: 21154.88 11:07:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "21154.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1508.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6979.41"}}} 11:07:45 INFO - Return code: 0 11:07:45 INFO - # TBPL SUCCESS # 11:07:45 INFO - Running post-action listener: _resource_record_post_action 11:07:45 INFO - Running post-run listener: _resource_record_post_run 11:07:46 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519729152; Read time: 20; Write time: 524152 11:07:46 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 235958272; Read time: 0; Write time: 358344 11:07:46 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281591808; Read time: 20; Write time: 163348 11:07:46 INFO - Running post-run listener: _upload_blobber_files 11:07:46 INFO - Blob upload gear active. 11:07:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:07:46 INFO - Copying logs to upload dir... 11:07:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.915597 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-20 11:07:46.842050) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 11:07:46.845158) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009957 build_url: 'https://queue.taskcluster.net/v1/task/Du_MZj_WS3WcA5-230WF5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 11:07:46.867754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:07:46.868046) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1448043474.411506-941657307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004633 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:07:46.917238) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 11:07:46.917571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 11:07:46.917862) ========= ========= Total master_lag: 0.48 =========