builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1447548815.95 results: success (0) buildid: 20151114143008 builduid: eb124b300ac3443ca06b651e336de8b4 revision: 41b5c629c4a00f41b9b85a4521cf62a726bf4c7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:35.950094) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:35.950502) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:35.950810) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006474 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:35.995932) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:35.996220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.015397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.015805) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004819 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.069463) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.069746) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.070092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.070363) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-14 16:53:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 78.7M=0s 2015-11-14 16:53:37 (78.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188173 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.271174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.271491) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019392 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.320623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.320981) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 41b5c629c4a00f41b9b85a4521cf62a726bf4c7f --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 41b5c629c4a00f41b9b85a4521cf62a726bf4c7f --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=0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-14 16:53:37,382 truncating revision to first 12 chars 2015-11-14 16:53:37,382 Setting DEBUG logging. 2015-11-14 16:53:37,382 attempt 1/10 2015-11-14 16:53:37,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/41b5c629c4a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 16:53:37,631 unpacking tar archive at: fx-team-41b5c629c4a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517769 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.851449) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.851774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.864586) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.865078) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 16:53:36.865676) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-14 16:53:36.866029) ========= /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=0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:53:38 INFO - MultiFileLogger online at 20151114 16:53:38 in /builds/slave/test-pgo 16:53:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:53:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:53:38 INFO - {'append_to_log': False, 16:53:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:53:38 INFO - 'blob_upload_branch': 'Fx-Team', 16:53:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:53:38 INFO - 'branch': 'Fx-Team', 16:53:38 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:38 INFO - 'config_files': ('talos/linux_config.py',), 16:53:38 INFO - 'default_actions': ('clobber', 16:53:38 INFO - 'read-buildbot-config', 16:53:38 INFO - 'download-and-extract', 16:53:38 INFO - 'populate-webroot', 16:53:38 INFO - 'create-virtualenv', 16:53:38 INFO - 'install', 16:53:38 INFO - 'run-tests'), 16:53:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:38 INFO - 'download_minidump_stackwalk': True, 16:53:38 INFO - 'download_symbols': 'ondemand', 16:53:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:53:38 INFO - 'tooltool.py': '/tools/tooltool.py', 16:53:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:53:38 INFO - '/tools/misc-python/virtualenv.py')}, 16:53:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:38 INFO - 'installer_path': 'installer.exe', 16:53:38 INFO - 'log_level': 'info', 16:53:38 INFO - 'log_name': 'talos', 16:53:38 INFO - 'log_to_console': True, 16:53:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:53:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:53:38 INFO - 'opt_config_files': (), 16:53:38 INFO - 'pip_index': False, 16:53:38 INFO - 'sps_profile': False, 16:53:38 INFO - 'sps_profile_interval': 0, 16:53:38 INFO - 'suite': 'dromaeojs', 16:53:38 INFO - 'system_bits': '64', 16:53:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:38 INFO - 'title': 'talos-linux64-ix-035', 16:53:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:38 INFO - 'use_talos_json': True, 16:53:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:53:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:38 INFO - 'work_dir': 'build'} 16:53:38 INFO - ##### 16:53:38 INFO - ##### Running clobber step. 16:53:38 INFO - ##### 16:53:38 INFO - Running pre-action listener: _resource_record_pre_action 16:53:38 INFO - Running main action method: clobber 16:53:38 INFO - rmtree: /builds/slave/test-pgo/build 16:53:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:53:38 INFO - Running post-action listener: _resource_record_post_action 16:53:38 INFO - ##### 16:53:38 INFO - ##### Running read-buildbot-config step. 16:53:38 INFO - ##### 16:53:38 INFO - Running pre-action listener: _resource_record_pre_action 16:53:38 INFO - Running main action method: read_buildbot_config 16:53:38 INFO - Using buildbot properties: 16:53:38 INFO - { 16:53:38 INFO - "properties": { 16:53:38 INFO - "buildnumber": 781, 16:53:38 INFO - "product": "firefox", 16:53:38 INFO - "script_repo_revision": "production", 16:53:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:53:38 INFO - "repository": "", 16:53:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:53:38 INFO - "buildid": "20151114143008", 16:53:38 INFO - "slavename": "talos-linux64-ix-035", 16:53:38 INFO - "pgo_build": "True", 16:53:38 INFO - "basedir": "/builds/slave/test-pgo", 16:53:38 INFO - "project": "", 16:53:38 INFO - "platform": "ubuntu64_hw", 16:53:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:53:38 INFO - "slavebuilddir": "test", 16:53:38 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:53:38 INFO - "branch": "fx-team", 16:53:38 INFO - "repo_path": "integration/fx-team", 16:53:38 INFO - "stage_platform": "linux64-pgo", 16:53:38 INFO - "builduid": "eb124b300ac3443ca06b651e336de8b4", 16:53:38 INFO - "revision": "41b5c629c4a00f41b9b85a4521cf62a726bf4c7f" 16:53:38 INFO - }, 16:53:38 INFO - "sourcestamp": { 16:53:38 INFO - "repository": "", 16:53:38 INFO - "hasPatch": false, 16:53:38 INFO - "project": "", 16:53:38 INFO - "branch": "fx-team-linux64-pgo-talos", 16:53:38 INFO - "changes": [ 16:53:38 INFO - { 16:53:38 INFO - "category": null, 16:53:38 INFO - "files": [ 16:53:38 INFO - { 16:53:38 INFO - "url": null, 16:53:38 INFO - "name": "https://queue.taskcluster.net/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:53:38 INFO - } 16:53:38 INFO - ], 16:53:38 INFO - "repository": "", 16:53:38 INFO - "rev": "41b5c629c4a00f41b9b85a4521cf62a726bf4c7f", 16:53:38 INFO - "who": "sendchange", 16:53:38 INFO - "when": 1447548777, 16:53:38 INFO - "number": 6662867, 16:53:38 INFO - "comments": "", 16:53:38 INFO - "project": "", 16:53:38 INFO - "at": "Sat 14 Nov 2015 16:52:57", 16:53:38 INFO - "branch": "fx-team-linux64-pgo-talos", 16:53:38 INFO - "revlink": "", 16:53:38 INFO - "properties": [ 16:53:38 INFO - [ 16:53:38 INFO - "buildid", 16:53:38 INFO - "20151114143008", 16:53:38 INFO - "Change" 16:53:38 INFO - ], 16:53:38 INFO - [ 16:53:38 INFO - "builduid", 16:53:38 INFO - "eb124b300ac3443ca06b651e336de8b4", 16:53:38 INFO - "Change" 16:53:38 INFO - ], 16:53:38 INFO - [ 16:53:38 INFO - "pgo_build", 16:53:38 INFO - "True", 16:53:38 INFO - "Change" 16:53:38 INFO - ] 16:53:38 INFO - ], 16:53:38 INFO - "revision": "41b5c629c4a00f41b9b85a4521cf62a726bf4c7f" 16:53:38 INFO - } 16:53:38 INFO - ], 16:53:38 INFO - "revision": "41b5c629c4a00f41b9b85a4521cf62a726bf4c7f" 16:53:38 INFO - } 16:53:38 INFO - } 16:53:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:53:38 INFO - Running post-action listener: _resource_record_post_action 16:53:38 INFO - ##### 16:53:38 INFO - ##### Running download-and-extract step. 16:53:38 INFO - ##### 16:53:38 INFO - Running pre-action listener: _resource_record_pre_action 16:53:38 INFO - Running main action method: download_and_extract 16:53:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:38 INFO - https://queue.taskcluster.net/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:53:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/test_packages.json 16:53:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/test_packages.json 16:53:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:53:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:53:47 INFO - Downloaded 1302 bytes. 16:53:47 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:53:47 INFO - Using the following test package requirements: 16:53:47 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:53:47 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:53:47 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:47 INFO - u'jsshell-linux-x86_64.zip'], 16:53:47 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:53:47 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:53:47 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:53:47 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:53:47 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:53:47 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:53:47 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:53:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:53:47 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')]} 16:53:47 INFO - https://queue.taskcluster.net/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:53:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:53:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:53:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/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 16:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/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 16:53:48 INFO - Downloaded 22462188 bytes. 16:53:48 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 16:53:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:53:48 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 16:53:49 INFO - Return code: 0 16:53:49 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 16:53:49 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')]} 16:53:49 INFO - https://queue.taskcluster.net/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:53:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:53:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:53:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/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 16:53:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/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 16:54:01 INFO - Downloaded 22462188 bytes. 16:54:01 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 16:54:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:54:01 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 16:54:02 INFO - Return code: 0 16:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:02 INFO - https://queue.taskcluster.net/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:54:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:54:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:54:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/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 16:54:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/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 16:54:03 INFO - Downloaded 11131693 bytes. 16:54:03 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 16:54:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:54:03 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 16:54:03 INFO - Return code: 0 16:54: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')]} 16:54:03 INFO - https://queue.taskcluster.net/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:54:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:54:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:54:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/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 16:54:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WAwNXHoWSzGeCsxh9zM48Q/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 16:54:06 INFO - Downloaded 57128522 bytes. 16:54:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:54:06 INFO - mkdir: /builds/slave/test-pgo/properties 16:54:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:54:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:54:06 INFO - Contents: 16:54:06 INFO - build_url:https://queue.taskcluster.net/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:54:06 INFO - Running post-action listener: _resource_record_post_action 16:54:06 INFO - Running post-action listener: set_extra_try_arguments 16:54:06 INFO - ##### 16:54:06 INFO - ##### Running populate-webroot step. 16:54:06 INFO - ##### 16:54:06 INFO - Running pre-action listener: _resource_record_pre_action 16:54:06 INFO - Running main action method: populate_webroot 16:54:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:54:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:54:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:54:06 INFO - '../fennec_ids.txt'], 16:54:06 INFO - 'tests': ['tcheck2']}, 16:54:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:54:06 INFO - '--tppagecycles', 16:54:06 INFO - '7'], 16:54:06 INFO - 'tests': ['tsvgm']}}, 16:54:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:54:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:54:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:54:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:54:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:54:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:54:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:06 INFO - 'talos_options': ['--e10s'], 16:54:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:06 INFO - 'tests': ['damp', 'tps']}, 16:54:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:06 INFO - 'talos_options': ['--e10s'], 16:54:06 INFO - 'tests': ['damp', 'tps']}, 16:54:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:54:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:54:06 INFO - 'other': {'tests': ['a11yr', 16:54:06 INFO - 'ts_paint', 16:54:06 INFO - 'tpaint', 16:54:06 INFO - 'sessionrestore', 16:54:06 INFO - 'sessionrestore_no_auto_restore']}, 16:54:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:54:06 INFO - 'tests': ['a11yr', 16:54:06 INFO - 'ts_paint', 16:54:06 INFO - 'tpaint', 16:54:06 INFO - 'sessionrestore', 16:54:06 INFO - 'sessionrestore_no_auto_restore']}, 16:54:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:54:06 INFO - 'tests': ['a11yr', 16:54:06 INFO - 'ts_paint', 16:54:06 INFO - 'tpaint', 16:54:06 INFO - 'sessionrestore', 16:54:06 INFO - 'sessionrestore_no_auto_restore']}, 16:54:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:54:06 INFO - 'tests': ['a11yr', 16:54:06 INFO - 'ts_paint', 16:54:06 INFO - 'tpaint', 16:54:06 INFO - 'sessionrestore', 16:54:06 INFO - 'sessionrestore_no_auto_restore']}, 16:54:06 INFO - 'other_l64': {'tests': ['a11yr', 16:54:06 INFO - 'ts_paint', 16:54:06 INFO - 'tpaint', 16:54:06 INFO - 'sessionrestore', 16:54:06 INFO - 'sessionrestore_no_auto_restore']}, 16:54:06 INFO - 'other_nol64': {'tests': ['a11yr', 16:54:06 INFO - 'ts_paint', 16:54:06 INFO - 'tpaint', 16:54:06 INFO - 'sessionrestore', 16:54:06 INFO - 'sessionrestore_no_auto_restore']}, 16:54:06 INFO - 'svgr': {'tests': ['tsvgx', 16:54:06 INFO - 'tsvgr_opacity', 16:54:06 INFO - 'tart', 16:54:06 INFO - 'tscrollx', 16:54:06 INFO - 'cart']}, 16:54:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:54:06 INFO - 'tests': ['tsvgx', 16:54:06 INFO - 'tsvgr_opacity', 16:54:06 INFO - 'tart', 16:54:06 INFO - 'tscrollx', 16:54:06 INFO - 'cart']}, 16:54:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:06 INFO - 'tests': ['tp5o']}, 16:54:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:06 INFO - 'talos_options': ['--e10s'], 16:54:06 INFO - 'tests': ['tp5o']}, 16:54:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:06 INFO - 'talos_options': ['--xperf_path', 16:54:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:06 INFO - 'tests': ['tp5n']}, 16:54:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:06 INFO - 'talos_options': ['--e10s', 16:54:06 INFO - '--xperf_path', 16:54:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:06 INFO - 'tests': ['tp5n']}}, 16:54:06 INFO - 'talos.zip': {'path': '', 16:54:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:54:06 INFO - Running post-action listener: _resource_record_post_action 16:54:06 INFO - ##### 16:54:06 INFO - ##### Running create-virtualenv step. 16:54:06 INFO - ##### 16:54:06 INFO - Running pre-action listener: _resource_record_pre_action 16:54:06 INFO - Running main action method: create_virtualenv 16:54:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:54:06 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 16:54:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:54:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:54:06 INFO - Using real prefix '/usr' 16:54:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:54:06 INFO - Installing distribute.............................................................................................................................................................................................done. 16:54:08 INFO - Installing pip.................done. 16:54:08 INFO - Return code: 0 16:54:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:54: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')]} 16:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3de0922c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e7a90>, '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 0x2839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a2e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', '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 16:54: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:54: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 pip>=1.5 16:54:08 INFO - Using env: {'DISPLAY': ':0', 16:54:08 INFO - 'HOME': '/home/cltbld', 16:54:08 INFO - 'LANG': 'en_US.UTF-8', 16:54:08 INFO - 'LANGUAGE': 'en_US:en', 16:54:08 INFO - 'LOGNAME': 'cltbld', 16:54:08 INFO - 'MAIL': '/var/mail/cltbld', 16:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:08 INFO - 'MOZ_NO_REMOTE': '1', 16:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:08 INFO - 'NO_EM_RESTART': '1', 16:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:08 INFO - 'SHELL': '/bin/bash', 16:54:08 INFO - 'SHLVL': '1', 16:54:08 INFO - 'TERM': 'linux', 16:54:08 INFO - 'TMOUT': '86400', 16:54:08 INFO - 'USER': 'cltbld', 16:54:08 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', 16:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:08 INFO - '_': '/tools/buildbot/bin/python'} 16:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:08 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 16:54:08 INFO - Cleaning up... 16:54:09 INFO - Return code: 0 16:54:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3de0922c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e7a90>, '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 0x2839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a2e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', '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 16:54:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:54:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:54:09 INFO - Using env: {'DISPLAY': ':0', 16:54:09 INFO - 'HOME': '/home/cltbld', 16:54:09 INFO - 'LANG': 'en_US.UTF-8', 16:54:09 INFO - 'LANGUAGE': 'en_US:en', 16:54:09 INFO - 'LOGNAME': 'cltbld', 16:54:09 INFO - 'MAIL': '/var/mail/cltbld', 16:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:09 INFO - 'MOZ_NO_REMOTE': '1', 16:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:09 INFO - 'NO_EM_RESTART': '1', 16:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:09 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:09 INFO - 'SHELL': '/bin/bash', 16:54:09 INFO - 'SHLVL': '1', 16:54:09 INFO - 'TERM': 'linux', 16:54:09 INFO - 'TMOUT': '86400', 16:54:09 INFO - 'USER': 'cltbld', 16:54:09 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', 16:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:09 INFO - '_': '/tools/buildbot/bin/python'} 16:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:09 INFO - Downloading/unpacking psutil>=0.7.1 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:10 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:54:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:54:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:54:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:11 INFO - Installing collected packages: psutil 16:54:11 INFO - Running setup.py install for psutil 16:54:11 INFO - building 'psutil._psutil_linux' extension 16:54:11 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 16:54:11 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 16:54:11 INFO - building 'psutil._psutil_posix' extension 16:54:11 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 16:54:11 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 16:54:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:11 INFO - Successfully installed psutil 16:54:11 INFO - Cleaning up... 16:54:11 INFO - Return code: 0 16:54:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:54: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')]} 16:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3de0922c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e7a90>, '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 0x2839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a2e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', '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 16:54:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:54:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:54:11 INFO - Using env: {'DISPLAY': ':0', 16:54:11 INFO - 'HOME': '/home/cltbld', 16:54:11 INFO - 'LANG': 'en_US.UTF-8', 16:54:11 INFO - 'LANGUAGE': 'en_US:en', 16:54:11 INFO - 'LOGNAME': 'cltbld', 16:54:11 INFO - 'MAIL': '/var/mail/cltbld', 16:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:11 INFO - 'MOZ_NO_REMOTE': '1', 16:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:11 INFO - 'NO_EM_RESTART': '1', 16:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:11 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:11 INFO - 'SHELL': '/bin/bash', 16:54:11 INFO - 'SHLVL': '1', 16:54:11 INFO - 'TERM': 'linux', 16:54:11 INFO - 'TMOUT': '86400', 16:54:11 INFO - 'USER': 'cltbld', 16:54:11 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', 16:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:11 INFO - '_': '/tools/buildbot/bin/python'} 16:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:54:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:54:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:54:13 INFO - Installing collected packages: mozsystemmonitor 16:54:13 INFO - Running setup.py install for mozsystemmonitor 16:54:13 INFO - Successfully installed mozsystemmonitor 16:54:13 INFO - Cleaning up... 16:54:13 INFO - Return code: 0 16:54:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3de0922c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e7a90>, '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 0x2839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a2e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', '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 16:54:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:54:13 INFO - Using env: {'DISPLAY': ':0', 16:54:13 INFO - 'HOME': '/home/cltbld', 16:54:13 INFO - 'LANG': 'en_US.UTF-8', 16:54:13 INFO - 'LANGUAGE': 'en_US:en', 16:54:13 INFO - 'LOGNAME': 'cltbld', 16:54:13 INFO - 'MAIL': '/var/mail/cltbld', 16:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:13 INFO - 'MOZ_NO_REMOTE': '1', 16:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:13 INFO - 'NO_EM_RESTART': '1', 16:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:13 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:13 INFO - 'SHELL': '/bin/bash', 16:54:13 INFO - 'SHLVL': '1', 16:54:13 INFO - 'TERM': 'linux', 16:54:13 INFO - 'TMOUT': '86400', 16:54:13 INFO - 'USER': 'cltbld', 16:54:13 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', 16:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:13 INFO - '_': '/tools/buildbot/bin/python'} 16:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:13 INFO - Downloading/unpacking blobuploader==1.2.4 16:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:15 INFO - Downloading blobuploader-1.2.4.tar.gz 16:54:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:54:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:54:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:54:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:54:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:16 INFO - Downloading docopt-0.6.1.tar.gz 16:54:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:54:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:54:16 INFO - Installing collected packages: blobuploader, requests, docopt 16:54:16 INFO - Running setup.py install for blobuploader 16:54:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:54:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:54:16 INFO - Running setup.py install for requests 16:54:16 INFO - Running setup.py install for docopt 16:54:16 INFO - Successfully installed blobuploader requests docopt 16:54:16 INFO - Cleaning up... 16:54:16 INFO - Return code: 0 16:54:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:16 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 0x7f3de0922c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e7a90>, '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 0x2839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a2e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', '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 16:54:16 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 16:54:16 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 16:54:16 INFO - Using env: {'DISPLAY': ':0', 16:54:16 INFO - 'HOME': '/home/cltbld', 16:54:16 INFO - 'LANG': 'en_US.UTF-8', 16:54:16 INFO - 'LANGUAGE': 'en_US:en', 16:54:16 INFO - 'LOGNAME': 'cltbld', 16:54:16 INFO - 'MAIL': '/var/mail/cltbld', 16:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:16 INFO - 'MOZ_NO_REMOTE': '1', 16:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:16 INFO - 'NO_EM_RESTART': '1', 16:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:16 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:16 INFO - 'SHELL': '/bin/bash', 16:54:16 INFO - 'SHLVL': '1', 16:54:16 INFO - 'TERM': 'linux', 16:54:16 INFO - 'TMOUT': '86400', 16:54:16 INFO - 'USER': 'cltbld', 16:54:16 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', 16:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:16 INFO - '_': '/tools/buildbot/bin/python'} 16:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:54:17 INFO - Running setup.py (path:/tmp/pip-ULQWhK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:54:17 INFO - Running setup.py (path:/tmp/pip-5y2ZTL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:54:17 INFO - Running setup.py (path:/tmp/pip-QsoIkJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:54:17 INFO - Running setup.py (path:/tmp/pip-9GfHNH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:54:17 INFO - Running setup.py (path:/tmp/pip-2BLgn7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:54:17 INFO - Running setup.py (path:/tmp/pip-VSRznu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:54:17 INFO - Running setup.py (path:/tmp/pip-XAmWjR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:54:17 INFO - Running setup.py (path:/tmp/pip-LRfXjI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:54:17 INFO - Running setup.py (path:/tmp/pip-x1kGMt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:54:17 INFO - Running setup.py (path:/tmp/pip-kVQniB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:54:17 INFO - Running setup.py (path:/tmp/pip-K5cKms-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:54:17 INFO - Running setup.py (path:/tmp/pip-lUS7K4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:54:17 INFO - Running setup.py (path:/tmp/pip-tadzYs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:54:17 INFO - Running setup.py (path:/tmp/pip-TGo2fL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:54:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:54:18 INFO - Running setup.py (path:/tmp/pip-i3D0fI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:54:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:54:18 INFO - Running setup.py (path:/tmp/pip-kocQwr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:54:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:54:18 INFO - Running setup.py (path:/tmp/pip-wTOgeZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:54:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:54:18 INFO - Running setup.py install for manifestparser 16:54:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:54:18 INFO - Running setup.py install for mozcrash 16:54:18 INFO - Running setup.py install for mozdebug 16:54:18 INFO - Running setup.py install for mozdevice 16:54:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:54:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:54:18 INFO - Running setup.py install for mozfile 16:54:18 INFO - Running setup.py install for mozhttpd 16:54:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:54:18 INFO - Running setup.py install for mozinfo 16:54:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:54:18 INFO - Running setup.py install for mozInstall 16:54:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:54:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:54:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:54:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:54:19 INFO - Running setup.py install for mozleak 16:54:19 INFO - Running setup.py install for mozlog 16:54:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:54:19 INFO - Running setup.py install for moznetwork 16:54:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:54:19 INFO - Running setup.py install for mozprocess 16:54:19 INFO - Running setup.py install for mozprofile 16:54:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:54:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:54:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:54:19 INFO - Running setup.py install for mozrunner 16:54:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:54:19 INFO - Running setup.py install for mozscreenshot 16:54:19 INFO - Running setup.py install for moztest 16:54:19 INFO - Running setup.py install for mozversion 16:54:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:54:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:54:19 INFO - Cleaning up... 16:54:19 INFO - Return code: 0 16:54:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:54:19 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')]} 16:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:19 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')]} 16:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:19 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 0x7f3de0922c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e7a90>, '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 0x2839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a2e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', '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 16:54:19 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 16:54:19 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 16:54:19 INFO - Using env: {'DISPLAY': ':0', 16:54:19 INFO - 'HOME': '/home/cltbld', 16:54:19 INFO - 'LANG': 'en_US.UTF-8', 16:54:19 INFO - 'LANGUAGE': 'en_US:en', 16:54:19 INFO - 'LOGNAME': 'cltbld', 16:54:19 INFO - 'MAIL': '/var/mail/cltbld', 16:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:19 INFO - 'MOZ_NO_REMOTE': '1', 16:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:19 INFO - 'NO_EM_RESTART': '1', 16:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:19 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:19 INFO - 'SHELL': '/bin/bash', 16:54:19 INFO - 'SHLVL': '1', 16:54:19 INFO - 'TERM': 'linux', 16:54:19 INFO - 'TMOUT': '86400', 16:54:19 INFO - 'USER': 'cltbld', 16:54:20 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', 16:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:20 INFO - '_': '/tools/buildbot/bin/python'} 16:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:54:20 INFO - Running setup.py (path:/tmp/pip-uG_uhU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:54:20 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)) 16:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:54:20 INFO - Running setup.py (path:/tmp/pip-zyoCWS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:54:20 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)) 16:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:54:20 INFO - Running setup.py (path:/tmp/pip-PMXitr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:54:20 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)) 16:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:54:20 INFO - Running setup.py (path:/tmp/pip-LtAGjg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:54:20 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)) 16:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:54:20 INFO - Running setup.py (path:/tmp/pip-HWn5Yc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:54:20 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)) 16:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:54:20 INFO - Running setup.py (path:/tmp/pip-29osal-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:54:20 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)) 16:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:54:20 INFO - Running setup.py (path:/tmp/pip-1vUZtF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:54:20 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)) 16:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:54:20 INFO - Running setup.py (path:/tmp/pip-etTev8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:54:20 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)) 16:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:54:20 INFO - Running setup.py (path:/tmp/pip-TX5iUs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:54:20 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)) 16:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:54:20 INFO - Running setup.py (path:/tmp/pip-q2mhJm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:54:20 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)) 16:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:54:20 INFO - Running setup.py (path:/tmp/pip-HDfXhb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:54:20 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)) 16:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:54:21 INFO - Running setup.py (path:/tmp/pip-nZA3Hm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:54:21 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)) 16:54:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:54:21 INFO - Running setup.py (path:/tmp/pip-F2sOe5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:54:21 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)) 16:54:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:54:21 INFO - Running setup.py (path:/tmp/pip-QummaU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:54:21 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)) 16:54:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:54:21 INFO - Running setup.py (path:/tmp/pip-KUKAVG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:54:21 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)) 16:54:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:54:21 INFO - Running setup.py (path:/tmp/pip-UI3t3a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:54:21 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)) 16:54:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:54:21 INFO - Running setup.py (path:/tmp/pip-ikPHNz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:54:21 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)) 16:54:21 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)) 16:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:54:21 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)) 16:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:54:21 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)) 16:54:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:23 INFO - Downloading blessings-1.5.1.tar.gz 16:54:23 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 16:54:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:54:23 INFO - Installing collected packages: blessings 16:54:23 INFO - Running setup.py install for blessings 16:54:23 INFO - Successfully installed blessings 16:54:23 INFO - Cleaning up... 16:54:23 INFO - Return code: 0 16:54:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:54:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:54:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:54:23 INFO - Reading from file tmpfile_stdout 16:54:23 INFO - Current package versions: 16:54:23 INFO - argparse == 1.2.1 16:54:23 INFO - blessings == 1.5.1 16:54:23 INFO - blobuploader == 1.2.4 16:54:23 INFO - docopt == 0.6.1 16:54:23 INFO - manifestparser == 1.1 16:54:23 INFO - mozInstall == 1.12 16:54:23 INFO - mozcrash == 0.16 16:54:23 INFO - mozdebug == 0.1 16:54:23 INFO - mozdevice == 0.47 16:54:23 INFO - mozfile == 1.2 16:54:23 INFO - mozhttpd == 0.7 16:54:23 INFO - mozinfo == 0.9 16:54:23 INFO - mozleak == 0.1 16:54:23 INFO - mozlog == 3.0 16:54:23 INFO - moznetwork == 0.27 16:54:23 INFO - mozprocess == 0.22 16:54:23 INFO - mozprofile == 0.27 16:54:23 INFO - mozrunner == 6.11 16:54:23 INFO - mozscreenshot == 0.1 16:54:23 INFO - mozsystemmonitor == 0.0 16:54:23 INFO - moztest == 0.7 16:54:23 INFO - mozversion == 1.4 16:54:23 INFO - psutil == 3.1.1 16:54:23 INFO - requests == 1.2.3 16:54:23 INFO - wsgiref == 0.1.2 16:54:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:54:23 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')]} 16:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:23 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')]} 16:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:23 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 0x7f3de0922c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e7a90>, '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 0x2839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a2e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', '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 16:54:23 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 16:54:23 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 16:54:23 INFO - Using env: {'DISPLAY': ':0', 16:54:23 INFO - 'HOME': '/home/cltbld', 16:54:23 INFO - 'LANG': 'en_US.UTF-8', 16:54:23 INFO - 'LANGUAGE': 'en_US:en', 16:54:23 INFO - 'LOGNAME': 'cltbld', 16:54:23 INFO - 'MAIL': '/var/mail/cltbld', 16:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:23 INFO - 'MOZ_NO_REMOTE': '1', 16:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:23 INFO - 'NO_EM_RESTART': '1', 16:54:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:23 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:23 INFO - 'SHELL': '/bin/bash', 16:54:23 INFO - 'SHLVL': '1', 16:54:23 INFO - 'TERM': 'linux', 16:54:23 INFO - 'TMOUT': '86400', 16:54:23 INFO - 'USER': 'cltbld', 16:54:23 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', 16:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:23 INFO - '_': '/tools/buildbot/bin/python'} 16:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:23 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)) 16:54:23 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)) 16:54:23 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)) 16:54:23 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)) 16:54:23 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)) 16:54:23 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)) 16:54:23 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)) 16:54:23 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)) 16:54:23 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)) 16:54:23 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)) 16:54:23 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)) 16:54:23 INFO - Cleaning up... 16:54:23 INFO - Return code: 0 16:54:23 INFO - Running post-action listener: _resource_record_post_action 16:54:23 INFO - Running post-action listener: _start_resource_monitoring 16:54:23 INFO - Starting resource monitoring. 16:54:23 INFO - ##### 16:54:23 INFO - ##### Running install step. 16:54:23 INFO - ##### 16:54:23 INFO - Running pre-action listener: _resource_record_pre_action 16:54:23 INFO - Running main action method: install 16:54:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:54:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:54:23 INFO - Reading from file tmpfile_stdout 16:54:23 INFO - Detecting whether we're running mozinstall >=1.0... 16:54:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:54:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:54:24 INFO - Reading from file tmpfile_stdout 16:54:24 INFO - Output received: 16:54:24 INFO - Usage: mozinstall [options] installer 16:54:24 INFO - Options: 16:54:24 INFO - -h, --help show this help message and exit 16:54:24 INFO - -d DEST, --destination=DEST 16:54:24 INFO - Directory to install application into. [default: 16:54:24 INFO - "/builds/slave/test-pgo"] 16:54:24 INFO - --app=APP Application being installed. [default: firefox] 16:54:24 INFO - mkdir: /builds/slave/test-pgo/build/application 16:54:24 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'] 16:54:24 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 16:54:38 INFO - Reading from file tmpfile_stdout 16:54:38 INFO - Output received: 16:54:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:54:38 INFO - Running post-action listener: _resource_record_post_action 16:54:38 INFO - ##### 16:54:38 INFO - ##### Running run-tests step. 16:54:38 INFO - ##### 16:54:38 INFO - Running pre-action listener: _resource_record_pre_action 16:54:38 INFO - Running main action method: run_tests 16:54:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:54:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:54:38 INFO - Python 2.7.3 16:54:38 INFO - Return code: 0 16:54:38 INFO - grabbing minidump binary from tooltool 16:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:38 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 0x27e7a90>, '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 0x2839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:54:38 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 16:54:38 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 16:54:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:54:38 INFO - Return code: 0 16:54:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:54:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:54:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:54:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:54:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:54:38 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/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:54:38 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/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 16:54:38 INFO - Using env: {'DISPLAY': ':0', 16:54:38 INFO - 'HOME': '/home/cltbld', 16:54:38 INFO - 'LANG': 'en_US.UTF-8', 16:54:38 INFO - 'LANGUAGE': 'en_US:en', 16:54:38 INFO - 'LOGNAME': 'cltbld', 16:54:38 INFO - 'MAIL': '/var/mail/cltbld', 16:54:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:54:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:38 INFO - 'MOZ_NO_REMOTE': '1', 16:54:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:38 INFO - 'NO_EM_RESTART': '1', 16:54:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:38 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:54:38 INFO - 'SHELL': '/bin/bash', 16:54:38 INFO - 'SHLVL': '1', 16:54:38 INFO - 'TERM': 'linux', 16:54:38 INFO - 'TMOUT': '86400', 16:54:38 INFO - 'USER': 'cltbld', 16:54:38 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654', 16:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:38 INFO - '_': '/tools/buildbot/bin/python'} 16:54:38 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/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 16:54:38 INFO - mozversion INFO | application_buildid: 20151114143008 16:54:38 INFO - mozversion INFO | application_changeset: 41b5c629c4a00f41b9b85a4521cf62a726bf4c7f 16:54:38 INFO - mozversion INFO | application_display_name: Nightly 16:54:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:54:38 INFO - mozversion INFO | application_name: Firefox 16:54:38 INFO - mozversion INFO | application_remotingname: firefox 16:54:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:54:38 INFO - mozversion INFO | application_vendor: Mozilla 16:54:38 INFO - mozversion INFO | application_version: 45.0a1 16:54:38 INFO - mozversion INFO | platform_buildid: 20151114143008 16:54:38 INFO - mozversion INFO | platform_changeset: 41b5c629c4a00f41b9b85a4521cf62a726bf4c7f 16:54:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:54:38 INFO - mozversion INFO | platform_version: 45.0a1 16:54:38 INFO - 2015-11-14 16:54:38,680 DEBUG : using testdate: 1447548878 16:54:38 INFO - 2015-11-14 16:54:38,680 DEBUG : actual date: 1447548878 16:54:38 INFO - 2015-11-14 16:54:38,688 INFO : starting webserver on 'localhost:36917' 16:54:38 INFO - 2015-11-14 16:54:38,689 INFO : Starting test suite talos-linux64-ix-035 16:54:38 INFO - 2015-11-14 16:54:38,689 INFO : Starting test dromaeo_css 16:54:38 INFO - 2015-11-14 16:54:38,689 DEBUG : operating with platform_type : linux_ 16:54:38 INFO - 2015-11-14 16:54:38,690 INFO : Initialising browser for dromaeo_css test... 16:54:38 INFO - 2015-11-14 16:54:38,700 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUS6nKN/profile http://localhost:36917/getInfo.html 16:54:42 INFO - 2015-11-14 16:54:42,393 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:54:42 INFO - 2015-11-14 16:54:42,393 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:54:42 INFO - 2015-11-14 16:54:42,393 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:54:42 INFO - 2015-11-14 16:54:42,393 DEBUG : BROWSER_OUTPUT: __metrics 16:54:42 INFO - 2015-11-14 16:54:42,489 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:54:43 INFO - 2015-11-14 16:54:43,819 INFO : Browser initialized. 16:54:43 INFO - 2015-11-14 16:54:43,819 INFO : Running cycle 1/1 for dromaeo_css test... 16:54:43 INFO - 2015-11-14 16:54:43,820 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUS6nKN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:54:55 INFO - 2015-11-14 16:54:55,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 139923456 16:54:55 INFO - 2015-11-14 16:54:55,586 DEBUG : BROWSER_OUTPUT: 16:55:47 INFO - 2015-11-14 16:55:47,224 DEBUG : BROWSER_OUTPUT: 1447548947222 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] 16:57:55 INFO - 2015-11-14 16:57:55,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36917/tests/dromaeo/cssquery-ext.html) 16:57:56 INFO - 2015-11-14 16:57:56,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 226607104 16:57:56 INFO - 2015-11-14 16:57:56,617 DEBUG : BROWSER_OUTPUT: 17:00:59 INFO - 2015-11-14 17:00:59,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/dromaeo/cssquery-ext.html (next: http://localhost:36917/tests/dromaeo/cssquery-jquery.html) 17:00:59 INFO - 2015-11-14 17:00:59,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 221147136 17:00:59 INFO - 2015-11-14 17:00:59,572 DEBUG : BROWSER_OUTPUT: 17:04:01 INFO - 2015-11-14 17:04:01,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36917/tests/dromaeo/cssquery-mootools.html) 17:04:02 INFO - 2015-11-14 17:04:02,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 218890240 17:04:02 INFO - 2015-11-14 17:04:02,096 DEBUG : BROWSER_OUTPUT: 17:07:03 INFO - 2015-11-14 17:07:03,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36917/tests/dromaeo/cssquery-prototype.html) 17:07:04 INFO - 2015-11-14 17:07:04,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 198856704 17:07:04 INFO - 2015-11-14 17:07:04,555 DEBUG : BROWSER_OUTPUT: 17:10:06 INFO - 2015-11-14 17:10:06,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36917/tests/dromaeo/cssquery-yui.html) 17:10:07 INFO - 2015-11-14 17:10:07,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 203460608 17:10:07 INFO - 2015-11-14 17:10:07,534 DEBUG : BROWSER_OUTPUT: 17:13:09 INFO - 2015-11-14 17:13:09,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/dromaeo/cssquery-yui.html (next: http://localhost:36917/tests/dromaeo/cssquery-dojo.html) 17:13:10 INFO - 2015-11-14 17:13:10,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 279134208 17:13:10 INFO - 2015-11-14 17:13:10,237 DEBUG : BROWSER_OUTPUT: 17:13:10 INFO - 2015-11-14 17:13:10,238 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:13:10 INFO - 2015-11-14 17:13:10,238 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:13:10 INFO - 2015-11-14 17:13:10,238 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:13:10 INFO - 2015-11-14 17:13:10,238 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:13:10 INFO - 2015-11-14 17:13:10,239 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3167.667394923533;3227.3867965086615;3259.5925509311337;3265.8856940007104;3294.687004734549;5351;5429.104197807362;5461.399246082938;5464.562834973202;5475.698836563993;5342.439043900393;5431.701256430894;5465.644733092357;5467.20725494803;5481.671099734019;4837.250226214934;4844.418669759634;4914.606831453475;4972.279019542164;5001.249812528132;5000.52495012975;5073.949260507385;5087.592992560605;5090.287359769617;5114.1050316194705;4927.630427717935;5028.245763135523;5052.065367906949;5087;5139.023585518739;4820.975895120537;4907.190313598252;4908.263760435963;4918.508149185089;4928.6303527235605;5039.042581909425;5039.72281524516;5062.063518249136;5070.771815268322;5093.923591146136;5184.766685499124;5204.063268611649;5291.920621190685;5385.7576409061685;5397;5921.407859214087;5926.8814623707285;5928.79249226275;5930.258717660293;5966.433188847052;5898.911516327258;5903.49820265278;5908.172855800191;5956.106584012389;5964.850878728023;5372.274742909696;5439.619226654136;5488.890222195574;5544.279243698294;5552.7223638818705;6020.337762846083;6052.515798736091;6075.908861367083;6084.756609735649;6092.482139018233;5858.326292476419;5871;5878.706064696834;5884.823455296348;5924.229850119457;5694.4590263924865;5748.338941021836;5905.881882362414;5986.431289027535;6033.276006879202;5888.146218798251;5889.116632505073;5895.380984996599;5902.409759024149;5908.911366329508;5730.598858079978;5910.172575839386;5914.9112763308585;5919.911201331984;5923.052311630118;4412.3160910059;4425.822967081345;4429.867103986886;4466.865994020184;4500.729956202638;4048.0284731664187;4054.2296963576828;4064.532578753422;4079.143379890197;4097.836086556505;5402;5500.697461639568;5631.746571404296;5645;5674.858128546819;5818.825435236865;5877.970610146922;5901.645901245939;5913.881722365529;5949.405059494103;5601.551875849922;5642.7178641067785;5646.096624540136;5652.519535839418;5657.4908258256955;4959.553640172329;5023.8492845214705;5141.948580514147;5185.429602743695;5190.221466779938;6049.667268300198;6098.817035488943;6099.237595300588;6101.938980610137;6124.14262003311;5931.525477961839;5970.0746384310505;5977.432143946318;5982.760689572542;5983.311919129182;5911.497522710618;5947.553933455095;5972.25346831646;6023.698815059317;6028.216331876828;5781.103928891029;5876.823695289148;5884.205632239593;5884.882302353843;5890.617109887844;5953.970230148821;5959.0763431668165;5971.0744834550715;5986.341502434641;5988.850278743066;5632.971835140798;5635;5729.341125770423;5770.913436298543;5771.249737534094;5790.420957904176;5831.271091113611;5833.970830145822;5836.883262334814;5838.065909454467;5526.751296191601;5726.427357264407;5744.540436765133;5750.453706897838;5751.4536119068625;5799.710014499174;5861.9706901465215;5928.857675673558;5964.194833697396;5994.880102398015;5736.110902810071;5743.483086522233;5760.94239057604;5768.423157684198;5788.131780232999 17:13:10 INFO - 2015-11-14 17:13:10,241 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.6432433510903;589.3428826858053;596.3499785234094;606.2391698418487;609.6677310865578;32115;41507.79246103769;41985.3702194467;42012.57987420125;42013.78993105038;44793.55206447934;45361;45439.54560454394;45449;45452.77273613627;7662;7718.498297610666;8820.073892241318;9007.369484136114;9009.189172974431;10515.316504427226;10834.72913177169;10839.349639021684;10839.566417343296;10844.891551084467;10503.737406564858;10539.578416863316;10555.947220263888;10575.20685948557;10595.25833191673;7707.267809558083;7950.880736788953;10481;10692.679219623424;11003.17476189289;10383;10521.947390263076;10528.578856845717;10532.26274160809;10547.84178237327;33629.49555756665;41237.58762412368;41856;41856.58143418557;41869.371959420634;2781.1517487166407;3102.844857757103;3234.983825080883;3271.4765637498126;3490.406630872758;30834.229144271347;30839.845800770854;30848;32129.678703212903;32243.6775632243;3298.224917144469;3312.850921708529;3316.034439173815;3409.0454672691685;3429.159855835336;285892;286818;287327;287819;289341;58754.412455874895;59085.70457147773;59092.40907590869;59095.40904590899;59098.40901591015;62205.37794622086;62312;62313;62361.68819155966;62510.374896251364;14035.438582456587;16406;16559;16789.74815377746;16817.663646726996;11618.244814087057;11722.238054526428;12743.49026038948;12786.232826030468;12806.67983300425;18605.627887442446;18659.160337784833;18831.96424196655;18930.90534547346;19013.714794278098;7424.443166762514;7471.476996610294;7602.239776022354;7630.351420129351;7686.807829804187;891.4695756025154;923.9168474837297;960.4189465373488;969.049245048814;1075.1076606416655;26140.34649133787;26281.474370512482;26489.15550993793;26802.463950720878;26818.5977210342;1011.9291649584459;1066.3655125200494;1101.6529793115144;1115.8158903780786;1140.4981808004452;14577;14631.414743410145;14812.407503699731;15021.549353519413;15028.09831410119;342386;346720;348355;349427;349661;51122;51158.23262651063;51216.743916280924;51232.48767512352;51237.74381128071;1323.5830713325272;1328.754180476615;1344.3009634989946;1346.3604787725947;1347.7574036673298;27126.593101103106;27894.44211115807;27988.58017129704;28434.146975590764;28491.857540712164;44525.55474445214;44809.55190448054;44870.77564612156;44928.77535612301;44949.32576011297;314364;393239.64223398734;403402;408040;417690;30486.84756576203;30544.847275763477;30579.847100764353;30763.38473230478;31073.378532429677;41079.58920410758;41769;41816.790916045225;42449.151016980104;42889.78555107205;35821.46267806037;35941.64058359383;36124.27751445009;36541.81729091337;36973.445398319585;34412.31175376428;35550.82224588964;36054.63945360618;36611.63388366082;37588.248235034596;34883.9534813956;35653.46519802257;35950.46074308835;36023.45964810478;36140.45789313215;30623;32376;33092.503612446315;33114.172145695586;33158.83420582882;24645.38386540351;24886.626700599143;24938.771269253208;24963.375915602257;25467.23598292054 17:13:10 INFO - 2015-11-14 17:13:10,241 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.0441999970082;353.8531509423589;354.1836067863574;354.3586109142454;358.38358024198385;15199.848001519982;15232.619184520392;16761.1619419029;17150.941886973564;17875.10624468778;11299.661010169688;11633.592824251153;16996.660066798657;17636.294548218055;17670.38153664622;4428.535003824601;4529.63762898969;4532.682712210147;4532.796024178903;4533.5013148553635;3595.6404359564094;3687.6312368763042;4460.33095035744;4477.865664030068;4931.457539670633;4966.528179822929;4985.551300382965;4989.700617962933;4994.350734404522;4996.825111121111;4837.080954618629;4944.35723355965;4947.653664243504;4973.229149481836;4977.875553111165;4347.608715215646;4366.366876802877;4371.737695738266;4372.5627437256335;4376.321670141133;13908.304584770722;14149.858501414958;14323.85676143246;14338.64153396163;14359.569212923629;1943.8639295249338;1962.7840937496865;1985.6227316809905;2037.7045328427296;2049.6208201482773;9459.290553208537;9579.952100239523;9722.854157187649;9783.36408133469;9971.05274998874;1609.6056466165865;1616.8868179227459;1634.5995231168322;1637.9672406551922;1662.6840900229038;62562.374376256565;63472.99999999954;64048.679756601385;64721.67639161774;65051.349486505474;6753.08833307507;6819.283975182633;6838.21360543534;6874.037634731141;6913.688884000232;8255.545944972964;8269.255766981001;8269.46248493858;8278;8286.875696864552;5407.810726624628;5424.376196737426;5449.64577302474;5481.232627432163;5527.2538207342295;5569.10894256917;5582;5585.636933599384;5587.664740115606;5633.2395126657375;3125.702833324145;3143.685631436838;3143.827089510099;3159.778815482894;3164.905052848418;1099.483242875847;1104.3815463340395;1130.4517309105076;1161.9825702614467;1162.767486426064;470.2147413818931;480.02794341458826;482.8044641920028;486.7541891344919;497.6889444097439;11439;11498.193412326722;11528.135389845795;11650.30098194111;11713.472893719803;447.1481827119343;484.2324915009749;484.6946423753013;486.56695540968565;490.7325507598367;5871.148683440877;6226.5641405101205;6238.781642642486;6241.500679945593;6252.3122456529745;567355;590465;595242;607679;616084;78801.21198788054;79541;80036.59890203303;80449.59775201087;81904;537.954273886724;542.8507160530806;543.2557396367002;543.2665901033573;544.1402583917401;10155.289129761142;10366.378017318984;10521.158307335549;10582.417967011888;10601.946990265;34496.827515862264;34821.12947176341;35063.948081557595;35522.82238588791;35650.8217458911;45692.54307456883;45909;48375.75812120917;49270.26094608512;52492;6551.770688025897;6676.933230667825;6694.430973367318;6695.564788288746;6755.324467553205;11299.43502824839;11587.478563464496;11650.6504804856;11716.88283117192;11761;10009.399436033862;10128.29101962885;10312.587496500357;10426.113780328757;10457.320274182153;9874.259430542881;10059.094681478702;10083.344582602107;10152.644657436955;10335.121514671337;9394;9672.274579406432;10157.39055656663;10410.68767936963;10474.895251047392;6088.634681918922;6285.5600107992;6550.7707230246715;6623.1389919312105;6626.933730662631;10003.049710277512;10091.444970526398;10157.085862272432;10164.695059148238;10204.642837500653 17:13:10 INFO - 2015-11-14 17:13:10,242 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1336.9197848129106;1677.0776073159761;1738.6261953679964;1742.9738553921693;1766.0992893624248;6627.469802415807;7503.662335194916;7696.769096927087;7704.152543220242;7706.576138312391;7500.287472690099;7733.961330193341;7741.109772376179;7745.225477452252;7757.806054848632;1943.6987266973642;1996.6206420780006;2106.7261256036695;2122.1617461102855;2197.439652888519;2234.6871437998693;2243.057915675412;2254.334971183505;2255.1768604459417;2259.5254996450767;2177.3359125466727;2297.6438652008965;2300.896459659311;2310.792028717415;2318.2002209237785;1958.1971391729394;2004.3586052463218;2220.8001279884807;2270.0579259607243;2273.5680220758004;2274.090363854455;2281.726192856868;2329.23135365329;2330.5804955108074;2338.029717667166;7752.651130699132;7776.494527855728;7817;7824.33493153077;7850;4655.301704744315;4708.293755936603;4714.599259062949;4746.572808447257;4747.216709242971;2924.093531005395;2925.6781754007043;2972.5541168824634;2972.8364939928297;3092.659807421182;917.9403338782957;924.7087167542203;930.50683137937;942.9952850235774;965.5896244096231;10742.194335424874;10751.462426878703;10768.407737574431;10785.83821242682;10799.352038877692;4132.462779838602;4184.832606695759;4237.025484138604;4251.723637963522;4276.8289268429535;9159.77100572491;9180.954095229481;9191.218746406497;9204.95397523008;9207.907920920705;4652.418447694038;4711.67018308722;4732.52674732524;4763.571278584944;4768.976155119271;4294.098239369705;4298.505671847777;4298.742075475481;4298.871033868989;4302.397664326997;3441.397755392796;3488.494168345576;3513.4378499440477;3521.5950165730756;3532.6643968822923;1163.947622356996;1174.723939874129;1179.0862081886435;1185.6798664360747;1186.145974898072;982.297657175109;1288.2978776566792;1301.1217428235902;1306.046585992212;1344.919304841693;6562.475001999828;7044.189918159374;7298.489105762652;7301.671424785897;7325.047743793273;710.9680064397114;721.6391804097951;1156.9826452603218;1214.6356093172012;1231.8644949055597;5606.943930560724;5660.858478537987;5664.0937450007805;5670.773169073191;5673.092305231144;8966.820663586692;9113.726588202364;9156.771080722901;9171.541422928827;9223.631054757734;9244.722658320261;9250.352475326663;9258.259339252843;9260.907390926139;9263.351565390358;7034.19106802714;7103.360697537247;7186.173590037212;7229.602371869598;7230.457715671346;7313.67088481009;7360.484766066324;7370.96314518424;7374.483786134919;7381.704731810883;8101.8379632408205;8166.918330816853;8199.139090395423;8217.465864718773;8362.247397734232;8426.03100643434;8459.238668519863;8605.139486051345;8609.82780344402;8612.095729948516;6896.551724137915;7098.467614929004;7099.964500177466;7108;7112.110986126734;7362.22696616869;7436.479446438698;7437.51656142349;7441.888371674321;7448.329650331496;6881.176488230723;7079.185893622093;7152.284771523015;7273.672684729306;7318;7052.576845389293;7069.257727938492;7108.573485590881;7111.644417779194;7161.713531458683;6431.324710905287;6607.2071351438135;6929.75745848913;6967.407770339578;6972.302769722987;6409.519286053472;6566.244881838458;6608.6365249909795;6609.306022867722;6614.90077648826;6391.105245265573;6459.967700161469;6478.578892371981;6479.384458476437;6492.383223593751 17:13:10 INFO - 2015-11-14 17:13:10,243 DEBUG : BROWSER_OUTPUT: |4;prototype.html;330.7899483827769;335.2072348894864;339.8232918882183;339.94900764885256;342.83372564306325;6036.577439579231;6082.604630699001;6109.236345456818;6118.296395914471;6140.416660417259;5752.7411266493;5864.76540938363;5891.85270368241;5966.343702192767;5994.190784244126;4531.6601254905845;4533.705309154894;4547.295169248771;4567.1094136643205;4572.382728331674;4345.348197770328;4519.66102542309;4534.501204867462;4559.042601053783;4564.087182563484;4426.513083560806;4430.468343798749;4512.5261847506035;4534.8639540813665;4553.908921821561;4524.954750452503;4525.230710779176;4531.161735079021;4546.54534546546;4549.454065512126;3940.921181576381;3956.6636835868985;3957.0700885291935;3959.2873282809082;3962.623550762673;5568.443155684399;5664.801731939404;5714.685692286923;5718.685472299022;5719.799807006735;5369.919451208235;5375.435579264199;5378.46215378463;5381.273528073699;5384.326959130109;6345;6346.143270658495;6347.96826015867;6349.682515874188;6358.332375100594;4481.417415735966;4482.932756008662;4487.214737420971;4492.146492166478;4493.41585593874;6447.4197322241225;6602.933970660328;6606.570572912793;6607.405333519958;6637.701303441357;4464.687471877002;4481.215787237221;4487.214737420938;4488.5960263576435;4489.034857505587;4528.977355113203;4534.093181363674;4534.183846907588;4534.682572219913;4537.38745269391;5291.417944026154;5296.1261391870685;5300.840974770763;5302.072137375943;5307.256984022163;6231.408016238541;6397.360263973658;6412.871742565216;6422.646754428458;6441.227052753699;1579.6445799694977;1590.6500569874609;1591.8089829220567;1595.226315237109;1599.5761123302334;1052.7210289273348;1061.0821639281965;1062.3413483640193;1073.683263437288;1079.1582565598846;6201.596896201732;6209.565330426827;6211.037289220088;6211.472024877846;6212.9068063979075;6608.603483790892;6612;6622.503312251601;6624.138861948012;6625.801225963229;6006.099085137177;6071.241094863142;6113.113598528189;6235.345288744707;6261.123442718023;3572.732045096628;3574.9285014299567;3587.336342776595;3590.9281814363567;3596.1908570571413;6827.69275382609;6828.726850926007;6832.658367081725;6833.760818371333;6841.247462779091;6665.200175978914;6790.898136527956;6809.421199198124;6836.692348844214;6838.965805171042;6837.589744615339;6850.38346548813;6856.794296171123;6859.588424694434;6874.037634731041;6506.3818937200895;6599.142111525471;6615.338466153346;6629.701663425061;6647.800565983028;6520.380563846427;6543.672816359258;6579.638119903451;6597.868042639025;6602.042703807825;6759.932400676127;6760.121184246016;6769.206160367605;6773.221079575715;6777.593344399352;4429.889252768707;4430.556944305673;4433.556644335669;4436.489803672619;4441.289393696993;6479.125318081999;6605.504587155887;6616.106825578485;6647.268800431852;6682.665866706742;6401.967990160019;6404;6406.391392817862;6431.839204019937;6493.318201588954;6455.580387274812;6468.15913931186;6472.546921715623;6473.158489396348;6477.255115661759;6186.350433204449;6355.237371515448;6357.396047375492;6365.299817020032;6367.235931688042;6505.2844187138435;6507;6514.1531600891585;6515.218173819172;6516.413522782972;6205.131281620486;6322.209723784527;6367.458766004756;6373.171487706754;6375.489960803032 17:13:10 INFO - 2015-11-14 17:13:10,244 DEBUG : BROWSER_OUTPUT: |5;yui.html;757.9696812127515;776.4603600497653;813.6663967773211;844.8014716541612;880.4013270975738;13544.864551354483;13826.101303415297;13874.999999999987;13875.306234688263;13915.652108697288;12931.224126552414;13441.932790336059;13455.663608409795;13475.326233688325;13481.460741570325;696.5890124826351;702.0487239790087;821.8356328734247;821.9506829590214;839.4627438439404;842.4945032980224;846;850.3409857360533;852.7399143261302;852.9658813647446;868.5309932636369;873.5719497446237;874.7813046738315;874.8862647855769;875.308506280038;721.5093736259341;729.1286912139994;862.6635612111281;877.8507653698887;878.2008372381102;645.1033064040987;645.180620611825;645.2966266769197;645.5868244323636;645.8320836582523;13963.441462341494;14120.435182592684;14159.150450972871;14164.29178541079;14168.716625667532;11489.195756296978;11540.081565502678;11696.12279079064;12012.579559715456;12035.338056406894;10672.839907401396;10732.839007414817;10736.838947415717;10740.677779666623;10841.512131954081;3418.265073009315;3507.6843084122297;3539.982300088483;3562.536870206882;3562.71498280137;48335;48587;48855;48894.266586001235;48934;9548.8063992001;9797.755056123511;10007.649732259337;10043.397396156253;10212.131968782589;17883.1952562135;17895.10524473771;17911.552211194823;17947;18020.909895450437;7575;7592.962035189788;7802.219778022152;7886.526808391515;7890.526568405914;4164.708470407042;4189.05746207107;4244.702870799076;4297.548757380492;4337.0892112656065;3067.6165479315086;3071.9539206911913;3094.056312824565;3100.2404410919016;3102.2399512119223;456.44085994656945;464.3220897489703;475.9262314341283;477.5821156488073;480.74520504132863;544.0506316477772;625.5964902637774;663.6548994522822;666.1007639686385;709.6841905352172;8834.55827208637;8837;8909.465432074096;9043.366964312436;9122.726318210463;538.859896426924;687.0610100291085;701.4738945790657;706.6254884911006;721.5418209437046;4152.626263636287;4368.235558777201;4374.825006999748;4488;4498.617617502549;55438;55593.444065558826;55960.72019639957;56053;56134.43865561292;47525.76237118792;48066;48081.51918480841;48322;48671.75664121657;43115.13769724588;43275.78362108232;43909.56090439118;44016.3397549037;44145.11709765851;9034.86447703272;9128.224100951493;9213.12475314844;9226.907730922605;9239.76900577491;34980;36171.27657446784;36268.27463450769;36304;36936;42635.786821065696;43270.350944736485;45857.77071114623;46675.29987050129;46820;11429.199956003;11743.706407339885;11897.345645989553;12029.939850300692;12061.939690301493;12450.315232661927;12527.559330677088;12559.811602825783;12900.677483062998;12907.677308067374;11331;11513.30920144794;11695.239809412362;11708.531658733555;11954.282743035446;11052.447377631248;11427.142964277546;11518.308901465938;11583.536658533902;11773.17587768848;11442.599509017144;11598.18812683104;11717.882821172021;11903.958056123794;11921.284722916653;9995.300328976902;10229.641962531276;10269.537870795682;10417;10421.322614030063;8974.237189838937;9258.35191536586;9409.717708468757;9462.243020558477;10027.649032283834 17:13:10 INFO - 2015-11-14 17:13:10,245 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:13:10 INFO - 2015-11-14 17:13:10,245 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:13:10 INFO - 2015-11-14 17:13:10,245 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,938 17:13:10 INFO - 2015-11-14 17:13:10,245 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:13:10 INFO - 2015-11-14 17:13:10,245 DEBUG : BROWSER_OUTPUT: __startTimestamp1447549990237__endTimestamp 17:13:10 INFO - 2015-11-14 17:13:10,245 DEBUG : BROWSER_OUTPUT: 17:13:10 INFO - 2015-11-14 17:13:10,245 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:13:10 INFO - 2015-11-14 17:13:10,245 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:13:10 INFO - 2015-11-14 17:13:10,245 DEBUG : BROWSER_OUTPUT: 17:13:10 INFO - 2015-11-14 17:13:10,246 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5479.99 Median:5736.11 stddev:626.54 (10.9%) stddev-sans-first:601.63 17:13:10 INFO - 2015-11-14 17:13:10,246 DEBUG : BROWSER_OUTPUT: Values: 3167.7 3227.4 3259.6 3265.9 3294.7 5351.0 5429.1 5461.4 5464.6 5475.7 5342.4 5431.7 5465.6 5467.2 5481.7 4837.3 4844.4 4914.6 4972.3 5001.2 5000.5 5073.9 5087.6 5090.3 5114.1 4927.6 5028.2 5052.1 5087.0 5139.0 4821.0 4907.2 4908.3 4918.5 4928.6 5039.0 5039.7 5062.1 5070.8 5093.9 5184.8 5204.1 5291.9 5385.8 5397.0 5921.4 5926.9 5928.8 5930.3 5966.4 5898.9 5903.5 5908.2 5956.1 5964.9 5372.3 5439.6 5488.9 5544.3 5552.7 6020.3 6052.5 6075.9 6084.8 6092.5 5858.3 5871.0 5878.7 5884.8 5924.2 5694.5 5748.3 5905.9 5986.4 6033.3 5888.1 5889.1 5895.4 5902.4 5908.9 5730.6 5910.2 5914.9 5919.9 5923.1 4412.3 4425.8 4429.9 4466.9 4500.7 4048.0 4054.2 4064.5 4079.1 4097.8 5402.0 5500.7 5631.7 5645.0 5674.9 5818.8 5878.0 5901.6 5913.9 5949.4 5601.6 5642.7 5646.1 5652.5 5657.5 4959.6 5023.8 5141.9 5185.4 5190.2 6049.7 6098.8 6099.2 6101.9 6124.1 5931.5 5970.1 5977.4 5982.8 5983.3 5911.5 5947.6 5972.3 6023.7 6028.2 5781.1 5876.8 5884.2 5884.9 5890.6 5954.0 5959.1 5971.1 5986.3 5988.9 5633.0 5635.0 5729.3 5770.9 5771.2 5790.4 5831.3 5834.0 5836.9 5838.1 5526.8 5726.4 5744.5 5750.5 5751.5 5799.7 5862.0 5928.9 5964.2 5994.9 5736.1 5743.5 5760.9 5768.4 5788.1 17:13:10 INFO - 2015-11-14 17:13:10,246 DEBUG : BROWSER_OUTPUT: 17:13:10 INFO - 2015-11-14 17:13:10,246 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50523.73 Median:18235.84 stddev:90373.57 (495.6%) stddev-sans-first:90549.24 17:13:10 INFO - 2015-11-14 17:13:10,246 DEBUG : BROWSER_OUTPUT: Values: 560.6 589.3 596.3 606.2 609.7 32115.0 41507.8 41985.4 42012.6 42013.8 44793.6 45361.0 45439.5 45449.0 45452.8 7662.0 7718.5 8820.1 9007.4 9009.2 10515.3 10834.7 10839.3 10839.6 10844.9 10503.7 10539.6 10555.9 10575.2 10595.3 7707.3 7950.9 10481.0 10692.7 11003.2 10383.0 10521.9 10528.6 10532.3 10547.8 33629.5 41237.6 41856.0 41856.6 41869.4 2781.2 3102.8 3235.0 3271.5 3490.4 30834.2 30839.8 30848.0 32129.7 32243.7 3298.2 3312.9 3316.0 3409.0 3429.2 285892.0 286818.0 287327.0 287819.0 289341.0 58754.4 59085.7 59092.4 59095.4 59098.4 62205.4 62312.0 62313.0 62361.7 62510.4 14035.4 16406.0 16559.0 16789.7 16817.7 11618.2 11722.2 12743.5 12786.2 12806.7 18605.6 18659.2 18832.0 18930.9 19013.7 7424.4 7471.5 7602.2 7630.4 7686.8 891.5 923.9 960.4 969.0 1075.1 26140.3 26281.5 26489.2 26802.5 26818.6 1011.9 1066.4 1101.7 1115.8 1140.5 14577.0 14631.4 14812.4 15021.5 15028.1 342386.0 346720.0 348355.0 349427.0 349661.0 51122.0 51158.2 51216.7 51232.5 51237.7 1323.6 1328.8 1344.3 1346.4 1347.8 27126.6 27894.4 27988.6 28434.1 28491.9 44525.6 44809.6 44870.8 44928.8 44949.3 314364.0 393239.6 403402.0 408040.0 417690.0 30486.8 30544.8 30579.8 30763.4 31073.4 41079.6 41769.0 41816.8 42449.2 42889.8 35821.5 35941.6 36124.3 36541.8 36973.4 34412.3 35550.8 36054.6 36611.6 37588.2 34884.0 35653.5 35950.5 36023.5 36140.5 30623.0 32376.0 33092.5 33114.2 33158.8 24645.4 24886.6 24938.8 24963.4 25467.2 17:13:10 INFO - 2015-11-14 17:13:10,246 DEBUG : BROWSER_OUTPUT: 17:13:10 INFO - 2015-11-14 17:13:10,247 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28630.99 Median:4533.15 stddev:97645.22 (2154.0%) stddev-sans-first:97896.04 17:13:10 INFO - 2015-11-14 17:13:10,247 DEBUG : BROWSER_OUTPUT: Values: 352.0 353.9 354.2 354.4 358.4 15199.8 15232.6 16761.2 17150.9 17875.1 11299.7 11633.6 16996.7 17636.3 17670.4 4428.5 4529.6 4532.7 4532.8 4533.5 3595.6 3687.6 4460.3 4477.9 4931.5 4966.5 4985.6 4989.7 4994.4 4996.8 4837.1 4944.4 4947.7 4973.2 4977.9 4347.6 4366.4 4371.7 4372.6 4376.3 13908.3 14149.9 14323.9 14338.6 14359.6 1943.9 1962.8 1985.6 2037.7 2049.6 9459.3 9580.0 9722.9 9783.4 9971.1 1609.6 1616.9 1634.6 1638.0 1662.7 62562.4 63473.0 64048.7 64721.7 65051.3 6753.1 6819.3 6838.2 6874.0 6913.7 8255.5 8269.3 8269.5 8278.0 8286.9 5407.8 5424.4 5449.6 5481.2 5527.3 5569.1 5582.0 5585.6 5587.7 5633.2 3125.7 3143.7 3143.8 3159.8 3164.9 1099.5 1104.4 1130.5 1162.0 1162.8 470.2 480.0 482.8 486.8 497.7 11439.0 11498.2 11528.1 11650.3 11713.5 447.1 484.2 484.7 486.6 490.7 5871.1 6226.6 6238.8 6241.5 6252.3 567355.0 590465.0 595242.0 607679.0 616084.0 78801.2 79541.0 80036.6 80449.6 81904.0 538.0 542.9 543.3 543.3 544.1 10155.3 10366.4 10521.2 10582.4 10601.9 34496.8 34821.1 35063.9 35522.8 35650.8 45692.5 45909.0 48375.8 49270.3 52492.0 6551.8 6676.9 6694.4 6695.6 6755.3 11299.4 11587.5 11650.7 11716.9 11761.0 10009.4 10128.3 10312.6 10426.1 10457.3 9874.3 10059.1 10083.3 10152.6 10335.1 9394.0 9672.3 10157.4 10410.7 10474.9 6088.6 6285.6 6550.8 6623.1 6626.9 10003.0 10091.4 10157.1 10164.7 10204.6 17:13:10 INFO - 2015-11-14 17:13:10,247 DEBUG : BROWSER_OUTPUT: 17:13:10 INFO - 2015-11-14 17:13:10,248 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5426.74 Median:6586.73 stddev:2820.37 (42.8%) stddev-sans-first:2811.52 17:13:10 INFO - 2015-11-14 17:13:10,248 DEBUG : BROWSER_OUTPUT: Values: 1336.9 1677.1 1738.6 1743.0 1766.1 6627.5 7503.7 7696.8 7704.2 7706.6 7500.3 7734.0 7741.1 7745.2 7757.8 1943.7 1996.6 2106.7 2122.2 2197.4 2234.7 2243.1 2254.3 2255.2 2259.5 2177.3 2297.6 2300.9 2310.8 2318.2 1958.2 2004.4 2220.8 2270.1 2273.6 2274.1 2281.7 2329.2 2330.6 2338.0 7752.7 7776.5 7817.0 7824.3 7850.0 4655.3 4708.3 4714.6 4746.6 4747.2 2924.1 2925.7 2972.6 2972.8 3092.7 917.9 924.7 930.5 943.0 965.6 10742.2 10751.5 10768.4 10785.8 10799.4 4132.5 4184.8 4237.0 4251.7 4276.8 9159.8 9181.0 9191.2 9205.0 9207.9 4652.4 4711.7 4732.5 4763.6 4769.0 4294.1 4298.5 4298.7 4298.9 4302.4 3441.4 3488.5 3513.4 3521.6 3532.7 1163.9 1174.7 1179.1 1185.7 1186.1 982.3 1288.3 1301.1 1306.0 1344.9 6562.5 7044.2 7298.5 7301.7 7325.0 711.0 721.6 1157.0 1214.6 1231.9 5606.9 5660.9 5664.1 5670.8 5673.1 8966.8 9113.7 9156.8 9171.5 9223.6 9244.7 9250.4 9258.3 9260.9 9263.4 7034.2 7103.4 7186.2 7229.6 7230.5 7313.7 7360.5 7371.0 7374.5 7381.7 8101.8 8166.9 8199.1 8217.5 8362.2 8426.0 8459.2 8605.1 8609.8 8612.1 6896.6 7098.5 7100.0 7108.0 7112.1 7362.2 7436.5 7437.5 7441.9 7448.3 6881.2 7079.2 7152.3 7273.7 7318.0 7052.6 7069.3 7108.6 7111.6 7161.7 6431.3 6607.2 6929.8 6967.4 6972.3 6409.5 6566.2 6608.6 6609.3 6614.9 6391.1 6460.0 6478.6 6479.4 6492.4 17:13:10 INFO - 2015-11-14 17:13:10,249 DEBUG : BROWSER_OUTPUT: 17:13:10 INFO - 2015-11-14 17:13:10,249 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5340.54 Median:6115.70 stddev:1627.60 (26.6%) stddev-sans-first:1588.14 17:13:10 INFO - 2015-11-14 17:13:10,249 DEBUG : BROWSER_OUTPUT: Values: 330.8 335.2 339.8 339.9 342.8 6036.6 6082.6 6109.2 6118.3 6140.4 5752.7 5864.8 5891.9 5966.3 5994.2 4531.7 4533.7 4547.3 4567.1 4572.4 4345.3 4519.7 4534.5 4559.0 4564.1 4426.5 4430.5 4512.5 4534.9 4553.9 4525.0 4525.2 4531.2 4546.5 4549.5 3940.9 3956.7 3957.1 3959.3 3962.6 5568.4 5664.8 5714.7 5718.7 5719.8 5369.9 5375.4 5378.5 5381.3 5384.3 6345.0 6346.1 6348.0 6349.7 6358.3 4481.4 4482.9 4487.2 4492.1 4493.4 6447.4 6602.9 6606.6 6607.4 6637.7 4464.7 4481.2 4487.2 4488.6 4489.0 4529.0 4534.1 4534.2 4534.7 4537.4 5291.4 5296.1 5300.8 5302.1 5307.3 6231.4 6397.4 6412.9 6422.6 6441.2 1579.6 1590.7 1591.8 1595.2 1599.6 1052.7 1061.1 1062.3 1073.7 1079.2 6201.6 6209.6 6211.0 6211.5 6212.9 6608.6 6612.0 6622.5 6624.1 6625.8 6006.1 6071.2 6113.1 6235.3 6261.1 3572.7 3574.9 3587.3 3590.9 3596.2 6827.7 6828.7 6832.7 6833.8 6841.2 6665.2 6790.9 6809.4 6836.7 6839.0 6837.6 6850.4 6856.8 6859.6 6874.0 6506.4 6599.1 6615.3 6629.7 6647.8 6520.4 6543.7 6579.6 6597.9 6602.0 6759.9 6760.1 6769.2 6773.2 6777.6 4429.9 4430.6 4433.6 4436.5 4441.3 6479.1 6605.5 6616.1 6647.3 6682.7 6402.0 6404.0 6406.4 6431.8 6493.3 6455.6 6468.2 6472.5 6473.2 6477.3 6186.4 6355.2 6357.4 6365.3 6367.2 6505.3 6507.0 6514.2 6515.2 6516.4 6205.1 6322.2 6367.5 6373.2 6375.5 17:13:10 INFO - 2015-11-14 17:13:10,249 DEBUG : BROWSER_OUTPUT: 17:13:10 INFO - 2015-11-14 17:13:10,249 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13774.30 Median:43962.95 stddev:15549.45 (35.4%) stddev-sans-first:15562.35 17:13:10 INFO - 2015-11-14 17:13:10,249 DEBUG : BROWSER_OUTPUT: Values: 758.0 776.5 813.7 844.8 880.4 13544.9 13826.1 13875.0 13875.3 13915.7 12931.2 13441.9 13455.7 13475.3 13481.5 696.6 702.0 821.8 822.0 839.5 842.5 846.0 850.3 852.7 853.0 868.5 873.6 874.8 874.9 875.3 721.5 729.1 862.7 877.9 878.2 645.1 645.2 645.3 645.6 645.8 13963.4 14120.4 14159.2 14164.3 14168.7 11489.2 11540.1 11696.1 12012.6 12035.3 10672.8 10732.8 10736.8 10740.7 10841.5 3418.3 3507.7 3540.0 3562.5 3562.7 48335.0 48587.0 48855.0 48894.3 48934.0 9548.8 9797.8 10007.6 10043.4 10212.1 17883.2 17895.1 17911.6 17947.0 18020.9 7575.0 7593.0 7802.2 7886.5 7890.5 4164.7 4189.1 4244.7 4297.5 4337.1 3067.6 3072.0 3094.1 3100.2 3102.2 456.4 464.3 475.9 477.6 480.7 544.1 625.6 663.7 666.1 709.7 8834.6 8837.0 8909.5 9043.4 9122.7 538.9 687.1 701.5 706.6 721.5 4152.6 4368.2 4374.8 4488.0 4498.6 55438.0 55593.4 55960.7 56053.0 56134.4 47525.8 48066.0 48081.5 48322.0 48671.8 43115.1 43275.8 43909.6 44016.3 44145.1 9034.9 9128.2 9213.1 9226.9 9239.8 34980.0 36171.3 36268.3 36304.0 36936.0 42635.8 43270.4 45857.8 46675.3 46820.0 11429.2 11743.7 11897.3 12029.9 12061.9 12450.3 12527.6 12559.8 12900.7 12907.7 11331.0 11513.3 11695.2 11708.5 11954.3 11052.4 11427.1 11518.3 11583.5 11773.2 11442.6 11598.2 11717.9 11904.0 11921.3 9995.3 10229.6 10269.5 10417.0 10421.3 8974.2 9258.4 9409.7 9462.2 10027.6 17:13:10 INFO - 2015-11-14 17:13:10,249 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:13:10 INFO - 2015-11-14 17:13:10,249 DEBUG : BROWSER_OUTPUT: 17:13:10 INFO - 2015-11-14 17:13:10,931 INFO : Browser exited with error code: 0 17:13:10 INFO - 2015-11-14 17:13:10,952 INFO : Completed test dromaeo_css (00:18:32) 17:13:10 INFO - 2015-11-14 17:13:10,952 INFO : Starting test kraken 17:13:10 INFO - 2015-11-14 17:13:10,952 DEBUG : operating with platform_type : linux_ 17:13:10 INFO - 2015-11-14 17:13:10,952 INFO : Initialising browser for kraken test... 17:13:10 INFO - 2015-11-14 17:13:10,958 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplFmhxo/profile http://localhost:36917/getInfo.html 17:13:14 INFO - 2015-11-14 17:13:14,610 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:13:14 INFO - 2015-11-14 17:13:14,610 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:13:14 INFO - 2015-11-14 17:13:14,610 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:13:14 INFO - 2015-11-14 17:13:14,611 DEBUG : BROWSER_OUTPUT: __metrics 17:13:14 INFO - 2015-11-14 17:13:14,707 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:13:16 INFO - 2015-11-14 17:13:16,027 INFO : Browser initialized. 17:13:16 INFO - 2015-11-14 17:13:16,027 INFO : Running cycle 1/1 for kraken test... 17:13:16 INFO - 2015-11-14 17:13:16,028 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplFmhxo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:13:27 INFO - 2015-11-14 17:13:27,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 141746176 17:13:27 INFO - 2015-11-14 17:13:27,772 DEBUG : BROWSER_OUTPUT: 17:13:30 INFO - 2015-11-14 17:13:30,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36917/tests/kraken/driver.html?testName=audio-beat-detection) 17:13:30 INFO - 2015-11-14 17:13:30,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 179830784 17:13:30 INFO - 2015-11-14 17:13:30,834 DEBUG : BROWSER_OUTPUT: 17:13:33 INFO - 2015-11-14 17:13:33,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36917/tests/kraken/driver.html?testName=audio-dft) 17:13:33 INFO - 2015-11-14 17:13:33,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 168259584 17:13:33 INFO - 2015-11-14 17:13:33,997 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2015-11-14 17:13:36,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36917/tests/kraken/driver.html?testName=audio-fft) 17:13:37 INFO - 2015-11-14 17:13:37,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 151494656 17:13:37 INFO - 2015-11-14 17:13:37,409 DEBUG : BROWSER_OUTPUT: 17:13:39 INFO - 2015-11-14 17:13:39,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36917/tests/kraken/driver.html?testName=audio-oscillator) 17:13:39 INFO - 2015-11-14 17:13:39,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 153870336 17:13:39 INFO - 2015-11-14 17:13:39,972 DEBUG : BROWSER_OUTPUT: 17:13:42 INFO - 2015-11-14 17:13:42,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36917/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:13:42 INFO - 2015-11-14 17:13:42,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 156233728 17:13:42 INFO - 2015-11-14 17:13:42,695 DEBUG : BROWSER_OUTPUT: 17:13:45 INFO - 2015-11-14 17:13:45,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36917/tests/kraken/driver.html?testName=imaging-darkroom) 17:13:46 INFO - 2015-11-14 17:13:46,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 156295168 17:13:46 INFO - 2015-11-14 17:13:46,186 DEBUG : BROWSER_OUTPUT: 17:13:49 INFO - 2015-11-14 17:13:49,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36917/tests/kraken/driver.html?testName=imaging-desaturate) 17:13:50 INFO - 2015-11-14 17:13:50,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 155758592 17:13:50 INFO - 2015-11-14 17:13:50,132 DEBUG : BROWSER_OUTPUT: 17:13:52 INFO - 2015-11-14 17:13:52,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36917/tests/kraken/driver.html?testName=json-parse-financial) 17:13:53 INFO - 2015-11-14 17:13:53,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 157716480 17:13:53 INFO - 2015-11-14 17:13:53,436 DEBUG : BROWSER_OUTPUT: 17:13:54 INFO - 2015-11-14 17:13:54,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36917/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:13:55 INFO - 2015-11-14 17:13:55,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 164904960 17:13:55 INFO - 2015-11-14 17:13:55,534 DEBUG : BROWSER_OUTPUT: 17:13:57 INFO - 2015-11-14 17:13:57,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36917/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:13:57 INFO - 2015-11-14 17:13:57,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 164446208 17:13:57 INFO - 2015-11-14 17:13:57,925 DEBUG : BROWSER_OUTPUT: 17:13:59 INFO - 2015-11-14 17:13:59,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36917/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:14:00 INFO - 2015-11-14 17:14:00,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 167718912 17:14:00 INFO - 2015-11-14 17:14:00,562 DEBUG : BROWSER_OUTPUT: 17:14:02 INFO - 2015-11-14 17:14:02,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36917/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:14:03 INFO - 2015-11-14 17:14:03,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 178176000 17:14:03 INFO - 2015-11-14 17:14:03,529 DEBUG : BROWSER_OUTPUT: 17:14:06 INFO - 2015-11-14 17:14:06,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36917/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:14:06 INFO - 2015-11-14 17:14:06,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 178356224 17:14:06 INFO - 2015-11-14 17:14:06,696 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36917/tests/kraken/driver.html?testName=ai-astar) 17:14:08 INFO - 2015-11-14 17:14:08,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 237539328 17:14:08 INFO - 2015-11-14 17:14:08,635 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,635 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:14:08 INFO - 2015-11-14 17:14:08,636 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:14:08 INFO - 2015-11-14 17:14:08,636 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:14:08 INFO - 2015-11-14 17:14:08,636 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:14:08 INFO - 2015-11-14 17:14:08,636 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;103;109;110;110;98;109;110;112 17:14:08 INFO - 2015-11-14 17:14:08,636 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;132;147;163;125;150;150;132;161;124 17:14:08 INFO - 2015-11-14 17:14:08,636 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;160;161;159;160;160;161;163;161;164 17:14:08 INFO - 2015-11-14 17:14:08,638 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;80;89;95;71;71;71;100;91;71 17:14:08 INFO - 2015-11-14 17:14:08,638 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;138;90;91;90;132;91;90;132 17:14:08 INFO - 2015-11-14 17:14:08,638 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 17:14:08 INFO - 2015-11-14 17:14:08,638 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;146;146;145;145;145 17:14:08 INFO - 2015-11-14 17:14:08,638 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;96;96;95;95;96 17:14:08 INFO - 2015-11-14 17:14:08,638 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;57;57;57;60;57;66;56;55 17:14:08 INFO - 2015-11-14 17:14:08,639 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;68;68;68;68;69;69;69;68 17:14:08 INFO - 2015-11-14 17:14:08,639 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;84;84;85;85;84;84;87;87;93 17:14:08 INFO - 2015-11-14 17:14:08,639 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;123;120;113;116;120;116;115;115;129 17:14:08 INFO - 2015-11-14 17:14:08,639 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;151;152;151;149;141;156;152;150;153 17:14:08 INFO - 2015-11-14 17:14:08,639 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;70;67;67;69;67;67;65;68 17:14:08 INFO - 2015-11-14 17:14:08,639 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:14:08 INFO - 2015-11-14 17:14:08,639 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:14:08 INFO - 2015-11-14 17:14:08,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,940 17:14:08 INFO - 2015-11-14 17:14:08,640 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:14:08 INFO - 2015-11-14 17:14:08,640 DEBUG : BROWSER_OUTPUT: __startTimestamp1447550048634__endTimestamp 17:14:08 INFO - 2015-11-14 17:14:08,640 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,643 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:14:08 INFO - 2015-11-14 17:14:08,643 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:14:08 INFO - 2015-11-14 17:14:08,643 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,643 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.40 Median:110.50 stddev:4.45 (4.0%) stddev-sans-first:4.62 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 103.0 109.0 110.0 110.0 98.0 109.0 110.0 112.0 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.50 Median:150.00 stddev:14.25 (9.5%) stddev-sans-first:14.85 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: Values: 151.0 132.0 147.0 163.0 125.0 150.0 150.0 132.0 161.0 124.0 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.62 (1.0%) stddev-sans-first:1.58 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: Values: 159.0 160.0 161.0 159.0 160.0 160.0 161.0 163.0 161.0 164.0 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.56 (15.2%) stddev-sans-first:11.78 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: Values: 72.0 80.0 89.0 95.0 71.0 71.0 71.0 100.0 91.0 71.0 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:90.00 stddev:21.11 (23.5%) stddev-sans-first:21.82 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 138.0 90.0 91.0 90.0 132.0 91.0 90.0 132.0 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:14:08 INFO - 2015-11-14 17:14:08,644 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:3.09 (5.4%) stddev-sans-first:3.28 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 57.0 57.0 57.0 60.0 57.0 66.0 56.0 55.0 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 68.0 68.0 68.0 69.0 69.0 69.0 68.0 17:14:08 INFO - 2015-11-14 17:14:08,645 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:3.20 (3.7%) stddev-sans-first:2.93 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: Values: 91.0 84.0 84.0 85.0 85.0 84.0 84.0 87.0 87.0 93.0 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:118.00 stddev:4.95 (4.2%) stddev-sans-first:5.03 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: Values: 114.0 123.0 120.0 113.0 116.0 120.0 116.0 115.0 115.0 129.0 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.50 Median:151.50 stddev:5.10 (3.4%) stddev-sans-first:4.10 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: Values: 140.0 151.0 152.0 151.0 149.0 141.0 156.0 152.0 150.0 153.0 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.48 (2.2%) stddev-sans-first:1.50 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 70.0 67.0 67.0 69.0 67.0 67.0 65.0 68.0 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:14:08 INFO - 2015-11-14 17:14:08,646 DEBUG : BROWSER_OUTPUT: 17:14:09 INFO - 2015-11-14 17:14:09,507 INFO : Browser exited with error code: 0 17:14:09 INFO - 2015-11-14 17:14:09,557 INFO : Completed test kraken (00:00:58) 17:14:09 INFO - 2015-11-14 17:14:09,558 INFO : Starting test v8_7 17:14:09 INFO - 2015-11-14 17:14:09,558 DEBUG : operating with platform_type : linux_ 17:14:09 INFO - 2015-11-14 17:14:09,558 INFO : Initialising browser for v8_7 test... 17:14:09 INFO - 2015-11-14 17:14:09,564 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVuLThf/profile http://localhost:36917/getInfo.html 17:14:13 INFO - 2015-11-14 17:14:13,038 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:14:13 INFO - 2015-11-14 17:14:13,038 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:14:13 INFO - 2015-11-14 17:14:13,038 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:14:13 INFO - 2015-11-14 17:14:13,038 DEBUG : BROWSER_OUTPUT: __metrics 17:14:13 INFO - 2015-11-14 17:14:13,134 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:14:14 INFO - 2015-11-14 17:14:14,384 INFO : Browser initialized. 17:14:14 INFO - 2015-11-14 17:14:14,384 INFO : Running cycle 1/1 for v8_7 test... 17:14:14 INFO - 2015-11-14 17:14:14,385 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVuLThf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:14:26 INFO - 2015-11-14 17:14:26,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 141119488 17:14:26 INFO - 2015-11-14 17:14:26,156 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36917/tests/v8_7/run.html (next: http://localhost:36917/tests/v8_7/run.html) 17:14:47 INFO - 2015-11-14 17:14:47,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 620974080 17:14:47 INFO - 2015-11-14 17:14:47,810 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,810 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:14:47 INFO - 2015-11-14 17:14:47,810 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:14:47 INFO - 2015-11-14 17:14:47,811 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:14:47 INFO - 2015-11-14 17:14:47,811 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:14:47 INFO - 2015-11-14 17:14:47,811 DEBUG : BROWSER_OUTPUT: |0;Richards;170.50298380221653 17:14:47 INFO - 2015-11-14 17:14:47,811 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.1370607649 17:14:47 INFO - 2015-11-14 17:14:47,812 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.61081385525205 17:14:47 INFO - 2015-11-14 17:14:47,812 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 17:14:47 INFO - 2015-11-14 17:14:47,812 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1100.1100110011 17:14:47 INFO - 2015-11-14 17:14:47,812 DEBUG : BROWSER_OUTPUT: |5;Earley;798.0845969672786 17:14:47 INFO - 2015-11-14 17:14:47,812 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 17:14:47 INFO - 2015-11-14 17:14:47,813 DEBUG : BROWSER_OUTPUT: |7;RegExp;25450 17:14:47 INFO - 2015-11-14 17:14:47,813 DEBUG : BROWSER_OUTPUT: |8;Splay;656.2091503267974 17:14:47 INFO - 2015-11-14 17:14:47,813 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 17:14:47 INFO - 2015-11-14 17:14:47,813 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:14:47 INFO - 2015-11-14 17:14:47,813 DEBUG : BROWSER_OUTPUT: __startTimestamp1447550087809__endTimestamp 17:14:47 INFO - 2015-11-14 17:14:47,813 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,813 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:14:47 INFO - 2015-11-14 17:14:47,814 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:14:47 INFO - 2015-11-14 17:14:47,814 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,814 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.50 Median:170.50 stddev:0.00 (0.0%) 17:14:47 INFO - 2015-11-14 17:14:47,814 DEBUG : BROWSER_OUTPUT: Values: 170.5 17:14:47 INFO - 2015-11-14 17:14:47,814 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,814 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.14 Median:194.14 stddev:0.00 (0.0%) 17:14:47 INFO - 2015-11-14 17:14:47,814 DEBUG : BROWSER_OUTPUT: Values: 194.1 17:14:47 INFO - 2015-11-14 17:14:47,814 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,815 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.61 Median:281.61 stddev:0.00 (0.0%) 17:14:47 INFO - 2015-11-14 17:14:47,815 DEBUG : BROWSER_OUTPUT: Values: 281.6 17:14:47 INFO - 2015-11-14 17:14:47,815 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,815 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 17:14:47 INFO - 2015-11-14 17:14:47,815 DEBUG : BROWSER_OUTPUT: Values: 5025.1 17:14:47 INFO - 2015-11-14 17:14:47,816 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,816 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1100.11 Median:1100.11 stddev:0.00 (0.0%) 17:14:47 INFO - 2015-11-14 17:14:47,816 DEBUG : BROWSER_OUTPUT: Values: 1100.1 17:14:47 INFO - 2015-11-14 17:14:47,816 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,816 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:798.08 Median:798.08 stddev:0.00 (0.0%) 17:14:47 INFO - 2015-11-14 17:14:47,817 DEBUG : BROWSER_OUTPUT: Values: 798.1 17:14:47 INFO - 2015-11-14 17:14:47,817 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,817 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 17:14:47 INFO - 2015-11-14 17:14:47,817 DEBUG : BROWSER_OUTPUT: Values: 12048.2 17:14:47 INFO - 2015-11-14 17:14:47,818 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,818 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 17:14:47 INFO - 2015-11-14 17:14:47,818 DEBUG : BROWSER_OUTPUT: Values: 25450.0 17:14:47 INFO - 2015-11-14 17:14:47,818 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,818 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:656.21 Median:656.21 stddev:0.00 (0.0%) 17:14:47 INFO - 2015-11-14 17:14:47,819 DEBUG : BROWSER_OUTPUT: Values: 656.2 17:14:47 INFO - 2015-11-14 17:14:47,819 DEBUG : BROWSER_OUTPUT: 17:14:47 INFO - 2015-11-14 17:14:47,819 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 17:14:47 INFO - 2015-11-14 17:14:47,819 DEBUG : BROWSER_OUTPUT: Values: 4817.3 17:14:47 INFO - 2015-11-14 17:14:47,819 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:14:47 INFO - 2015-11-14 17:14:47,820 DEBUG : BROWSER_OUTPUT: 17:14:48 INFO - 2015-11-14 17:14:48,703 INFO : Browser exited with error code: 0 17:14:48 INFO - 2015-11-14 17:14:48,722 INFO : Completed test v8_7 (00:00:39) 17:14:48 INFO - 2015-11-14 17:14:48,810 INFO : Completed test suite (00:20:10) 17:14:48 INFO - 2015-11-14 17:14:48,810 DEBUG : Working with test: dromaeo_css 17:14:48 INFO - 2015-11-14 17:14:48,811 DEBUG : Generating results file: dromaeo_css 17:14:48 INFO - 2015-11-14 17:14:48,812 DEBUG : Working with test: kraken 17:14:48 INFO - 2015-11-14 17:14:48,812 DEBUG : Generating results file: kraken 17:14:48 INFO - 2015-11-14 17:14:48,812 INFO : javascript benchmark 17:14:48 INFO - 2015-11-14 17:14:48,812 DEBUG : Working with test: v8_7 17:14:48 INFO - 2015-11-14 17:14:48,812 DEBUG : Generating results file: v8_7 17:14:48 INFO - 2015-11-14 17:14:48,813 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:14:48 INFO - 2015-11-14 17:14:48,873 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:14:48 INFO - 2015-11-14 17:14:48,873 DEBUG : process_Request line: dromaeo_css 6766.70 graph.html#tests=[[72,64,35]] 17:14:48 INFO - 2015-11-14 17:14:48,873 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:14:48 INFO - 2015-11-14 17:14:48,998 DEBUG : process_Request line: kraken 1494.40 graph.html#tests=[[232,64,35]] 17:14:48 INFO - 2015-11-14 17:14:48,998 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:14:49 INFO - 2015-11-14 17:14:49,034 DEBUG : process_Request line: v8_7 20862.73 graph.html#tests=[[230,64,35]] 17:14:49 INFO - 2015-11-14 17:14:49,035 INFO : javascript benchmark 17:14:49 INFO - 2015-11-14 17:14:49,039 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [352.0441999970082, 353.8531509423589, 354.1836067863574, 354.3586109142454, 358.38358024198385, 15199.848001519982, 15232.619184520392, 16761.1619419029, 17150.941886973564, 17875.10624468778, 11299.661010169688, 11633.592824251153, 16996.660066798657, 17636.294548218055, 17670.38153664622, 4428.535003824601, 4529.63762898969, 4532.682712210147, 4532.796024178903, 4533.5013148553635, 3595.6404359564094, 3687.6312368763042, 4460.33095035744, 4477.865664030068, 4931.457539670633, 4966.528179822929, 4985.551300382965, 4989.700617962933, 4994.350734404522, 4996.825111121111, 4837.080954618629, 4944.35723355965, 4947.653664243504, 4973.229149481836, 4977.875553111165, 4347.608715215646, 4366.366876802877, 4371.737695738266, 4372.5627437256335, 4376.321670141133, 13908.304584770722, 14149.858501414958, 14323.85676143246, 14338.64153396163, 14359.569212923629, 1943.8639295249338, 1962.7840937496865, 1985.6227316809905, 2037.7045328427296, 2049.6208201482773, 9459.290553208537, 9579.952100239523, 9722.854157187649, 9783.36408133469, 9971.05274998874, 1609.6056466165865, 1616.8868179227459, 1634.5995231168322, 1637.9672406551922, 1662.6840900229038, 62562.374376256565, 63472.99999999954, 64048.679756601385, 64721.67639161774, 65051.349486505474, 6753.08833307507, 6819.283975182633, 6838.21360543534, 6874.037634731141, 6913.688884000232, 8255.545944972964, 8269.255766981001, 8269.46248493858, 8278.0, 8286.875696864552, 5407.810726624628, 5424.376196737426, 5449.64577302474, 5481.232627432163, 5527.2538207342295, 5569.10894256917, 5582.0, 5585.636933599384, 5587.664740115606, 5633.2395126657375, 3125.702833324145, 3143.685631436838, 3143.827089510099, 3159.778815482894, 3164.905052848418, 1099.483242875847, 1104.3815463340395, 1130.4517309105076, 1161.9825702614467, 1162.767486426064, 470.2147413818931, 480.02794341458826, 482.8044641920028, 486.7541891344919, 497.6889444097439, 11439.0, 11498.193412326722, 11528.135389845795, 11650.30098194111, 11713.472893719803, 447.1481827119343, 484.2324915009749, 484.6946423753013, 486.56695540968565, 490.7325507598367, 5871.148683440877, 6226.5641405101205, 6238.781642642486, 6241.500679945593, 6252.3122456529745, 567355.0, 590465.0, 595242.0, 607679.0, 616084.0, 78801.21198788054, 79541.0, 80036.59890203303, 80449.59775201087, 81904.0, 537.954273886724, 542.8507160530806, 543.2557396367002, 543.2665901033573, 544.1402583917401, 10155.289129761142, 10366.378017318984, 10521.158307335549, 10582.417967011888, 10601.946990265, 34496.827515862264, 34821.12947176341, 35063.948081557595, 35522.82238588791, 35650.8217458911, 45692.54307456883, 45909.0, 48375.75812120917, 49270.26094608512, 52492.0, 6551.770688025897, 6676.933230667825, 6694.430973367318, 6695.564788288746, 6755.324467553205, 11299.43502824839, 11587.478563464496, 11650.6504804856, 11716.88283117192, 11761.0, 10009.399436033862, 10128.29101962885, 10312.587496500357, 10426.113780328757, 10457.320274182153, 9874.259430542881, 10059.094681478702, 10083.344582602107, 10152.644657436955, 10335.121514671337, 9394.0, 9672.274579406432, 10157.39055656663, 10410.68767936963, 10474.895251047392, 6088.634681918922, 6285.5600107992, 6550.7707230246715, 6623.1389919312105, 6626.933730662631, 10003.049710277512, 10091.444970526398, 10157.085862272432, 10164.695059148238, 10204.642837500653], "dojo.html": [3167.667394923533, 3227.3867965086615, 3259.5925509311337, 3265.8856940007104, 3294.687004734549, 5351.0, 5429.104197807362, 5461.399246082938, 5464.562834973202, 5475.698836563993, 5342.439043900393, 5431.701256430894, 5465.644733092357, 5467.20725494803, 5481.671099734019, 4837.250226214934, 4844.418669759634, 4914.606831453475, 4972.279019542164, 5001.249812528132, 5000.52495012975, 5073.949260507385, 5087.592992560605, 5090.287359769617, 5114.1050316194705, 4927.630427717935, 5028.245763135523, 5052.065367906949, 5087.0, 5139.023585518739, 4820.975895120537, 4907.190313598252, 4908.263760435963, 4918.508149185089, 4928.6303527235605, 5039.042581909425, 5039.72281524516, 5062.063518249136, 5070.771815268322, 5093.923591146136, 5184.766685499124, 5204.063268611649, 5291.920621190685, 5385.7576409061685, 5397.0, 5921.407859214087, 5926.8814623707285, 5928.79249226275, 5930.258717660293, 5966.433188847052, 5898.911516327258, 5903.49820265278, 5908.172855800191, 5956.106584012389, 5964.850878728023, 5372.274742909696, 5439.619226654136, 5488.890222195574, 5544.279243698294, 5552.7223638818705, 6020.337762846083, 6052.515798736091, 6075.908861367083, 6084.756609735649, 6092.482139018233, 5858.326292476419, 5871.0, 5878.706064696834, 5884.823455296348, 5924.229850119457, 5694.4590263924865, 5748.338941021836, 5905.881882362414, 5986.431289027535, 6033.276006879202, 5888.146218798251, 5889.116632505073, 5895.380984996599, 5902.409759024149, 5908.911366329508, 5730.598858079978, 5910.172575839386, 5914.9112763308585, 5919.911201331984, 5923.052311630118, 4412.3160910059, 4425.822967081345, 4429.867103986886, 4466.865994020184, 4500.729956202638, 4048.0284731664187, 4054.2296963576828, 4064.532578753422, 4079.143379890197, 4097.836086556505, 5402.0, 5500.697461639568, 5631.746571404296, 5645.0, 5674.858128546819, 5818.825435236865, 5877.970610146922, 5901.645901245939, 5913.881722365529, 5949.405059494103, 5601.551875849922, 5642.7178641067785, 5646.096624540136, 5652.519535839418, 5657.4908258256955, 4959.553640172329, 5023.8492845214705, 5141.948580514147, 5185.429602743695, 5190.221466779938, 6049.667268300198, 6098.817035488943, 6099.237595300588, 6101.938980610137, 6124.14262003311, 5931.525477961839, 5970.0746384310505, 5977.432143946318, 5982.760689572542, 5983.311919129182, 5911.497522710618, 5947.553933455095, 5972.25346831646, 6023.698815059317, 6028.216331876828, 5781.103928891029, 5876.823695289148, 5884.205632239593, 5884.882302353843, 5890.617109887844, 5953.970230148821, 5959.0763431668165, 5971.0744834550715, 5986.341502434641, 5988.850278743066, 5632.971835140798, 5635.0, 5729.341125770423, 5770.913436298543, 5771.249737534094, 5790.420957904176, 5831.271091113611, 5833.970830145822, 5836.883262334814, 5838.065909454467, 5526.751296191601, 5726.427357264407, 5744.540436765133, 5750.453706897838, 5751.4536119068625, 5799.710014499174, 5861.9706901465215, 5928.857675673558, 5964.194833697396, 5994.880102398015, 5736.110902810071, 5743.483086522233, 5760.94239057604, 5768.423157684198, 5788.131780232999], "mootools.html": [1336.9197848129106, 1677.0776073159761, 1738.6261953679964, 1742.9738553921693, 1766.0992893624248, 6627.469802415807, 7503.662335194916, 7696.769096927087, 7704.152543220242, 7706.576138312391, 7500.287472690099, 7733.961330193341, 7741.109772376179, 7745.225477452252, 7757.806054848632, 1943.6987266973642, 1996.6206420780006, 2106.7261256036695, 2122.1617461102855, 2197.439652888519, 2234.6871437998693, 2243.057915675412, 2254.334971183505, 2255.1768604459417, 2259.5254996450767, 2177.3359125466727, 2297.6438652008965, 2300.896459659311, 2310.792028717415, 2318.2002209237785, 1958.1971391729394, 2004.3586052463218, 2220.8001279884807, 2270.0579259607243, 2273.5680220758004, 2274.090363854455, 2281.726192856868, 2329.23135365329, 2330.5804955108074, 2338.029717667166, 7752.651130699132, 7776.494527855728, 7817.0, 7824.33493153077, 7850.0, 4655.301704744315, 4708.293755936603, 4714.599259062949, 4746.572808447257, 4747.216709242971, 2924.093531005395, 2925.6781754007043, 2972.5541168824634, 2972.8364939928297, 3092.659807421182, 917.9403338782957, 924.7087167542203, 930.50683137937, 942.9952850235774, 965.5896244096231, 10742.194335424874, 10751.462426878703, 10768.407737574431, 10785.83821242682, 10799.352038877692, 4132.462779838602, 4184.832606695759, 4237.025484138604, 4251.723637963522, 4276.8289268429535, 9159.77100572491, 9180.954095229481, 9191.218746406497, 9204.95397523008, 9207.907920920705, 4652.418447694038, 4711.67018308722, 4732.52674732524, 4763.571278584944, 4768.976155119271, 4294.098239369705, 4298.505671847777, 4298.742075475481, 4298.871033868989, 4302.397664326997, 3441.397755392796, 3488.494168345576, 3513.4378499440477, 3521.5950165730756, 3532.6643968822923, 1163.947622356996, 1174.723939874129, 1179.0862081886435, 1185.6798664360747, 1186.145974898072, 982.297657175109, 1288.2978776566792, 1301.1217428235902, 1306.046585992212, 1344.919304841693, 6562.475001999828, 7044.189918159374, 7298.489105762652, 7301.671424785897, 7325.047743793273, 710.9680064397114, 721.6391804097951, 1156.9826452603218, 1214.6356093172012, 1231.8644949055597, 5606.943930560724, 5660.858478537987, 5664.0937450007805, 5670.773169073191, 5673.092305231144, 8966.820663586692, 9113.726588202364, 9156.771080722901, 9171.541422928827, 9223.631054757734, 9244.722658320261, 9250.352475326663, 9258.259339252843, 9260.907390926139, 9263.351565390358, 7034.19106802714, 7103.360697537247, 7186.173590037212, 7229.602371869598, 7230.457715671346, 7313.67088481009, 7360.484766066324, 7370.96314518424, 7374.483786134919, 7381.704731810883, 8101.8379632408205, 8166.918330816853, 8199.139090395423, 8217.465864718773, 8362.247397734232, 8426.03100643434, 8459.238668519863, 8605.139486051345, 8609.82780344402, 8612.095729948516, 6896.551724137915, 7098.467614929004, 7099.964500177466, 7108.0, 7112.110986126734, 7362.22696616869, 7436.479446438698, 7437.51656142349, 7441.888371674321, 7448.329650331496, 6881.176488230723, 7079.185893622093, 7152.284771523015, 7273.672684729306, 7318.0, 7052.576845389293, 7069.257727938492, 7108.573485590881, 7111.644417779194, 7161.713531458683, 6431.324710905287, 6607.2071351438135, 6929.75745848913, 6967.407770339578, 6972.302769722987, 6409.519286053472, 6566.244881838458, 6608.6365249909795, 6609.306022867722, 6614.90077648826, 6391.105245265573, 6459.967700161469, 6478.578892371981, 6479.384458476437, 6492.383223593751], "ext.html": [560.6432433510903, 589.3428826858053, 596.3499785234094, 606.2391698418487, 609.6677310865578, 32115.0, 41507.79246103769, 41985.3702194467, 42012.57987420125, 42013.78993105038, 44793.55206447934, 45361.0, 45439.54560454394, 45449.0, 45452.77273613627, 7662.0, 7718.498297610666, 8820.073892241318, 9007.369484136114, 9009.189172974431, 10515.316504427226, 10834.72913177169, 10839.349639021684, 10839.566417343296, 10844.891551084467, 10503.737406564858, 10539.578416863316, 10555.947220263888, 10575.20685948557, 10595.25833191673, 7707.267809558083, 7950.880736788953, 10481.0, 10692.679219623424, 11003.17476189289, 10383.0, 10521.947390263076, 10528.578856845717, 10532.26274160809, 10547.84178237327, 33629.49555756665, 41237.58762412368, 41856.0, 41856.58143418557, 41869.371959420634, 2781.1517487166407, 3102.844857757103, 3234.983825080883, 3271.4765637498126, 3490.406630872758, 30834.229144271347, 30839.845800770854, 30848.0, 32129.678703212903, 32243.6775632243, 3298.224917144469, 3312.850921708529, 3316.034439173815, 3409.0454672691685, 3429.159855835336, 285892.0, 286818.0, 287327.0, 287819.0, 289341.0, 58754.412455874895, 59085.70457147773, 59092.40907590869, 59095.40904590899, 59098.40901591015, 62205.37794622086, 62312.0, 62313.0, 62361.68819155966, 62510.374896251364, 14035.438582456587, 16406.0, 16559.0, 16789.74815377746, 16817.663646726996, 11618.244814087057, 11722.238054526428, 12743.49026038948, 12786.232826030468, 12806.67983300425, 18605.627887442446, 18659.160337784833, 18831.96424196655, 18930.90534547346, 19013.714794278098, 7424.443166762514, 7471.476996610294, 7602.239776022354, 7630.351420129351, 7686.807829804187, 891.4695756025154, 923.9168474837297, 960.4189465373488, 969.049245048814, 1075.1076606416655, 26140.34649133787, 26281.474370512482, 26489.15550993793, 26802.463950720878, 26818.5977210342, 1011.9291649584459, 1066.3655125200494, 1101.6529793115144, 1115.8158903780786, 1140.4981808004452, 14577.0, 14631.414743410145, 14812.407503699731, 15021.549353519413, 15028.09831410119, 342386.0, 346720.0, 348355.0, 349427.0, 349661.0, 51122.0, 51158.23262651063, 51216.743916280924, 51232.48767512352, 51237.74381128071, 1323.5830713325272, 1328.754180476615, 1344.3009634989946, 1346.3604787725947, 1347.7574036673298, 27126.593101103106, 27894.44211115807, 27988.58017129704, 28434.146975590764, 28491.857540712164, 44525.55474445214, 44809.55190448054, 44870.77564612156, 44928.77535612301, 44949.32576011297, 314364.0, 393239.64223398734, 403402.0, 408040.0, 417690.0, 30486.84756576203, 30544.847275763477, 30579.847100764353, 30763.38473230478, 31073.378532429677, 41079.58920410758, 41769.0, 41816.790916045225, 42449.151016980104, 42889.78555107205, 35821.46267806037, 35941.64058359383, 36124.27751445009, 36541.81729091337, 36973.445398319585, 34412.31175376428, 35550.82224588964, 36054.63945360618, 36611.63388366082, 37588.248235034596, 34883.9534813956, 35653.46519802257, 35950.46074308835, 36023.45964810478, 36140.45789313215, 30623.0, 32376.0, 33092.503612446315, 33114.172145695586, 33158.83420582882, 24645.38386540351, 24886.626700599143, 24938.771269253208, 24963.375915602257, 25467.23598292054], "prototype.html": [330.7899483827769, 335.2072348894864, 339.8232918882183, 339.94900764885256, 342.83372564306325, 6036.577439579231, 6082.604630699001, 6109.236345456818, 6118.296395914471, 6140.416660417259, 5752.7411266493, 5864.76540938363, 5891.85270368241, 5966.343702192767, 5994.190784244126, 4531.6601254905845, 4533.705309154894, 4547.295169248771, 4567.1094136643205, 4572.382728331674, 4345.348197770328, 4519.66102542309, 4534.501204867462, 4559.042601053783, 4564.087182563484, 4426.513083560806, 4430.468343798749, 4512.5261847506035, 4534.8639540813665, 4553.908921821561, 4524.954750452503, 4525.230710779176, 4531.161735079021, 4546.54534546546, 4549.454065512126, 3940.921181576381, 3956.6636835868985, 3957.0700885291935, 3959.2873282809082, 3962.623550762673, 5568.443155684399, 5664.801731939404, 5714.685692286923, 5718.685472299022, 5719.799807006735, 5369.919451208235, 5375.435579264199, 5378.46215378463, 5381.273528073699, 5384.326959130109, 6345.0, 6346.143270658495, 6347.96826015867, 6349.682515874188, 6358.332375100594, 4481.417415735966, 4482.932756008662, 4487.214737420971, 4492.146492166478, 4493.41585593874, 6447.4197322241225, 6602.933970660328, 6606.570572912793, 6607.405333519958, 6637.701303441357, 4464.687471877002, 4481.215787237221, 4487.214737420938, 4488.5960263576435, 4489.034857505587, 4528.977355113203, 4534.093181363674, 4534.183846907588, 4534.682572219913, 4537.38745269391, 5291.417944026154, 5296.1261391870685, 5300.840974770763, 5302.072137375943, 5307.256984022163, 6231.408016238541, 6397.360263973658, 6412.871742565216, 6422.646754428458, 6441.227052753699, 1579.6445799694977, 1590.6500569874609, 1591.8089829220567, 1595.226315237109, 1599.5761123302334, 1052.7210289273348, 1061.0821639281965, 1062.3413483640193, 1073.683263437288, 1079.1582565598846, 6201.596896201732, 6209.565330426827, 6211.037289220088, 6211.472024877846, 6212.9068063979075, 6608.603483790892, 6612.0, 6622.503312251601, 6624.138861948012, 6625.801225963229, 6006.099085137177, 6071.241094863142, 6113.113598528189, 6235.345288744707, 6261.123442718023, 3572.732045096628, 3574.9285014299567, 3587.336342776595, 3590.9281814363567, 3596.1908570571413, 6827.69275382609, 6828.726850926007, 6832.658367081725, 6833.760818371333, 6841.247462779091, 6665.200175978914, 6790.898136527956, 6809.421199198124, 6836.692348844214, 6838.965805171042, 6837.589744615339, 6850.38346548813, 6856.794296171123, 6859.588424694434, 6874.037634731041, 6506.3818937200895, 6599.142111525471, 6615.338466153346, 6629.701663425061, 6647.800565983028, 6520.380563846427, 6543.672816359258, 6579.638119903451, 6597.868042639025, 6602.042703807825, 6759.932400676127, 6760.121184246016, 6769.206160367605, 6773.221079575715, 6777.593344399352, 4429.889252768707, 4430.556944305673, 4433.556644335669, 4436.489803672619, 4441.289393696993, 6479.125318081999, 6605.504587155887, 6616.106825578485, 6647.268800431852, 6682.665866706742, 6401.967990160019, 6404.0, 6406.391392817862, 6431.839204019937, 6493.318201588954, 6455.580387274812, 6468.15913931186, 6472.546921715623, 6473.158489396348, 6477.255115661759, 6186.350433204449, 6355.237371515448, 6357.396047375492, 6365.299817020032, 6367.235931688042, 6505.2844187138435, 6507.0, 6514.1531600891585, 6515.218173819172, 6516.413522782972, 6205.131281620486, 6322.209723784527, 6367.458766004756, 6373.171487706754, 6375.489960803032], "yui.html": [757.9696812127515, 776.4603600497653, 813.6663967773211, 844.8014716541612, 880.4013270975738, 13544.864551354483, 13826.101303415297, 13874.999999999987, 13875.306234688263, 13915.652108697288, 12931.224126552414, 13441.932790336059, 13455.663608409795, 13475.326233688325, 13481.460741570325, 696.5890124826351, 702.0487239790087, 821.8356328734247, 821.9506829590214, 839.4627438439404, 842.4945032980224, 846.0, 850.3409857360533, 852.7399143261302, 852.9658813647446, 868.5309932636369, 873.5719497446237, 874.7813046738315, 874.8862647855769, 875.308506280038, 721.5093736259341, 729.1286912139994, 862.6635612111281, 877.8507653698887, 878.2008372381102, 645.1033064040987, 645.180620611825, 645.2966266769197, 645.5868244323636, 645.8320836582523, 13963.441462341494, 14120.435182592684, 14159.150450972871, 14164.29178541079, 14168.716625667532, 11489.195756296978, 11540.081565502678, 11696.12279079064, 12012.579559715456, 12035.338056406894, 10672.839907401396, 10732.839007414817, 10736.838947415717, 10740.677779666623, 10841.512131954081, 3418.265073009315, 3507.6843084122297, 3539.982300088483, 3562.536870206882, 3562.71498280137, 48335.0, 48587.0, 48855.0, 48894.266586001235, 48934.0, 9548.8063992001, 9797.755056123511, 10007.649732259337, 10043.397396156253, 10212.131968782589, 17883.1952562135, 17895.10524473771, 17911.552211194823, 17947.0, 18020.909895450437, 7575.0, 7592.962035189788, 7802.219778022152, 7886.526808391515, 7890.526568405914, 4164.708470407042, 4189.05746207107, 4244.702870799076, 4297.548757380492, 4337.0892112656065, 3067.6165479315086, 3071.9539206911913, 3094.056312824565, 3100.2404410919016, 3102.2399512119223, 456.44085994656945, 464.3220897489703, 475.9262314341283, 477.5821156488073, 480.74520504132863, 544.0506316477772, 625.5964902637774, 663.6548994522822, 666.1007639686385, 709.6841905352172, 8834.55827208637, 8837.0, 8909.465432074096, 9043.366964312436, 9122.726318210463, 538.859896426924, 687.0610100291085, 701.4738945790657, 706.6254884911006, 721.5418209437046, 4152.626263636287, 4368.235558777201, 4374.825006999748, 4488.0, 4498.617617502549, 55438.0, 55593.444065558826, 55960.72019639957, 56053.0, 56134.43865561292, 47525.76237118792, 48066.0, 48081.51918480841, 48322.0, 48671.75664121657, 43115.13769724588, 43275.78362108232, 43909.56090439118, 44016.3397549037, 44145.11709765851, 9034.86447703272, 9128.224100951493, 9213.12475314844, 9226.907730922605, 9239.76900577491, 34980.0, 36171.27657446784, 36268.27463450769, 36304.0, 36936.0, 42635.786821065696, 43270.350944736485, 45857.77071114623, 46675.29987050129, 46820.0, 11429.199956003, 11743.706407339885, 11897.345645989553, 12029.939850300692, 12061.939690301493, 12450.315232661927, 12527.559330677088, 12559.811602825783, 12900.677483062998, 12907.677308067374, 11331.0, 11513.30920144794, 11695.239809412362, 11708.531658733555, 11954.282743035446, 11052.447377631248, 11427.142964277546, 11518.308901465938, 11583.536658533902, 11773.17587768848, 11442.599509017144, 11598.18812683104, 11717.882821172021, 11903.958056123794, 11921.284722916653, 9995.300328976902, 10229.641962531276, 10269.537870795682, 10417.0, 10421.322614030063, 8974.237189838937, 9258.35191536586, 9409.717708468757, 9462.243020558477, 10027.649032283834]}, "summary": {"lowerIsBetter": false, "suite": 6766.701088377495, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6859.144156695086, "unit": "ms", "value": 6859.144156695086}, "dojo.html": {"lowerIsBetter": false, "filtered": 5437.984231738215, "unit": "ms", "value": 5437.984231738215}, "mootools.html": {"lowerIsBetter": false, "filtered": 4447.966702081783, "unit": "ms", "value": 4447.966702081783}, "ext.html": {"lowerIsBetter": false, "filtered": 18939.932866717583, "unit": "ms", "value": 18939.932866717583}, "prototype.html": {"lowerIsBetter": false, "filtered": 4809.475081675026, "unit": "ms", "value": 4809.475081675026}, "yui.html": {"lowerIsBetter": false, "filtered": 6351.541073244225, "unit": "ms", "value": 6351.541073244225}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-035"}, "testrun": {"date": 1447548878, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114143008", "branch": "Fx-Team", "revision": "41b5c629c4a00f41b9b85a4521cf62a726bf4c7f"}}, {"talos_counters": {}, "results": {"audio-dft": [159.0, 160.0, 161.0, 159.0, 160.0, 160.0, 161.0, 163.0, 161.0, 164.0], "ai-astar": [111.0, 112.0, 103.0, 109.0, 110.0, 110.0, 98.0, 109.0, 110.0, 112.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "audio-beat-detection": [151.0, 132.0, 147.0, 163.0, 125.0, 150.0, 150.0, 132.0, 161.0, 124.0], "json-stringify-tinderbox": [68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0], "stanford-crypto-pbkdf2": [140.0, 151.0, 152.0, 151.0, 149.0, 141.0, 156.0, 152.0, 150.0, 153.0], "json-parse-financial": [58.0, 57.0, 57.0, 57.0, 57.0, 60.0, 57.0, 66.0, 56.0, 55.0], "stanford-crypto-sha256-iterative": [66.0, 66.0, 70.0, 67.0, 67.0, 69.0, 67.0, 67.0, 65.0, 68.0], "audio-fft": [72.0, 80.0, 89.0, 95.0, 71.0, 71.0, 71.0, 100.0, 91.0, 71.0], "imaging-darkroom": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "stanford-crypto-ccm": [114.0, 123.0, 120.0, 113.0, 116.0, 120.0, 116.0, 115.0, 115.0, 129.0], "audio-oscillator": [90.0, 91.0, 138.0, 90.0, 91.0, 90.0, 132.0, 91.0, 90.0, 132.0], "stanford-crypto-aes": [91.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 87.0, 87.0, 93.0], "imaging-desaturate": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1494.4, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.1, "unit": "ms", "value": 81.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.5, "unit": "ms", "value": 149.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.5, "unit": "ms", "value": 143.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 118.1, "unit": "ms", "value": 118.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.2, "unit": "ms", "value": 145.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.0, "unit": "ms", "value": 58.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.5, "unit": "ms", "value": 103.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.4, "unit": "ms", "value": 108.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.8, "unit": "ms", "value": 160.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.2, "unit": "ms", "value": 67.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.2, "unit": "ms", "value": 68.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.0, "unit": "ms", "value": 109.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.4, "unit": "ms", "value": 86.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.5, "unit": "ms", "value": 95.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-035"}, "testrun": {"date": 1447548878, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114143008", "branch": "Fx-Team", "revision": "41b5c629c4a00f41b9b85a4521cf62a726bf4c7f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.1370607649], "Encrypt": [281.61081385525205], "NavierStokes": [4817.307692307692], "Decrypt": [5025.125628140703], "Splay": [656.2091503267974], "Richards": [170.50298380221653], "RegExp": [25450.0], "Earley": [798.0845969672786], "Boyer": [12048.192771084337], "RayTrace": [1100.1100110011]}, "summary": {"lowerIsBetter": false, "suite": 20862.72631187909, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.5738179999999, "unit": "score", "value": 340.5738179999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 945.2087309999996, "unit": "score", "value": 945.2087309999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 308.055888223553, "unit": "score", "value": 308.055888223553}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.970019, "unit": "score", "value": 52.970019}, "Splay": {"lowerIsBetter": false, "filtered": 124.1844920318725, "unit": "score", "value": 124.1844920318725}, "RegExp": {"lowerIsBetter": false, "filtered": 35.79508840864438, "unit": "score", "value": 35.79508840864438}, "Richards": {"lowerIsBetter": false, "filtered": 207.04623000000007, "unit": "score", "value": 207.04623000000007}, "Earley": {"lowerIsBetter": false, "filtered": 835.078139, "unit": "score", "value": 835.078139}, "Boyer": {"lowerIsBetter": false, "filtered": 55.31642899999996, "unit": "score", "value": 55.31642899999996}, "RayTrace": {"lowerIsBetter": false, "filtered": 672.6500009999999, "unit": "score", "value": 672.6500009999999}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-035"}, "testrun": {"date": 1447548878, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114143008", "branch": "Fx-Team", "revision": "41b5c629c4a00f41b9b85a4521cf62a726bf4c7f"}}] 17:14:49 INFO - RETURN: dromaeo_css: 6766.70 17:14:49 INFO - RETURN: kraken: 1494.40 17:14:49 INFO - RETURN: v8_7: 20862.73 17:14:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20862.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1494.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6766.70"}}} 17:14:49 INFO - Return code: 0 17:14:49 INFO - # TBPL SUCCESS # 17:14:49 INFO - Running post-action listener: _resource_record_post_action 17:14:49 INFO - Running post-run listener: _resource_record_post_run 17:14:50 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 495808512; Read time: 16; Write time: 367072 17:14:50 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 155656192; Read time: 0; Write time: 109564 17:14:50 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 265920512; Read time: 0; Write time: 157464 17:14:50 INFO - Running post-run listener: _upload_blobber_files 17:14:50 INFO - Blob upload gear active. 17:14:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:14:50 INFO - Copying logs to upload dir... 17:14:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.345403 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-14 17:14:49.363495) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 17:14:49.368360) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008819 build_url: 'https://queue.taskcluster.net/v1/task/WAwNXHoWSzGeCsxh9zM48Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 17:14:49.393702) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 17:14:49.394065) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447547402.374298-1962051654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 17:14:49.443526) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 17:14:49.443828) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 17:14:49.444908) ========= ========= Total master_lag: 0.36 =========