builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1447944665.81 results: success (0) buildid: 20151119053001 builduid: b14e5f382b7f4597830e0ec69772a14c revision: 9a49075671cb62db97b9567a510a0bb361c9114a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:05.807704) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:05.808485) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:05.808915) ========= 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=5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006717 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:05.830428) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:05.830783) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:05.844751) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:05.845157) ========= 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=5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:05.894841) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:05.895158) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:05.895578) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:05.895877) ========= 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=5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 06:51:06-- 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% 84.0M=0s 2015-11-19 06:51:06 (84.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098641 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.007226) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.007555) ========= 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=5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022124 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.057885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.058266) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9a49075671cb62db97b9567a510a0bb361c9114a --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 9a49075671cb62db97b9567a510a0bb361c9114a --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=5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 06:51:06,671 truncating revision to first 12 chars 2015-11-19 06:51:06,671 Setting DEBUG logging. 2015-11-19 06:51:06,671 attempt 1/10 2015-11-19 06:51:06,671 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9a49075671cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 06:51:07,121 unpacking tar archive at: fx-team-9a49075671cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.718961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.796248) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.796553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.810338) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.810676) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.811148) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-19 06:51:06.811522) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:51:07 INFO - MultiFileLogger online at 20151119 06:51:07 in /builds/slave/test-pgo 06:51:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 06:51:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:51:07 INFO - {'append_to_log': False, 06:51:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:51:07 INFO - 'blob_upload_branch': 'Fx-Team', 06:51:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:51:07 INFO - 'branch': 'Fx-Team', 06:51:07 INFO - 'buildbot_json_path': 'buildprops.json', 06:51:07 INFO - 'config_files': ('talos/linux_config.py',), 06:51:07 INFO - 'default_actions': ('clobber', 06:51:07 INFO - 'read-buildbot-config', 06:51:07 INFO - 'download-and-extract', 06:51:07 INFO - 'populate-webroot', 06:51:07 INFO - 'create-virtualenv', 06:51:07 INFO - 'install', 06:51:07 INFO - 'run-tests'), 06:51:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:51:07 INFO - 'download_minidump_stackwalk': True, 06:51:07 INFO - 'download_symbols': 'ondemand', 06:51:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:51:07 INFO - 'tooltool.py': '/tools/tooltool.py', 06:51:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:51:07 INFO - '/tools/misc-python/virtualenv.py')}, 06:51:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:51:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:51:07 INFO - 'installer_path': 'installer.exe', 06:51:07 INFO - 'log_level': 'info', 06:51:07 INFO - 'log_name': 'talos', 06:51:07 INFO - 'log_to_console': True, 06:51:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:51:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:51:07 INFO - 'opt_config_files': (), 06:51:07 INFO - 'pip_index': False, 06:51:07 INFO - 'sps_profile': False, 06:51:07 INFO - 'sps_profile_interval': 0, 06:51:07 INFO - 'suite': 'dromaeojs-e10s', 06:51:07 INFO - 'system_bits': '64', 06:51:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:51:07 INFO - 'title': 'talos-linux64-ix-059', 06:51:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:51:07 INFO - 'use_talos_json': True, 06:51:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:51:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:51:07 INFO - 'work_dir': 'build'} 06:51:07 INFO - ##### 06:51:07 INFO - ##### Running clobber step. 06:51:07 INFO - ##### 06:51:07 INFO - Running pre-action listener: _resource_record_pre_action 06:51:07 INFO - Running main action method: clobber 06:51:07 INFO - rmtree: /builds/slave/test-pgo/build 06:51:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:51:07 INFO - Running post-action listener: _resource_record_post_action 06:51:07 INFO - ##### 06:51:07 INFO - ##### Running read-buildbot-config step. 06:51:07 INFO - ##### 06:51:07 INFO - Running pre-action listener: _resource_record_pre_action 06:51:07 INFO - Running main action method: read_buildbot_config 06:51:07 INFO - Using buildbot properties: 06:51:07 INFO - { 06:51:07 INFO - "properties": { 06:51:07 INFO - "buildnumber": 97, 06:51:07 INFO - "product": "firefox", 06:51:07 INFO - "script_repo_revision": "production", 06:51:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:51:07 INFO - "repository": "", 06:51:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 06:51:07 INFO - "buildid": "20151119053001", 06:51:07 INFO - "slavename": "talos-linux64-ix-059", 06:51:07 INFO - "pgo_build": "True", 06:51:07 INFO - "basedir": "/builds/slave/test-pgo", 06:51:07 INFO - "project": "", 06:51:07 INFO - "platform": "ubuntu64_hw", 06:51:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:51:07 INFO - "slavebuilddir": "test", 06:51:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:51:07 INFO - "branch": "fx-team", 06:51:07 INFO - "repo_path": "integration/fx-team", 06:51:07 INFO - "stage_platform": "linux64-pgo", 06:51:07 INFO - "builduid": "b14e5f382b7f4597830e0ec69772a14c", 06:51:07 INFO - "revision": "9a49075671cb62db97b9567a510a0bb361c9114a" 06:51:07 INFO - }, 06:51:07 INFO - "sourcestamp": { 06:51:07 INFO - "repository": "", 06:51:07 INFO - "hasPatch": false, 06:51:07 INFO - "project": "", 06:51:07 INFO - "branch": "fx-team-linux64-pgo-talos", 06:51:07 INFO - "changes": [ 06:51:07 INFO - { 06:51:07 INFO - "category": null, 06:51:07 INFO - "files": [ 06:51:07 INFO - { 06:51:07 INFO - "url": null, 06:51:07 INFO - "name": "https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:51:07 INFO - } 06:51:07 INFO - ], 06:51:07 INFO - "repository": "", 06:51:07 INFO - "rev": "9a49075671cb62db97b9567a510a0bb361c9114a", 06:51:07 INFO - "who": "sendchange", 06:51:07 INFO - "when": 1447944630, 06:51:07 INFO - "number": 6682773, 06:51:07 INFO - "comments": "", 06:51:07 INFO - "project": "", 06:51:07 INFO - "at": "Thu 19 Nov 2015 06:50:30", 06:51:07 INFO - "branch": "fx-team-linux64-pgo-talos", 06:51:07 INFO - "revlink": "", 06:51:07 INFO - "properties": [ 06:51:07 INFO - [ 06:51:07 INFO - "buildid", 06:51:07 INFO - "20151119053001", 06:51:07 INFO - "Change" 06:51:07 INFO - ], 06:51:07 INFO - [ 06:51:07 INFO - "builduid", 06:51:07 INFO - "b14e5f382b7f4597830e0ec69772a14c", 06:51:07 INFO - "Change" 06:51:07 INFO - ], 06:51:07 INFO - [ 06:51:07 INFO - "pgo_build", 06:51:07 INFO - "True", 06:51:07 INFO - "Change" 06:51:07 INFO - ] 06:51:07 INFO - ], 06:51:07 INFO - "revision": "9a49075671cb62db97b9567a510a0bb361c9114a" 06:51:07 INFO - } 06:51:07 INFO - ], 06:51:07 INFO - "revision": "9a49075671cb62db97b9567a510a0bb361c9114a" 06:51:07 INFO - } 06:51:07 INFO - } 06:51:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:51:07 INFO - Running post-action listener: _resource_record_post_action 06:51:07 INFO - ##### 06:51:07 INFO - ##### Running download-and-extract step. 06:51:07 INFO - ##### 06:51:07 INFO - Running pre-action listener: _resource_record_pre_action 06:51:07 INFO - Running main action method: download_and_extract 06:51:07 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:07 INFO - https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:51:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/test_packages.json 06:51:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/test_packages.json 06:51:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:51:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:51:23 INFO - Downloaded 1302 bytes. 06:51:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:51:23 INFO - Using the following test package requirements: 06:51:23 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:23 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:51:23 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:23 INFO - u'jsshell-linux-x86_64.zip'], 06:51:23 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:51:23 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:23 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:51:23 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:51:23 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:51:23 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:23 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:51:23 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:51: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')]} 06:51:23 INFO - https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:30 INFO - Downloaded 22474801 bytes. 06:51:30 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 06:51:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:30 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 06:51:31 INFO - Return code: 0 06:51:31 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 06:51:31 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')]} 06:51:31 INFO - https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:32 INFO - Downloaded 22474801 bytes. 06:51:32 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 06:51:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:32 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 06:51:33 INFO - Return code: 0 06:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:33 INFO - https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:51:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:34 INFO - Downloaded 11130997 bytes. 06:51:34 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 06:51:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:34 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 06:51:34 INFO - Return code: 0 06:51:34 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')]} 06:51:34 INFO - https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:51:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:41 INFO - Downloaded 57204736 bytes. 06:51:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:41 INFO - mkdir: /builds/slave/test-pgo/properties 06:51:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:51:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:51:41 INFO - Contents: 06:51:41 INFO - build_url:https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:41 INFO - Running post-action listener: _resource_record_post_action 06:51:41 INFO - Running post-action listener: set_extra_try_arguments 06:51:41 INFO - ##### 06:51:41 INFO - ##### Running populate-webroot step. 06:51:41 INFO - ##### 06:51:41 INFO - Running pre-action listener: _resource_record_pre_action 06:51:41 INFO - Running main action method: populate_webroot 06:51:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:41 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:51:41 INFO - '../fennec_ids.txt'], 06:51:41 INFO - 'tests': ['tcheck2']}, 06:51:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:41 INFO - '--tppagecycles', 06:51:41 INFO - '7'], 06:51:41 INFO - 'tests': ['tsvgm']}}, 06:51:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:51:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:51:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:51:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:51:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:51:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:41 INFO - 'talos_options': ['--e10s'], 06:51:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:41 INFO - 'tests': ['damp', 'tps']}, 06:51:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:41 INFO - 'talos_options': ['--e10s'], 06:51:41 INFO - 'tests': ['damp', 'tps']}, 06:51:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:51:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:41 INFO - 'other': {'tests': ['a11yr', 06:51:41 INFO - 'ts_paint', 06:51:41 INFO - 'tpaint', 06:51:41 INFO - 'sessionrestore', 06:51:41 INFO - 'sessionrestore_no_auto_restore']}, 06:51:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:51:41 INFO - 'tests': ['a11yr', 06:51:41 INFO - 'ts_paint', 06:51:41 INFO - 'tpaint', 06:51:41 INFO - 'sessionrestore', 06:51:41 INFO - 'sessionrestore_no_auto_restore']}, 06:51:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:51:41 INFO - 'tests': ['a11yr', 06:51:41 INFO - 'ts_paint', 06:51:41 INFO - 'tpaint', 06:51:41 INFO - 'sessionrestore', 06:51:41 INFO - 'sessionrestore_no_auto_restore']}, 06:51:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:51:41 INFO - 'tests': ['a11yr', 06:51:41 INFO - 'ts_paint', 06:51:41 INFO - 'tpaint', 06:51:41 INFO - 'sessionrestore', 06:51:41 INFO - 'sessionrestore_no_auto_restore']}, 06:51:41 INFO - 'other_l64': {'tests': ['a11yr', 06:51:41 INFO - 'ts_paint', 06:51:41 INFO - 'tpaint', 06:51:41 INFO - 'sessionrestore', 06:51:41 INFO - 'sessionrestore_no_auto_restore']}, 06:51:41 INFO - 'other_nol64': {'tests': ['a11yr', 06:51:41 INFO - 'ts_paint', 06:51:41 INFO - 'tpaint', 06:51:41 INFO - 'sessionrestore', 06:51:41 INFO - 'sessionrestore_no_auto_restore']}, 06:51:41 INFO - 'svgr': {'tests': ['tsvgx', 06:51:41 INFO - 'tsvgr_opacity', 06:51:41 INFO - 'tart', 06:51:41 INFO - 'tscrollx', 06:51:41 INFO - 'cart']}, 06:51:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:51:41 INFO - 'tests': ['tsvgx', 06:51:41 INFO - 'tsvgr_opacity', 06:51:41 INFO - 'tart', 06:51:41 INFO - 'tscrollx', 06:51:41 INFO - 'cart']}, 06:51:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:41 INFO - 'tests': ['tp5o']}, 06:51:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:41 INFO - 'talos_options': ['--e10s'], 06:51:41 INFO - 'tests': ['tp5o']}, 06:51:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:41 INFO - 'talos_options': ['--xperf_path', 06:51:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:41 INFO - 'tests': ['tp5n']}, 06:51:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:41 INFO - 'talos_options': ['--e10s', 06:51:41 INFO - '--xperf_path', 06:51:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:41 INFO - 'tests': ['tp5n']}}, 06:51:41 INFO - 'talos.zip': {'path': '', 06:51:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:41 INFO - Running post-action listener: _resource_record_post_action 06:51:41 INFO - ##### 06:51:41 INFO - ##### Running create-virtualenv step. 06:51:41 INFO - ##### 06:51:41 INFO - Running pre-action listener: _resource_record_pre_action 06:51:41 INFO - Running main action method: create_virtualenv 06:51:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:51:41 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 06:51:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:51:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:41 INFO - Using real prefix '/usr' 06:51:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:51:41 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:43 INFO - Installing pip.................done. 06:51:43 INFO - Return code: 0 06:51:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:51:43 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')]} 06:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:43 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')]} 06:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:43 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 0x7f6669f5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24886e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bea90>, '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 0x2510f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25112e0>, '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': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', '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 06:51:43 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 06:51:43 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 06:51:43 INFO - Using env: {'DISPLAY': ':0', 06:51:43 INFO - 'HOME': '/home/cltbld', 06:51:43 INFO - 'LANG': 'en_US.UTF-8', 06:51:43 INFO - 'LANGUAGE': 'en_US:en', 06:51:43 INFO - 'LOGNAME': 'cltbld', 06:51:43 INFO - 'MAIL': '/var/mail/cltbld', 06:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:43 INFO - 'MOZ_NO_REMOTE': '1', 06:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:43 INFO - 'NO_EM_RESTART': '1', 06:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:43 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:43 INFO - 'SHELL': '/bin/bash', 06:51:43 INFO - 'SHLVL': '1', 06:51:43 INFO - 'TERM': 'linux', 06:51:43 INFO - 'TMOUT': '86400', 06:51:43 INFO - 'USER': 'cltbld', 06:51:43 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', 06:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:43 INFO - '_': '/tools/buildbot/bin/python'} 06:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:44 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 06:51:44 INFO - Cleaning up... 06:51:44 INFO - Return code: 0 06:51:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:51:44 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')]} 06:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:44 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')]} 06:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:44 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 0x7f6669f5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24886e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bea90>, '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 0x2510f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25112e0>, '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': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', '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 06:51:44 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 06:51:44 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 06:51:44 INFO - Using env: {'DISPLAY': ':0', 06:51:44 INFO - 'HOME': '/home/cltbld', 06:51:44 INFO - 'LANG': 'en_US.UTF-8', 06:51:44 INFO - 'LANGUAGE': 'en_US:en', 06:51:44 INFO - 'LOGNAME': 'cltbld', 06:51:44 INFO - 'MAIL': '/var/mail/cltbld', 06:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:44 INFO - 'MOZ_NO_REMOTE': '1', 06:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:44 INFO - 'NO_EM_RESTART': '1', 06:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:44 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:44 INFO - 'SHELL': '/bin/bash', 06:51:44 INFO - 'SHLVL': '1', 06:51:44 INFO - 'TERM': 'linux', 06:51:44 INFO - 'TMOUT': '86400', 06:51:44 INFO - 'USER': 'cltbld', 06:51:44 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', 06:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:44 INFO - '_': '/tools/buildbot/bin/python'} 06:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:44 INFO - Downloading/unpacking psutil>=0.7.1 06:51:44 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 06:51:44 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 06:51:44 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 06:51:44 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 06:51:44 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 06:51:44 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 06:51:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:51:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:51:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:51:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:46 INFO - Installing collected packages: psutil 06:51:46 INFO - Running setup.py install for psutil 06:51:46 INFO - building 'psutil._psutil_linux' extension 06:51:46 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 06:51:46 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 06:51:46 INFO - building 'psutil._psutil_posix' extension 06:51:46 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 06:51:46 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 06:51:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:46 INFO - Successfully installed psutil 06:51:46 INFO - Cleaning up... 06:51:46 INFO - Return code: 0 06:51:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:46 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 0x7f6669f5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24886e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bea90>, '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 0x2510f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25112e0>, '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': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', '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 06:51:46 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 06:51:46 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 06:51:46 INFO - Using env: {'DISPLAY': ':0', 06:51:46 INFO - 'HOME': '/home/cltbld', 06:51:46 INFO - 'LANG': 'en_US.UTF-8', 06:51:46 INFO - 'LANGUAGE': 'en_US:en', 06:51:46 INFO - 'LOGNAME': 'cltbld', 06:51:46 INFO - 'MAIL': '/var/mail/cltbld', 06:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:46 INFO - 'MOZ_NO_REMOTE': '1', 06:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:46 INFO - 'NO_EM_RESTART': '1', 06:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:46 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:46 INFO - 'SHELL': '/bin/bash', 06:51:46 INFO - 'SHLVL': '1', 06:51:46 INFO - 'TERM': 'linux', 06:51:46 INFO - 'TMOUT': '86400', 06:51:46 INFO - 'USER': 'cltbld', 06:51:46 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', 06:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:46 INFO - '_': '/tools/buildbot/bin/python'} 06:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:51:46 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 06:51:46 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 06:51:46 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 06:51:46 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 06:51:46 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 06:51:46 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 06:51:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:51:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:51:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:51:48 INFO - Installing collected packages: mozsystemmonitor 06:51:48 INFO - Running setup.py install for mozsystemmonitor 06:51:48 INFO - Successfully installed mozsystemmonitor 06:51:48 INFO - Cleaning up... 06:51:48 INFO - Return code: 0 06:51:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:51:48 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')]} 06:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:48 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')]} 06:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:48 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 0x7f6669f5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24886e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bea90>, '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 0x2510f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25112e0>, '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': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', '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 06:51:48 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 06:51:48 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 06:51:48 INFO - Using env: {'DISPLAY': ':0', 06:51:48 INFO - 'HOME': '/home/cltbld', 06:51:48 INFO - 'LANG': 'en_US.UTF-8', 06:51:48 INFO - 'LANGUAGE': 'en_US:en', 06:51:48 INFO - 'LOGNAME': 'cltbld', 06:51:48 INFO - 'MAIL': '/var/mail/cltbld', 06:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:48 INFO - 'MOZ_NO_REMOTE': '1', 06:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:48 INFO - 'NO_EM_RESTART': '1', 06:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:48 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:48 INFO - 'SHELL': '/bin/bash', 06:51:48 INFO - 'SHLVL': '1', 06:51:48 INFO - 'TERM': 'linux', 06:51:48 INFO - 'TMOUT': '86400', 06:51:48 INFO - 'USER': 'cltbld', 06:51:48 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', 06:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:48 INFO - '_': '/tools/buildbot/bin/python'} 06:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:48 INFO - Downloading/unpacking blobuploader==1.2.4 06:51:48 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 06:51:48 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 06:51:48 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 06:51:48 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 06:51:48 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 06:51:48 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 06:51:50 INFO - Downloading blobuploader-1.2.4.tar.gz 06:51:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:51:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:51:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:51:50 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 06:51:50 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 06:51:50 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 06:51:50 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 06:51:50 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 06:51:50 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 06:51:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:51:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:51:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:51 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 06:51:51 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 06:51:51 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 06:51:51 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 06:51:51 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 06:51:51 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 06:51:51 INFO - Downloading docopt-0.6.1.tar.gz 06:51:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:51:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:51 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:51 INFO - Running setup.py install for blobuploader 06:51:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:51:51 INFO - Running setup.py install for requests 06:51:51 INFO - Running setup.py install for docopt 06:51:51 INFO - Successfully installed blobuploader requests docopt 06:51:51 INFO - Cleaning up... 06:51:51 INFO - Return code: 0 06:51:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:51 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 0x7f6669f5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24886e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bea90>, '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 0x2510f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25112e0>, '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': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', '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 06:51:51 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 06:51:51 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 06:51:51 INFO - Using env: {'DISPLAY': ':0', 06:51:51 INFO - 'HOME': '/home/cltbld', 06:51:51 INFO - 'LANG': 'en_US.UTF-8', 06:51:51 INFO - 'LANGUAGE': 'en_US:en', 06:51:51 INFO - 'LOGNAME': 'cltbld', 06:51:51 INFO - 'MAIL': '/var/mail/cltbld', 06:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:51 INFO - 'MOZ_NO_REMOTE': '1', 06:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:51 INFO - 'NO_EM_RESTART': '1', 06:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:51 INFO - 'SHELL': '/bin/bash', 06:51:51 INFO - 'SHLVL': '1', 06:51:51 INFO - 'TERM': 'linux', 06:51:51 INFO - 'TMOUT': '86400', 06:51:51 INFO - 'USER': 'cltbld', 06:51:51 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', 06:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:51 INFO - '_': '/tools/buildbot/bin/python'} 06:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:52 INFO - Running setup.py (path:/tmp/pip-zzjkiN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:52 INFO - Running setup.py (path:/tmp/pip-i1YA6f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:52 INFO - Running setup.py (path:/tmp/pip-PxvxOQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:52 INFO - Running setup.py (path:/tmp/pip-YHZW56-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:52 INFO - Running setup.py (path:/tmp/pip-mtRVtC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:52 INFO - Running setup.py (path:/tmp/pip-RnxXbv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:52 INFO - Running setup.py (path:/tmp/pip-cUhTgh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:52 INFO - Running setup.py (path:/tmp/pip-9Zy8KN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:52 INFO - Running setup.py (path:/tmp/pip-kFG0qB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:52 INFO - Running setup.py (path:/tmp/pip-zYT1Qu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:52 INFO - Running setup.py (path:/tmp/pip-TTMigE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:52 INFO - Running setup.py (path:/tmp/pip-xPiohQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:53 INFO - Running setup.py (path:/tmp/pip-Pez746-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:53 INFO - Running setup.py (path:/tmp/pip-x7lbyo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:53 INFO - Running setup.py (path:/tmp/pip-DGey3h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:53 INFO - Running setup.py (path:/tmp/pip-WVN0r4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:53 INFO - Running setup.py (path:/tmp/pip-Lu4D0G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:51:53 INFO - Running setup.py install for manifestparser 06:51:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:51:53 INFO - Running setup.py install for mozcrash 06:51:53 INFO - Running setup.py install for mozdebug 06:51:53 INFO - Running setup.py install for mozdevice 06:51:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:51:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:51:53 INFO - Running setup.py install for mozfile 06:51:53 INFO - Running setup.py install for mozhttpd 06:51:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:51:53 INFO - Running setup.py install for mozinfo 06:51:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:51:54 INFO - Running setup.py install for mozInstall 06:51:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:51:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:51:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:51:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:51:54 INFO - Running setup.py install for mozleak 06:51:54 INFO - Running setup.py install for mozlog 06:51:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:51:54 INFO - Running setup.py install for moznetwork 06:51:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:51:54 INFO - Running setup.py install for mozprocess 06:51:54 INFO - Running setup.py install for mozprofile 06:51:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:51:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:51:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:51:54 INFO - Running setup.py install for mozrunner 06:51:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:51:54 INFO - Running setup.py install for mozscreenshot 06:51:54 INFO - Running setup.py install for moztest 06:51:55 INFO - Running setup.py install for mozversion 06:51:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:51:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:51:55 INFO - Cleaning up... 06:51:55 INFO - Return code: 0 06:51:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:55 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 0x7f6669f5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24886e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bea90>, '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 0x2510f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25112e0>, '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': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', '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 06:51:55 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 06:51:55 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 06:51:55 INFO - Using env: {'DISPLAY': ':0', 06:51:55 INFO - 'HOME': '/home/cltbld', 06:51:55 INFO - 'LANG': 'en_US.UTF-8', 06:51:55 INFO - 'LANGUAGE': 'en_US:en', 06:51:55 INFO - 'LOGNAME': 'cltbld', 06:51:55 INFO - 'MAIL': '/var/mail/cltbld', 06:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:55 INFO - 'MOZ_NO_REMOTE': '1', 06:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:55 INFO - 'NO_EM_RESTART': '1', 06:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:55 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:55 INFO - 'SHELL': '/bin/bash', 06:51:55 INFO - 'SHLVL': '1', 06:51:55 INFO - 'TERM': 'linux', 06:51:55 INFO - 'TMOUT': '86400', 06:51:55 INFO - 'USER': 'cltbld', 06:51:55 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', 06:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:55 INFO - '_': '/tools/buildbot/bin/python'} 06:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:55 INFO - Running setup.py (path:/tmp/pip-TUrTgz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:55 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)) 06:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:55 INFO - Running setup.py (path:/tmp/pip-Cjl5xJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:55 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)) 06:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:55 INFO - Running setup.py (path:/tmp/pip-G7mshH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:55 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)) 06:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:55 INFO - Running setup.py (path:/tmp/pip-aPj2k3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:55 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)) 06:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:55 INFO - Running setup.py (path:/tmp/pip-7zEjmm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:55 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)) 06:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:55 INFO - Running setup.py (path:/tmp/pip-pbTlsL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:55 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)) 06:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:55 INFO - Running setup.py (path:/tmp/pip-si6zs4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:55 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)) 06:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:55 INFO - Running setup.py (path:/tmp/pip-Ms2jxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:55 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)) 06:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:55 INFO - Running setup.py (path:/tmp/pip-Mz2qgm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:56 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)) 06:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:56 INFO - Running setup.py (path:/tmp/pip-zisMzG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:56 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)) 06:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:56 INFO - Running setup.py (path:/tmp/pip-bJhiVN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:56 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)) 06:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:56 INFO - Running setup.py (path:/tmp/pip-i5IOoO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:56 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)) 06:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:56 INFO - Running setup.py (path:/tmp/pip-joRqg5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:56 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)) 06:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:56 INFO - Running setup.py (path:/tmp/pip-dTyDnl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:56 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)) 06:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:56 INFO - Running setup.py (path:/tmp/pip-4p9KAO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:56 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)) 06:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:56 INFO - Running setup.py (path:/tmp/pip-RkXGeH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:56 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)) 06:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:56 INFO - Running setup.py (path:/tmp/pip-p7Sazk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:56 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)) 06:51:56 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)) 06:51:56 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)) 06:51:56 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)) 06:51:56 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)) 06:51:56 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)) 06:51:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:51:56 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 06:51:56 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 06:51:56 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 06:51:56 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 06:51:56 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 06:51:56 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 06:51:58 INFO - Downloading blessings-1.5.1.tar.gz 06:51:58 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 06:51:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:58 INFO - Installing collected packages: blessings 06:51:58 INFO - Running setup.py install for blessings 06:51:58 INFO - Successfully installed blessings 06:51:58 INFO - Cleaning up... 06:51:58 INFO - Return code: 0 06:51:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:51:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:51:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:51:58 INFO - Reading from file tmpfile_stdout 06:51:58 INFO - Current package versions: 06:51:58 INFO - argparse == 1.2.1 06:51:58 INFO - blessings == 1.5.1 06:51:58 INFO - blobuploader == 1.2.4 06:51:58 INFO - docopt == 0.6.1 06:51:58 INFO - manifestparser == 1.1 06:51:58 INFO - mozInstall == 1.12 06:51:58 INFO - mozcrash == 0.16 06:51:58 INFO - mozdebug == 0.1 06:51:58 INFO - mozdevice == 0.47 06:51:58 INFO - mozfile == 1.2 06:51:58 INFO - mozhttpd == 0.7 06:51:58 INFO - mozinfo == 0.9 06:51:58 INFO - mozleak == 0.1 06:51:58 INFO - mozlog == 3.0 06:51:58 INFO - moznetwork == 0.27 06:51:58 INFO - mozprocess == 0.22 06:51:58 INFO - mozprofile == 0.27 06:51:58 INFO - mozrunner == 6.11 06:51:58 INFO - mozscreenshot == 0.1 06:51:58 INFO - mozsystemmonitor == 0.0 06:51:58 INFO - moztest == 0.7 06:51:58 INFO - mozversion == 1.4 06:51:58 INFO - psutil == 3.1.1 06:51:58 INFO - requests == 1.2.3 06:51:58 INFO - wsgiref == 0.1.2 06:51:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51:58 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')]} 06:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:58 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')]} 06:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:58 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 0x7f6669f5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24886e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bea90>, '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 0x2510f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25112e0>, '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': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', '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 06:51:58 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 06:51:58 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 06:51:58 INFO - Using env: {'DISPLAY': ':0', 06:51:58 INFO - 'HOME': '/home/cltbld', 06:51:58 INFO - 'LANG': 'en_US.UTF-8', 06:51:58 INFO - 'LANGUAGE': 'en_US:en', 06:51:58 INFO - 'LOGNAME': 'cltbld', 06:51:58 INFO - 'MAIL': '/var/mail/cltbld', 06:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:58 INFO - 'MOZ_NO_REMOTE': '1', 06:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:58 INFO - 'NO_EM_RESTART': '1', 06:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:58 INFO - 'SHELL': '/bin/bash', 06:51:58 INFO - 'SHLVL': '1', 06:51:58 INFO - 'TERM': 'linux', 06:51:58 INFO - 'TMOUT': '86400', 06:51:58 INFO - 'USER': 'cltbld', 06:51:58 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', 06:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:58 INFO - '_': '/tools/buildbot/bin/python'} 06:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:58 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)) 06:51:58 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)) 06:51:58 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)) 06:51:58 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)) 06:51:58 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)) 06:51:58 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)) 06:51:58 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)) 06:51:58 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)) 06:51:58 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)) 06:51:58 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)) 06:51:58 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)) 06:51:58 INFO - Cleaning up... 06:51:58 INFO - Return code: 0 06:51:58 INFO - Running post-action listener: _resource_record_post_action 06:51:58 INFO - Running post-action listener: _start_resource_monitoring 06:51:58 INFO - Starting resource monitoring. 06:51:58 INFO - ##### 06:51:58 INFO - ##### Running install step. 06:51:58 INFO - ##### 06:51:58 INFO - Running pre-action listener: _resource_record_pre_action 06:51:58 INFO - Running main action method: install 06:51:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:51:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:51:59 INFO - Reading from file tmpfile_stdout 06:51:59 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:51:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:51:59 INFO - Reading from file tmpfile_stdout 06:51:59 INFO - Output received: 06:51:59 INFO - Usage: mozinstall [options] installer 06:51:59 INFO - Options: 06:51:59 INFO - -h, --help show this help message and exit 06:51:59 INFO - -d DEST, --destination=DEST 06:51:59 INFO - Directory to install application into. [default: 06:51:59 INFO - "/builds/slave/test-pgo"] 06:51:59 INFO - --app=APP Application being installed. [default: firefox] 06:51:59 INFO - mkdir: /builds/slave/test-pgo/build/application 06:51:59 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'] 06:51:59 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 06:52:13 INFO - Reading from file tmpfile_stdout 06:52:13 INFO - Output received: 06:52:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:52:13 INFO - Running post-action listener: _resource_record_post_action 06:52:13 INFO - ##### 06:52:13 INFO - ##### Running run-tests step. 06:52:13 INFO - ##### 06:52:13 INFO - Running pre-action listener: _resource_record_pre_action 06:52:13 INFO - Running main action method: run_tests 06:52:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:52:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:52:13 INFO - Python 2.7.3 06:52:13 INFO - Return code: 0 06:52:13 INFO - grabbing minidump binary from tooltool 06:52: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')]} 06:52:13 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 0x24bea90>, '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 0x2510f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25112e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:52:13 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 06:52:13 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 06:52:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:52:13 INFO - Return code: 0 06:52:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:52:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:52:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:52:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:52:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:52:13 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:52:13 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost 06:52:13 INFO - Using env: {'DISPLAY': ':0', 06:52:13 INFO - 'HOME': '/home/cltbld', 06:52:13 INFO - 'LANG': 'en_US.UTF-8', 06:52:13 INFO - 'LANGUAGE': 'en_US:en', 06:52:13 INFO - 'LOGNAME': 'cltbld', 06:52:13 INFO - 'MAIL': '/var/mail/cltbld', 06:52:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:52:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:13 INFO - 'MOZ_NO_REMOTE': '1', 06:52:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:13 INFO - 'NO_EM_RESTART': '1', 06:52:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:13 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:52:13 INFO - 'SHELL': '/bin/bash', 06:52:13 INFO - 'SHLVL': '1', 06:52:13 INFO - 'TERM': 'linux', 06:52:13 INFO - 'TMOUT': '86400', 06:52:13 INFO - 'USER': 'cltbld', 06:52:13 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305', 06:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:13 INFO - '_': '/tools/buildbot/bin/python'} 06:52:13 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] with output_timeout 3600 06:52:13 INFO - mozversion INFO | application_buildid: 20151119053001 06:52:13 INFO - mozversion INFO | application_changeset: 9a49075671cb62db97b9567a510a0bb361c9114a 06:52:13 INFO - mozversion INFO | application_display_name: Nightly 06:52:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:52:13 INFO - mozversion INFO | application_name: Firefox 06:52:13 INFO - mozversion INFO | application_remotingname: firefox 06:52:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:52:13 INFO - mozversion INFO | application_vendor: Mozilla 06:52:13 INFO - mozversion INFO | application_version: 45.0a1 06:52:13 INFO - mozversion INFO | platform_buildid: 20151119053001 06:52:13 INFO - mozversion INFO | platform_changeset: 9a49075671cb62db97b9567a510a0bb361c9114a 06:52:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:52:13 INFO - mozversion INFO | platform_version: 45.0a1 06:52:13 INFO - 2015-11-19 06:52:13,898 DEBUG : using testdate: 1447944733 06:52:13 INFO - 2015-11-19 06:52:13,898 DEBUG : actual date: 1447944733 06:52:13 INFO - 2015-11-19 06:52:13,907 INFO : starting webserver on 'localhost:50881' 06:52:13 INFO - 2015-11-19 06:52:13,908 INFO : Starting test suite talos-linux64-ix-059.e 06:52:13 INFO - 2015-11-19 06:52:13,909 INFO : Starting test dromaeo_css 06:52:13 INFO - 2015-11-19 06:52:13,909 DEBUG : operating with platform_type : linux_ 06:52:13 INFO - 2015-11-19 06:52:13,909 INFO : Initialising browser for dromaeo_css test... 06:52:13 INFO - 2015-11-19 06:52:13,926 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNl0wlx/profile http://localhost:50881/getInfo.html 06:52:18 INFO - 2015-11-19 06:52:18,515 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:52:18 INFO - 2015-11-19 06:52:18,515 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:52:18 INFO - 2015-11-19 06:52:18,515 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:52:18 INFO - 2015-11-19 06:52:18,516 DEBUG : BROWSER_OUTPUT: __metrics 06:52:19 INFO - 2015-11-19 06:52:19,622 INFO : Browser initialized. 06:52:19 INFO - 2015-11-19 06:52:19,622 INFO : Running cycle 1/1 for dromaeo_css test... 06:52:19 INFO - 2015-11-19 06:52:19,623 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNl0wlx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:52:31 INFO - 2015-11-19 06:52:31,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 142204928 06:52:31 INFO - 2015-11-19 06:52:31,477 DEBUG : BROWSER_OUTPUT: 06:53:21 INFO - 2015-11-19 06:53:21,118 DEBUG : BROWSER_OUTPUT: 1447944801114 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] 06:55:29 INFO - 2015-11-19 06:55:29,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50881/tests/dromaeo/cssquery-ext.html) 06:55:30 INFO - 2015-11-19 06:55:30,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 148312064 06:55:30 INFO - 2015-11-19 06:55:30,935 DEBUG : BROWSER_OUTPUT: 06:58:32 INFO - 2015-11-19 06:58:32,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/dromaeo/cssquery-ext.html (next: http://localhost:50881/tests/dromaeo/cssquery-jquery.html) 06:58:33 INFO - 2015-11-19 06:58:33,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 141352960 06:58:33 INFO - 2015-11-19 06:58:33,532 DEBUG : BROWSER_OUTPUT: 07:01:35 INFO - 2015-11-19 07:01:35,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50881/tests/dromaeo/cssquery-mootools.html) 07:01:35 INFO - 2015-11-19 07:01:35,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 141328384 07:01:35 INFO - 2015-11-19 07:01:35,739 DEBUG : BROWSER_OUTPUT: 07:04:37 INFO - 2015-11-19 07:04:37,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50881/tests/dromaeo/cssquery-prototype.html) 07:04:38 INFO - 2015-11-19 07:04:38,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 140804096 07:04:38 INFO - 2015-11-19 07:04:38,019 DEBUG : BROWSER_OUTPUT: 07:07:40 INFO - 2015-11-19 07:07:40,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50881/tests/dromaeo/cssquery-yui.html) 07:07:40 INFO - 2015-11-19 07:07:40,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 140320768 07:07:40 INFO - 2015-11-19 07:07:40,960 DEBUG : BROWSER_OUTPUT: 07:10:43 INFO - 2015-11-19 07:10:43,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/dromaeo/cssquery-yui.html (next: http://localhost:50881/tests/dromaeo/cssquery-dojo.html) 07:10:43 INFO - 2015-11-19 07:10:43,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 143712256 07:10:43 INFO - 2015-11-19 07:10:43,432 DEBUG : BROWSER_OUTPUT: 07:10:43 INFO - 2015-11-19 07:10:43,432 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:10:43 INFO - 2015-11-19 07:10:43,432 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:10:43 INFO - 2015-11-19 07:10:43,432 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:10:43 INFO - 2015-11-19 07:10:43,432 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:10:43 INFO - 2015-11-19 07:10:43,432 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3221.6778322167784;3318.8672453101863;3333.250018745784;3346.330733853229;3359.193793489563;5257.86855328617;5398.919016214755;5431.701256430894;5456.345238571372;5468.425815289397;5322.840314790563;5376.4085950545405;5421.918671219925;5463.836084917449;5471.835844924659;4686;4890.046440944008;5090.465501122366;5090.592752579785;5094.261332106861;4870.293807397925;5008.599312055045;5053.343065401493;5074.670146440488;5093.363329583802;4828.661993660445;4913.361263035818;4936.80252789888;4940.28365886948;4957.479464656195;4929.383827021622;4943.060818444484;4963.255511673242;4996.975015124937;4998.7250701211415;4789.760511974422;4878.390201224847;4925.827596034122;4943.8022479101155;4997.450280469182;5103.132467480537;5144.9742751286;5158.303629010074;5177.689338639656;5244.81643142492;5886.175935369051;5887.61730487517;5895.705214739246;5897.73460194288;5904.911426328608;5781.479666830005;5816.82549523515;5895.64626122434;5899.32157801854;5899.970500147515;5487.478689524529;5491.203775452577;5492.313460817398;5492.47821456961;5539.529140023103;5817.301923769175;5830.446107619854;5838.591298609056;5839.9124013139835;5909.527237820964;5618.325800903917;5734.426557344315;5745;5749.712514374264;5814.854628634233;5768.913466298009;5860.765569377262;5868.67722275279;5872.823815285548;5921.904447677193;5837.357890632027;5838.766449341979;5841.094630332305;5849.678267695318;5856.355800861902;5663.716814159276;5752.597318187687;5844.1233814927255;5864.530837532987;6023.156758053876;4569.543045695404;4578.084383123389;4584.724916504953;4597.356370108188;4607.07858428309;4077.55146933837;4086.7139300248696;4092.6112019358116;4097.426360309559;4118.382242663564;5479.479449452296;5513.145462453326;5563.888722225533;5611.9438805612235;5617.354004289477;5864.44287792659;5891.9705401473575;5908.379620139909;5927.73325200367;5937.703114844327;5419.864503387447;5612.102063669793;5625.521830644359;5627.099664053813;5628.774849005994;5029;5109.284700141983;5134.204198349262;5148.9485105149215;5168.095583272912;5927.318358388754;6032.276126864805;6040.244969378828;6041.969790151021;6067.302260240129;5776.537876969748;5858;5885.823425297248;5886.23478947734;5887.146363777143;5922.7334769936315;6018.398160183947;6090.451859332681;6095.420935011167;6135.938640613536;5696.430356964271;5726.828195154152;5753.8561535961935;5764.106563482667;5823.4467725566;5643.294588176478;5730.3410107838135;5833.125031245348;5844.1525978732;5860.501857342003;5698.116791897262;5717.228174196596;5789.681567513827;5801.854953626024;5825.766969321349;5748.281464816898;5767.452092051416;5768.53851691872;5789.884202316014;5807.157962095557;5483.232347471437;5605.103183490622;5608.747606357642;5686.317641883001;5713.485786279255;5731.713414329351;5751.654900705971;5783.797567085132;5802.767889284381;5805.419458054161;5608.663480191039;5631.605787594993;5662.943370566241;5670.319561652628;5674.744636491285 07:10:43 INFO - 2015-11-19 07:10:43,433 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.0281584381453;583.9182514447976;589.2722487727656;597.4413922982014;609.7621927448296;39728.801355993215;40884.59115408845;40901.795491022574;40952.18095638086;40960.38559421611;42474.15051698964;42636.573634263645;42668.359974600404;42897.35653965193;43096;8712.695055673054;8796.69211577595;8833.11668833118;8855.24730397917;8903.198712115909;8633.309335253165;8664.61009254582;8705.695300664478;8741.300695944341;8743.387962842604;8677.783055423633;8720.694775682852;8744.475331480131;8746.037935827055;8753.299736021136;8673.69642062528;8768.868466972937;8790.428622139605;8794.208521233088;8796.648134074629;8558.144185581454;8621.224089831945;8626.396152269344;8657.134286571356;8666.956665216634;39364;39398.01504962399;39740;39748.20503589912;39753;3218.742500599946;3391.4573668213216;3430.7426942979127;3443.2080621457203;3884.2037382336835;28897.56653650197;29512.409751804844;29664.406711865857;29736.8513157435;29979.70020299791;3538.7876727396438;3569.214772749991;3658.798766067865;3681.392570225936;3682.4660424238605;260846;262155;262649;263753;264235;42365;42488.3626745599;56883.43116568781;57393;57393;42610.57389426128;42660.57339426566;42721.35917961233;42769.57230427656;42980.355294670604;13150.60548183556;13294.268815215257;13330.800037999437;13357.866421335857;13379.331033448289;11394.715132121763;11436.428178591037;11514.194006419637;11531.827022594667;11554;14313.499027534195;14404.351804168837;14418.062825916282;14488.492902748354;14510.782338264935;5841.094630332305;5950.761969521257;6005.789797357072;6034.607750496204;6078.1186727924205;959.3476436023572;976.5800705696477;1001.8146642871092;1035.0115639564199;1129.858917351614;28583;28718;28814.711852881203;28870;28891;1039.6205385034407;1064.5156453813497;1082.5561519777011;1122.5958654884234;1125.983110253347;14575.562733117811;14595.197264150574;14627.78058329126;14683.926580367244;14882.10707357562;403782;409010;409183;409205;410610;52961.47038529642;53036;53278;53453.99999999922;53575;1368.206440264644;1374.0725010617793;1384.7299776543477;1391.3877893726728;1399.839018512884;26755.866220668773;27573;27693.446131076864;27703;27861.303467413476;43135;43833.56166438422;43903.560964389944;43962.34056489091;43968.12063758771;291473;292472;293469;294254;294304;32296;46216.537834621224;46227.3065904005;46963.765181173876;47190.05619887652;43549.56450435582;43667.56332436635;43695.12609747851;44587.55412445964;44673.32990005217;36973.44539831851;37070.62929370672;37303.81348093242;37480.437793433666;38525.80737096297;37492.81253593715;37632.81183594174;37709;38148.427773582865;38174.80912595419;36518.26963460769;36691.44962825613;36769.816150919076;36906.81546592357;37307.44038839474;32886.177845554055;33217.169570760925;33629.3274134511;33803;34041;25594;25746.35634109162;26042.609360859224;26099.73900260973;26258.474830503666 07:10:43 INFO - 2015-11-19 07:10:43,435 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.73918908791114;360.682599312605;365.9030356955407;366.4978978799045;368.9151495156114;14673.559793206194;15767.211639418012;16698.66602667946;17489.212985415656;18184.54538636533;16764.66470670586;16769.580760480963;16799.664006719857;16934.661306773887;16981.660366792657;5240.292560504321;5338.06583847827;5390.056740070491;5399.136138217886;5402.37872644645;4756.9286460703115;4909.680870743408;4916.3608730864935;4921.606271498289;5386.057439948013;4766.2374020156785;4776.68951518152;4807.23084306511;4828.806847726104;5006.599472042246;4956.132676781584;4970.304157417964;4982;4986.850394488171;4986.850394488171;4274.893127671802;4304.483461984551;4321.7406955582455;4335.1329734053;4338.891527711801;12961.675958101123;13317.53388631403;13491.527796527074;13502.864971350258;13714.451421943111;1965.8820470771657;2025.9696104558443;2029.8985050747551;2048.6312463756517;2256.6727824465524;9667.419954802665;9829.90170098297;9979.501024948797;9987.80024399508;10254.53854576546;1714.2885702433475;1723.913804309792;1755.6576467588825;1765.3115285038846;1775.9289628414847;58494.41505584932;60936;61188.69405652988;61302;62892.685536572026;7058.823529411703;7100.431965442752;7150.821229469201;7153.749618763319;7157.57054576727;8413.915860841313;8420.621072051772;8434.746957591282;8497.150284971452;8504.362172837062;5329.25390445338;5385.461453854661;5451.781928722886;5457.481539253765;5496.258005169331;5524.364698059694;5525.143602741581;5555.472230138131;5592.692401917933;5592.832215033555;3218.8551515181402;3313;3336.182635254378;3358.2108204571905;3388.6950174484414;1166.935818529989;1167.6847251242118;1175.042340492496;1180.6458062581362;1231.2489381477292;474.11814025911775;476.066908858634;479.1638590659322;482.4138671514127;488.33098654843093;11626;12184.329861857506;12300.261984280973;12498.875011249953;12528.310942898046;503.7103665392414;508.11334221783227;516.8036146264395;524.9160134378482;546.0335206684147;6551.312112228147;6693.163354580677;6772.153480814898;6863.176418829772;6873.48448866337;506859;514678;526457;531939;534876;70356.296437036;74468.62765686137;76369.61815190999;76791;79357.60321198472;544.1945920038287;550.9504144627003;551.4760977071797;559.3315987395024;562.8705397758539;10886.530318406914;11036.448177591248;11146.777064458827;11172.720681983015;11184.94407527957;33263.16842078871;34268.31463370669;35314.11714707153;36389.27221455609;36713.44929826108;46283.3057504131;47238.291425627955;49312.50687493222;49867.50132498628;49922;6833.521653484208;6854.760083397057;6872.518923675495;6905.620190889348;6929.1684997800585;12240.143189976616;12544.435500402686;12680.175788573713;12716.237025778482;12794.936025319814;10551;10665.786684266115;10905.727356815825;11105.167112466435;11175.608853690082;10585.52365143555;10824.134069274282;10998.835017474905;11034.668959931216;11211.60759373418;11099.611513596985;11330.433478326215;11357.829632555353;11426.800185980352;11471.770564588494;6798.830029249309;6832.93167068323;6841.692123854538;6885.758998435031;6888.690008949709;10870.836937446104;11112.611058612909;11150.55397784112;11156.49795759209;11180.944095279472 07:10:43 INFO - 2015-11-19 07:10:43,438 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1394.8326200855895;1468.2145052396966;1591.0453727763343;1625.894316869404;1758.525198196487;7487.588182649952;7546.471746977707;7690.5770182639935;7696.692132314701;7706;7518;7524.209957954418;7585.582792946386;7589.279018493235;7592.354649854769;2241.68616393705;2262.309995451387;2274.238130226368;2281;2281.9845168899847;2246.3148739634403;2284.908603655852;2289.828262880282;2297.058206135485;2302.458922153293;2186.726659167604;2239.2722365231366;2244;2277.089164334271;2284;2250.2799104286637;2259.5029093599464;2336.6495025746103;2338.7193536775526;2341.3561270650453;2299.540091981594;2307.734610519795;2311.3643747969277;2318.8492747971327;2319.5360927814504;7576.28025337592;7660.808479787994;7668.463207575472;7682.884756728654;7693.846123077507;4467.5755803198645;4513.323001549794;4559.589636932659;4570.314452832102;4578.702384345007;3084.506478963355;3106.9378612427627;3165.6042994625673;3167.1765341011273;3196.5045417960023;1078.8327809189589;1078.9352638841617;1103.5034234594384;1110.0231796019532;1116.263266244275;10241.795164096751;10246.180305575535;10262.692119236435;10359.63741269052;10367.79264414715;4089.427480152781;4110.23960567296;4143.212789569972;4228.598283163156;4249.80875860587;8516.233538981398;8544;8549.914500855037;8552;8561.871571926426;4625.884352891205;4676.321933319649;4684.2271025281125;4686.66430067436;4695.647826413033;4211.684123690736;4222.514410842731;4226.915461690749;4238.0888109056705;4244.129953359554;3363.0919651694394;3430.0052984634176;3449.4308439107767;3467.687908088284;3471.323091997087;1068.6420049283422;1076.671615157369;1087.499750114956;1090.0734375780683;1103.5598543900287;977.5845265762023;1023.0792286941663;1058.3649810114025;1192.6422073377953;1310.5020092364841;7057.294270572902;7062.823429414203;7116.395106415909;7149.249328820503;7187.532810367309;1121.966341009771;1122.0518661730825;1127.774445110981;1142.2061667141422;1163.069544364505;5673.432656734293;5694.202811606378;5696;5739.569532285095;5755.65466072037;8768.956155219183;8887.289016878634;8993.235574976201;9170.495622740813;9171.58727857248;8957.731268061969;8969.910300896907;8990.865137022949;9026.593803278869;9089.27285817133;6964.582125072512;7067.92932070683;7129.39400150993;7143.89284160738;7193.352598266181;7066.7173313066905;7099.574025558483;7126.251743566851;7155.928440715735;7158;7817.843643126992;7836.451448398785;7991.920080799117;8067.475614085066;8086.1913808618665;7996.960015199887;8138.104808470945;8158.551279679675;8165.428420010542;8167.3466122711225;6466.224053113657;6668.133142691419;6744.7976560703255;6747.493937954575;6860.4168645663685;7262.128544574685;7307.976883236457;7308.8903666443985;7312.488125831141;7317.707291708272;6821.3519715626935;6896.620685862325;6926.757563485254;7022.719091236293;7085.468589855678;6638.867222655616;6745.190577130776;6821.317868213139;6869.553479023847;6949.791506254821;6699.263081060982;6712.563683360566;6725.19297684281;6730;6780;6264.21697287839;6321.462675672619;6341.524385671185;6351.9047214290895;6373;6335.809925702052;6348.841278968062;6352.428281454691;6368.235811702625;6383.840403989938 07:10:43 INFO - 2015-11-19 07:10:43,438 DEBUG : BROWSER_OUTPUT: |4;prototype.html;341.96409377015397;342.9571303587052;343.9484077388393;347.5724858424138;356.8590406789318;6240.43836054755;6271.090691849679;6285.088662143987;6315.242170939488;6498.870022599545;6306.274778400485;6314.958031924738;6319.146915166451;6336.176297081373;6352.6188428694195;4776.71339719617;4786.449558300805;4786.4974177711365;4789.7844596993045;4794.592459640935;4801.0157917626975;4804.87987800306;4815.566599006089;4820.71075735457;4823.059503396821;4641.257398816173;4741.288806679008;4744.976275118637;4746.24060150376;4774.80900763969;4745.169595320823;4748.287756836467;4748.643851711118;4755.286706993961;4764.976175119137;4109.486314210723;4123.9381409278885;4125.381192821071;4126.174765046972;4128.091819799639;6060.30306514752;6065.666388348639;6067.787627433018;6071.2714474263375;6073.483753880925;5443.482869127427;5603.215549823028;5606.691631960241;5610.410906854803;5615.1857980592995;6758.898616520756;6768.8307792305095;6777.966110169467;6779.694913728845;6797.864042719168;4604.424446944132;4605.424321959755;4606.631469482433;4609.423822022247;4616.122936642061;6698.59808411492;6867.690953907087;6900.516963812535;6923.584584924921;6972.930270697329;4688.906221875543;4693.460252070987;4696.741679207608;4722.70125715431;4735.573798358164;4778.1399348117675;4797.232442809134;4809;4825.469198388175;4826.372571565674;5515.917261241085;5558.082916318843;5568.220449137124;5571.303587051619;5595.048841696921;6520.641364724986;6641.169853768279;6642.701078451481;6737.461003119836;6772.255051944282;1638.279157170841;1657.77620021298;1675.8324167583144;1676.9413070542716;1684.4778118783217;1120.1934607082887;1131.2025022359217;1132.6771870017171;1136.2216881436077;1145.66202970124;6335;6337.429631333202;6343.397377249154;6349.746010159634;6358.918983772677;6806.693698783567;6833.214180369321;6845.931540684529;6876.277990810993;6881.793546193522;6362;6402.9359706403275;6411.6153030818305;6414.230292364946;6414.230292364946;3771.17034252464;3806.7335286530233;3807.657310841982;3809;3809.695224382043;7254;7290.8177295566975;7292;7296.927030729625;7311.817204569822;7039.964800176069;7190.496665233488;7198.676059577331;7214.278572142849;7232.602206878672;7251.746188883364;7252.2747725227055;7256.8911466328045;7273.345398914017;7275.527090739085;6955.617441040589;6966.198887127843;6973.79078627642;6978.406835418843;6990.335918087773;6726.932730672631;6851.212110607344;6876.896846547406;6907.412869905913;6947.548409353376;7236.674349654173;7265.309795569412;7266.1280646322775;7282.45381596393;7285.344319011315;4670.3228031934495;4706.623470122314;4717.339572459927;4723.811047558197;4730.858074257778;6697.564658297195;6736.5958042517605;6807.659617019228;6950.339717726808;6997.685104170427;6659.467242620675;6695.799126026227;6711.261761206166;6714.3957043866285;6734.023566582916;6698.430633396216;6717.932820671731;6739.460843132636;6756.6959486822225;6760.492963027694;6496.155499784998;6580.670966451563;6588.176477940257;6623.768168114093;6625.039369291522;6749.0888730020815;6799.490038247052;6822.863542729018;6827.658617069226;6831.521793474608;6556.2788093308745;6561.409473147249;6619.900701489578;6631;6634.237062737654 07:10:43 INFO - 2015-11-19 07:10:43,440 DEBUG : BROWSER_OUTPUT: |5;yui.html;854.8461276970143;856.3834039491568;860.4794099569759;873.5195642396681;876.1501343696613;13632.18206907585;13872.237026963512;13905.88752899768;13911.721765564695;13977.580672579827;13522.323883805819;13594.592162235149;13604.795928061063;13616.659583510393;13617.387217575208;812.1513018895254;814.9348052155843;826.8635675113599;827.3339961331126;827.6234313387395;833.7540425574471;834.7913021744564;840.5839109640737;842.9157084291583;843.9240468357847;865.6364326982682;867.483847110968;869.678219058946;871.6034204436966;871.6600525794913;846.86026805577;848.8854004709409;850.4727069217063;851.6678495386773;853.6670698427587;630.0171732097942;631.2897989761518;631.8515148939996;632.5256057956533;633.4235845380681;13807.654808629864;13925.651858703512;13930.93034534831;13933.094348867393;13935.651608709863;10449.164066874631;10495.63265285719;10799.4060326682;10850.403227822546;10904.182186336056;9701.466419346933;9885.159761420287;10170;10325.58697652093;10549.314294570828;3262.2986057997646;3336.1492819331156;3349.422044008807;3375.088726043979;3433.759636825423;47171.05657886823;47509;47949;48209.51790482085;48290.51709482895;7353.816154596071;8193.79515512105;8268.173182681683;8268.710595129261;8474.1949514796;12778;12821.23072615646;12894.161879477804;12915.483380664857;12969.092163548461;6660.234073081658;6850.0752398425575;6988.126484189476;7062.646867656596;7215.701173788769;4112.547619761824;4187.288161012635;4210.2842516772225;4214.325707886785;4222.0500387412585;2885.4084912592866;2889.971100289012;2897.2901639098554;2902.622659054309;2910.97089029107;445.04093678123047;456.6324109092213;458.68580022683904;467.5534864204744;469.9271612900006;662.2318110991323;680.343468552839;688.5283580747205;694.1773997812609;698.2682946293221;9021.368504204642;9083;9157.267418606496;9239.72280831576;9277.721668349961;581.8167277307634;671.6910221298258;698.078536332047;705.3651713457826;707.345705222667;4301.505326887448;4354.651627869763;4367.650587952956;4392.414281581374;4528.5245049270015;60564.39435605676;60831.695841521396;60887.82453491414;61058.38941610527;61714;52713.2093018605;53494;53533.73233133809;53555;53852.192217116775;48272;48737;48759.756201219476;49027.75486122618;49759;8266.297364724065;8352.707655232038;8430.40591579537;8490.23587877094;8598.097199794182;36081.639183607826;36097.81951090228;36890.63109368979;37108.814455927546;37167.25665486729;43295.783521082194;46278;46751.53248467608;46859.297110542684;47394.28908566443;8065.435419520577;8092.433529652868;8138.3082437993435;8278.627461764356;8423.536705481258;11375.544978201111;11488.48301826403;11510.53957841677;11802.94098529502;11987.820182697442;11010.779784404427;11011.61459348951;11258.7748245033;11389.259698119928;11505.194636375709;10331.32846364984;10395.584176633152;10512.159027277952;10760.408177549996;11323.660290191307;9594.712158635251;9691.563879625575;11023.779524409307;11486.483108260316;11819;9471;9526.428414294887;9620.037996200324;10010.599576016877;10367.170626350025;9087.954560227157;9129.269658427176;9184.448933064037;9893.35693179941;9902.950485247527 07:10:43 INFO - 2015-11-19 07:10:43,440 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:10:43 INFO - 2015-11-19 07:10:43,440 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:10:43 INFO - 2015-11-19 07:10:43,440 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,285 07:10:43 INFO - 2015-11-19 07:10:43,440 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:10:43 INFO - 2015-11-19 07:10:43,440 DEBUG : BROWSER_OUTPUT: __startTimestamp1447945843429__endTimestamp 07:10:43 INFO - 2015-11-19 07:10:43,440 DEBUG : BROWSER_OUTPUT: 07:10:43 INFO - 2015-11-19 07:10:43,440 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:10:43 INFO - 2015-11-19 07:10:43,440 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:10:43 INFO - 2015-11-19 07:10:43,440 DEBUG : BROWSER_OUTPUT: 07:10:43 INFO - 2015-11-19 07:10:43,440 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5434.60 Median:5662.94 stddev:590.13 (10.4%) stddev-sans-first:565.83 07:10:43 INFO - 2015-11-19 07:10:43,440 DEBUG : BROWSER_OUTPUT: Values: 3221.7 3318.9 3333.3 3346.3 3359.2 5257.9 5398.9 5431.7 5456.3 5468.4 5322.8 5376.4 5421.9 5463.8 5471.8 4686.0 4890.0 5090.5 5090.6 5094.3 4870.3 5008.6 5053.3 5074.7 5093.4 4828.7 4913.4 4936.8 4940.3 4957.5 4929.4 4943.1 4963.3 4997.0 4998.7 4789.8 4878.4 4925.8 4943.8 4997.5 5103.1 5145.0 5158.3 5177.7 5244.8 5886.2 5887.6 5895.7 5897.7 5904.9 5781.5 5816.8 5895.6 5899.3 5900.0 5487.5 5491.2 5492.3 5492.5 5539.5 5817.3 5830.4 5838.6 5839.9 5909.5 5618.3 5734.4 5745.0 5749.7 5814.9 5768.9 5860.8 5868.7 5872.8 5921.9 5837.4 5838.8 5841.1 5849.7 5856.4 5663.7 5752.6 5844.1 5864.5 6023.2 4569.5 4578.1 4584.7 4597.4 4607.1 4077.6 4086.7 4092.6 4097.4 4118.4 5479.5 5513.1 5563.9 5611.9 5617.4 5864.4 5892.0 5908.4 5927.7 5937.7 5419.9 5612.1 5625.5 5627.1 5628.8 5029.0 5109.3 5134.2 5148.9 5168.1 5927.3 6032.3 6040.2 6042.0 6067.3 5776.5 5858.0 5885.8 5886.2 5887.1 5922.7 6018.4 6090.5 6095.4 6135.9 5696.4 5726.8 5753.9 5764.1 5823.4 5643.3 5730.3 5833.1 5844.2 5860.5 5698.1 5717.2 5789.7 5801.9 5825.8 5748.3 5767.5 5768.5 5789.9 5807.2 5483.2 5605.1 5608.7 5686.3 5713.5 5731.7 5751.7 5783.8 5802.8 5805.4 5608.7 5631.6 5662.9 5670.3 5674.7 07:10:43 INFO - 2015-11-19 07:10:43,441 DEBUG : BROWSER_OUTPUT: 07:10:43 INFO - 2015-11-19 07:10:43,441 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48287.47 Median:38161.62 stddev:86140.91 (225.7%) stddev-sans-first:86307.99 07:10:43 INFO - 2015-11-19 07:10:43,441 DEBUG : BROWSER_OUTPUT: Values: 550.0 583.9 589.3 597.4 609.8 39728.8 40884.6 40901.8 40952.2 40960.4 42474.2 42636.6 42668.4 42897.4 43096.0 8712.7 8796.7 8833.1 8855.2 8903.2 8633.3 8664.6 8705.7 8741.3 8743.4 8677.8 8720.7 8744.5 8746.0 8753.3 8673.7 8768.9 8790.4 8794.2 8796.6 8558.1 8621.2 8626.4 8657.1 8667.0 39364.0 39398.0 39740.0 39748.2 39753.0 3218.7 3391.5 3430.7 3443.2 3884.2 28897.6 29512.4 29664.4 29736.9 29979.7 3538.8 3569.2 3658.8 3681.4 3682.5 260846.0 262155.0 262649.0 263753.0 264235.0 42365.0 42488.4 56883.4 57393.0 57393.0 42610.6 42660.6 42721.4 42769.6 42980.4 13150.6 13294.3 13330.8 13357.9 13379.3 11394.7 11436.4 11514.2 11531.8 11554.0 14313.5 14404.4 14418.1 14488.5 14510.8 5841.1 5950.8 6005.8 6034.6 6078.1 959.3 976.6 1001.8 1035.0 1129.9 28583.0 28718.0 28814.7 28870.0 28891.0 1039.6 1064.5 1082.6 1122.6 1126.0 14575.6 14595.2 14627.8 14683.9 14882.1 403782.0 409010.0 409183.0 409205.0 410610.0 52961.5 53036.0 53278.0 53454.0 53575.0 1368.2 1374.1 1384.7 1391.4 1399.8 26755.9 27573.0 27693.4 27703.0 27861.3 43135.0 43833.6 43903.6 43962.3 43968.1 291473.0 292472.0 293469.0 294254.0 294304.0 32296.0 46216.5 46227.3 46963.8 47190.1 43549.6 43667.6 43695.1 44587.6 44673.3 36973.4 37070.6 37303.8 37480.4 38525.8 37492.8 37632.8 37709.0 38148.4 38174.8 36518.3 36691.4 36769.8 36906.8 37307.4 32886.2 33217.2 33629.3 33803.0 34041.0 25594.0 25746.4 26042.6 26099.7 26258.5 07:10:43 INFO - 2015-11-19 07:10:43,441 DEBUG : BROWSER_OUTPUT: 07:10:43 INFO - 2015-11-19 07:10:43,441 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26715.32 Median:2621.15 stddev:85735.45 (3270.9%) stddev-sans-first:85953.12 07:10:43 INFO - 2015-11-19 07:10:43,442 DEBUG : BROWSER_OUTPUT: Values: 359.7 360.7 365.9 366.5 368.9 14673.6 15767.2 16698.7 17489.2 18184.5 16764.7 16769.6 16799.7 16934.7 16981.7 5240.3 5338.1 5390.1 5399.1 5402.4 4756.9 4909.7 4916.4 4921.6 5386.1 4766.2 4776.7 4807.2 4828.8 5006.6 4956.1 4970.3 4982.0 4986.9 4986.9 4274.9 4304.5 4321.7 4335.1 4338.9 12961.7 13317.5 13491.5 13502.9 13714.5 1965.9 2026.0 2029.9 2048.6 2256.7 9667.4 9829.9 9979.5 9987.8 10254.5 1714.3 1723.9 1755.7 1765.3 1775.9 58494.4 60936.0 61188.7 61302.0 62892.7 7058.8 7100.4 7150.8 7153.7 7157.6 8413.9 8420.6 8434.7 8497.2 8504.4 5329.3 5385.5 5451.8 5457.5 5496.3 5524.4 5525.1 5555.5 5592.7 5592.8 3218.9 3313.0 3336.2 3358.2 3388.7 1166.9 1167.7 1175.0 1180.6 1231.2 474.1 476.1 479.2 482.4 488.3 11626.0 12184.3 12300.3 12498.9 12528.3 503.7 508.1 516.8 524.9 546.0 6551.3 6693.2 6772.2 6863.2 6873.5 506859.0 514678.0 526457.0 531939.0 534876.0 70356.3 74468.6 76369.6 76791.0 79357.6 544.2 551.0 551.5 559.3 562.9 10886.5 11036.4 11146.8 11172.7 11184.9 33263.2 34268.3 35314.1 36389.3 36713.4 46283.3 47238.3 49312.5 49867.5 49922.0 6833.5 6854.8 6872.5 6905.6 6929.2 12240.1 12544.4 12680.2 12716.2 12794.9 10551.0 10665.8 10905.7 11105.2 11175.6 10585.5 10824.1 10998.8 11034.7 11211.6 11099.6 11330.4 11357.8 11426.8 11471.8 6798.8 6832.9 6841.7 6885.8 6888.7 10870.8 11112.6 11150.6 11156.5 11180.9 07:10:43 INFO - 2015-11-19 07:10:43,442 DEBUG : BROWSER_OUTPUT: 07:10:43 INFO - 2015-11-19 07:10:43,442 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5322.04 Median:6328.64 stddev:2698.26 (42.6%) stddev-sans-first:2689.68 07:10:43 INFO - 2015-11-19 07:10:43,442 DEBUG : BROWSER_OUTPUT: Values: 1394.8 1468.2 1591.0 1625.9 1758.5 7487.6 7546.5 7690.6 7696.7 7706.0 7518.0 7524.2 7585.6 7589.3 7592.4 2241.7 2262.3 2274.2 2281.0 2282.0 2246.3 2284.9 2289.8 2297.1 2302.5 2186.7 2239.3 2244.0 2277.1 2284.0 2250.3 2259.5 2336.6 2338.7 2341.4 2299.5 2307.7 2311.4 2318.8 2319.5 7576.3 7660.8 7668.5 7682.9 7693.8 4467.6 4513.3 4559.6 4570.3 4578.7 3084.5 3106.9 3165.6 3167.2 3196.5 1078.8 1078.9 1103.5 1110.0 1116.3 10241.8 10246.2 10262.7 10359.6 10367.8 4089.4 4110.2 4143.2 4228.6 4249.8 8516.2 8544.0 8549.9 8552.0 8561.9 4625.9 4676.3 4684.2 4686.7 4695.6 4211.7 4222.5 4226.9 4238.1 4244.1 3363.1 3430.0 3449.4 3467.7 3471.3 1068.6 1076.7 1087.5 1090.1 1103.6 977.6 1023.1 1058.4 1192.6 1310.5 7057.3 7062.8 7116.4 7149.2 7187.5 1122.0 1122.1 1127.8 1142.2 1163.1 5673.4 5694.2 5696.0 5739.6 5755.7 8769.0 8887.3 8993.2 9170.5 9171.6 8957.7 8969.9 8990.9 9026.6 9089.3 6964.6 7067.9 7129.4 7143.9 7193.4 7066.7 7099.6 7126.3 7155.9 7158.0 7817.8 7836.5 7991.9 8067.5 8086.2 7997.0 8138.1 8158.6 8165.4 8167.3 6466.2 6668.1 6744.8 6747.5 6860.4 7262.1 7308.0 7308.9 7312.5 7317.7 6821.4 6896.6 6926.8 7022.7 7085.5 6638.9 6745.2 6821.3 6869.6 6949.8 6699.3 6712.6 6725.2 6730.0 6780.0 6264.2 6321.5 6341.5 6351.9 6373.0 6335.8 6348.8 6352.4 6368.2 6383.8 07:10:43 INFO - 2015-11-19 07:10:43,442 DEBUG : BROWSER_OUTPUT: 07:10:43 INFO - 2015-11-19 07:10:43,443 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5606.62 Median:6346.57 stddev:1707.96 (26.9%) stddev-sans-first:1666.41 07:10:43 INFO - 2015-11-19 07:10:43,444 DEBUG : BROWSER_OUTPUT: Values: 342.0 343.0 343.9 347.6 356.9 6240.4 6271.1 6285.1 6315.2 6498.9 6306.3 6315.0 6319.1 6336.2 6352.6 4776.7 4786.4 4786.5 4789.8 4794.6 4801.0 4804.9 4815.6 4820.7 4823.1 4641.3 4741.3 4745.0 4746.2 4774.8 4745.2 4748.3 4748.6 4755.3 4765.0 4109.5 4123.9 4125.4 4126.2 4128.1 6060.3 6065.7 6067.8 6071.3 6073.5 5443.5 5603.2 5606.7 5610.4 5615.2 6758.9 6768.8 6778.0 6779.7 6797.9 4604.4 4605.4 4606.6 4609.4 4616.1 6698.6 6867.7 6900.5 6923.6 6972.9 4688.9 4693.5 4696.7 4722.7 4735.6 4778.1 4797.2 4809.0 4825.5 4826.4 5515.9 5558.1 5568.2 5571.3 5595.0 6520.6 6641.2 6642.7 6737.5 6772.3 1638.3 1657.8 1675.8 1676.9 1684.5 1120.2 1131.2 1132.7 1136.2 1145.7 6335.0 6337.4 6343.4 6349.7 6358.9 6806.7 6833.2 6845.9 6876.3 6881.8 6362.0 6402.9 6411.6 6414.2 6414.2 3771.2 3806.7 3807.7 3809.0 3809.7 7254.0 7290.8 7292.0 7296.9 7311.8 7040.0 7190.5 7198.7 7214.3 7232.6 7251.7 7252.3 7256.9 7273.3 7275.5 6955.6 6966.2 6973.8 6978.4 6990.3 6726.9 6851.2 6876.9 6907.4 6947.5 7236.7 7265.3 7266.1 7282.5 7285.3 4670.3 4706.6 4717.3 4723.8 4730.9 6697.6 6736.6 6807.7 6950.3 6997.7 6659.5 6695.8 6711.3 6714.4 6734.0 6698.4 6717.9 6739.5 6756.7 6760.5 6496.2 6580.7 6588.2 6623.8 6625.0 6749.1 6799.5 6822.9 6827.7 6831.5 6556.3 6561.4 6619.9 6631.0 6634.2 07:10:43 INFO - 2015-11-19 07:10:43,444 DEBUG : BROWSER_OUTPUT: 07:10:43 INFO - 2015-11-19 07:10:43,444 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13746.87 Median:48893.76 stddev:16676.25 (34.1%) stddev-sans-first:16694.93 07:10:43 INFO - 2015-11-19 07:10:43,444 DEBUG : BROWSER_OUTPUT: Values: 854.8 856.4 860.5 873.5 876.2 13632.2 13872.2 13905.9 13911.7 13977.6 13522.3 13594.6 13604.8 13616.7 13617.4 812.2 814.9 826.9 827.3 827.6 833.8 834.8 840.6 842.9 843.9 865.6 867.5 869.7 871.6 871.7 846.9 848.9 850.5 851.7 853.7 630.0 631.3 631.9 632.5 633.4 13807.7 13925.7 13930.9 13933.1 13935.7 10449.2 10495.6 10799.4 10850.4 10904.2 9701.5 9885.2 10170.0 10325.6 10549.3 3262.3 3336.1 3349.4 3375.1 3433.8 47171.1 47509.0 47949.0 48209.5 48290.5 7353.8 8193.8 8268.2 8268.7 8474.2 12778.0 12821.2 12894.2 12915.5 12969.1 6660.2 6850.1 6988.1 7062.6 7215.7 4112.5 4187.3 4210.3 4214.3 4222.1 2885.4 2890.0 2897.3 2902.6 2911.0 445.0 456.6 458.7 467.6 469.9 662.2 680.3 688.5 694.2 698.3 9021.4 9083.0 9157.3 9239.7 9277.7 581.8 671.7 698.1 705.4 707.3 4301.5 4354.7 4367.7 4392.4 4528.5 60564.4 60831.7 60887.8 61058.4 61714.0 52713.2 53494.0 53533.7 53555.0 53852.2 48272.0 48737.0 48759.8 49027.8 49759.0 8266.3 8352.7 8430.4 8490.2 8598.1 36081.6 36097.8 36890.6 37108.8 37167.3 43295.8 46278.0 46751.5 46859.3 47394.3 8065.4 8092.4 8138.3 8278.6 8423.5 11375.5 11488.5 11510.5 11802.9 11987.8 11010.8 11011.6 11258.8 11389.3 11505.2 10331.3 10395.6 10512.2 10760.4 11323.7 9594.7 9691.6 11023.8 11486.5 11819.0 9471.0 9526.4 9620.0 10010.6 10367.2 9088.0 9129.3 9184.4 9893.4 9903.0 07:10:43 INFO - 2015-11-19 07:10:43,444 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:10:43 INFO - 2015-11-19 07:10:43,444 DEBUG : BROWSER_OUTPUT: 07:10:44 INFO - 2015-11-19 07:10:44,118 INFO : Browser exited with error code: 0 07:10:44 INFO - 2015-11-19 07:10:44,139 INFO : Completed test dromaeo_css (00:18:30) 07:10:44 INFO - 2015-11-19 07:10:44,139 INFO : Starting test kraken 07:10:44 INFO - 2015-11-19 07:10:44,139 DEBUG : operating with platform_type : linux_ 07:10:44 INFO - 2015-11-19 07:10:44,139 INFO : Initialising browser for kraken test... 07:10:44 INFO - 2015-11-19 07:10:44,146 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKBZ5vu/profile http://localhost:50881/getInfo.html 07:10:48 INFO - 2015-11-19 07:10:48,474 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:10:48 INFO - 2015-11-19 07:10:48,474 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:10:48 INFO - 2015-11-19 07:10:48,474 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:10:48 INFO - 2015-11-19 07:10:48,475 DEBUG : BROWSER_OUTPUT: __metrics 07:10:49 INFO - 2015-11-19 07:10:49,474 INFO : Browser initialized. 07:10:49 INFO - 2015-11-19 07:10:49,474 INFO : Running cycle 1/1 for kraken test... 07:10:49 INFO - 2015-11-19 07:10:49,475 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKBZ5vu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:11:01 INFO - 2015-11-19 07:11:01,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 139452416 07:11:01 INFO - 2015-11-19 07:11:01,247 DEBUG : BROWSER_OUTPUT: 07:11:03 INFO - 2015-11-19 07:11:03,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50881/tests/kraken/driver.html?testName=audio-beat-detection) 07:11:04 INFO - 2015-11-19 07:11:04,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 141463552 07:11:04 INFO - 2015-11-19 07:11:04,377 DEBUG : BROWSER_OUTPUT: 07:11:07 INFO - 2015-11-19 07:11:07,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50881/tests/kraken/driver.html?testName=audio-dft) 07:11:07 INFO - 2015-11-19 07:11:07,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 141750272 07:11:07 INFO - 2015-11-19 07:11:07,628 DEBUG : BROWSER_OUTPUT: 07:11:10 INFO - 2015-11-19 07:11:10,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50881/tests/kraken/driver.html?testName=audio-fft) 07:11:11 INFO - 2015-11-19 07:11:11,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 137003008 07:11:11 INFO - 2015-11-19 07:11:11,057 DEBUG : BROWSER_OUTPUT: 07:11:13 INFO - 2015-11-19 07:11:13,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50881/tests/kraken/driver.html?testName=audio-oscillator) 07:11:13 INFO - 2015-11-19 07:11:13,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 136798208 07:11:13 INFO - 2015-11-19 07:11:13,618 DEBUG : BROWSER_OUTPUT: 07:11:15 INFO - 2015-11-19 07:11:15,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50881/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:11:16 INFO - 2015-11-19 07:11:16,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 136757248 07:11:16 INFO - 2015-11-19 07:11:16,378 DEBUG : BROWSER_OUTPUT: 07:11:19 INFO - 2015-11-19 07:11:19,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50881/tests/kraken/driver.html?testName=imaging-darkroom) 07:11:19 INFO - 2015-11-19 07:11:19,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 136560640 07:11:19 INFO - 2015-11-19 07:11:19,971 DEBUG : BROWSER_OUTPUT: 07:11:23 INFO - 2015-11-19 07:11:23,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50881/tests/kraken/driver.html?testName=imaging-desaturate) 07:11:23 INFO - 2015-11-19 07:11:23,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 139534336 07:11:23 INFO - 2015-11-19 07:11:23,959 DEBUG : BROWSER_OUTPUT: 07:11:26 INFO - 2015-11-19 07:11:26,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50881/tests/kraken/driver.html?testName=json-parse-financial) 07:11:27 INFO - 2015-11-19 07:11:27,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 139612160 07:11:27 INFO - 2015-11-19 07:11:27,368 DEBUG : BROWSER_OUTPUT: 07:11:28 INFO - 2015-11-19 07:11:28,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50881/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:11:29 INFO - 2015-11-19 07:11:29,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 139153408 07:11:29 INFO - 2015-11-19 07:11:29,578 DEBUG : BROWSER_OUTPUT: 07:11:31 INFO - 2015-11-19 07:11:31,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50881/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:32 INFO - 2015-11-19 07:11:32,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 139083776 07:11:32 INFO - 2015-11-19 07:11:32,019 DEBUG : BROWSER_OUTPUT: 07:11:34 INFO - 2015-11-19 07:11:34,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50881/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:34 INFO - 2015-11-19 07:11:34,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 139538432 07:11:34 INFO - 2015-11-19 07:11:34,745 DEBUG : BROWSER_OUTPUT: 07:11:37 INFO - 2015-11-19 07:11:37,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:37 INFO - 2015-11-19 07:11:37,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 139747328 07:11:37 INFO - 2015-11-19 07:11:37,805 DEBUG : BROWSER_OUTPUT: 07:11:40 INFO - 2015-11-19 07:11:40,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:40 INFO - 2015-11-19 07:11:40,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 139935744 07:11:40 INFO - 2015-11-19 07:11:40,992 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50881/tests/kraken/driver.html?testName=ai-astar) 07:11:42 INFO - 2015-11-19 07:11:42,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 140292096 07:11:42 INFO - 2015-11-19 07:11:42,938 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,941 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:11:42 INFO - 2015-11-19 07:11:42,942 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:11:42 INFO - 2015-11-19 07:11:42,942 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:11:42 INFO - 2015-11-19 07:11:42,942 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:11:42 INFO - 2015-11-19 07:11:42,942 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;107;110;110;112;123;111;110;111;112 07:11:42 INFO - 2015-11-19 07:11:42,942 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;135;151;169;129;152;150;131;161;135 07:11:42 INFO - 2015-11-19 07:11:42,942 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;164;165;162;161;162;166;169;163 07:11:42 INFO - 2015-11-19 07:11:42,943 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;75;72;73;76;137;72;72;72;73 07:11:42 INFO - 2015-11-19 07:11:42,943 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;128;91;90;90;136;91;91;134 07:11:42 INFO - 2015-11-19 07:11:42,943 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;109;110;110;111;110;110 07:11:42 INFO - 2015-11-19 07:11:42,943 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;147;146;147;146;147;147 07:11:42 INFO - 2015-11-19 07:11:42,943 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;96;97;97;98;97;95;96;96 07:11:42 INFO - 2015-11-19 07:11:42,943 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;63;63;61;63;63;62;63;62;60 07:11:42 INFO - 2015-11-19 07:11:42,943 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;69;70;70;71;71;71;70;69;69 07:11:42 INFO - 2015-11-19 07:11:42,943 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;95;87;97;92;85;87;86;86;85 07:11:42 INFO - 2015-11-19 07:11:42,944 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;125;121;122;115;123;126;127;122;123 07:11:42 INFO - 2015-11-19 07:11:42,944 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;152;156;152;150;140;163;140;163;141 07:11:42 INFO - 2015-11-19 07:11:42,944 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;70;67;68;68;68;72;67;67;66 07:11:42 INFO - 2015-11-19 07:11:42,944 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:11:42 INFO - 2015-11-19 07:11:42,944 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:11:42 INFO - 2015-11-19 07:11:42,944 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,731 07:11:42 INFO - 2015-11-19 07:11:42,944 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:11:42 INFO - 2015-11-19 07:11:42,945 DEBUG : BROWSER_OUTPUT: __startTimestamp1447945902939__endTimestamp 07:11:42 INFO - 2015-11-19 07:11:42,945 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,948 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:11:42 INFO - 2015-11-19 07:11:42,948 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:11:42 INFO - 2015-11-19 07:11:42,948 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,949 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.80 Median:111.50 stddev:4.21 (3.8%) stddev-sans-first:4.47 07:11:42 INFO - 2015-11-19 07:11:42,949 DEBUG : BROWSER_OUTPUT: Values: 112.0 107.0 110.0 110.0 112.0 123.0 111.0 110.0 111.0 112.0 07:11:42 INFO - 2015-11-19 07:11:42,949 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,949 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.00 Median:151.50 stddev:13.74 (9.1%) stddev-sans-first:14.08 07:11:42 INFO - 2015-11-19 07:11:42,949 DEBUG : BROWSER_OUTPUT: Values: 157.0 135.0 151.0 169.0 129.0 152.0 150.0 131.0 161.0 135.0 07:11:42 INFO - 2015-11-19 07:11:42,949 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,949 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.55 (1.6%) stddev-sans-first:2.65 07:11:42 INFO - 2015-11-19 07:11:42,949 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 164.0 165.0 162.0 161.0 162.0 166.0 169.0 163.0 07:11:42 INFO - 2015-11-19 07:11:42,950 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,950 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:73.00 stddev:20.25 (27.7%) stddev-sans-first:21.34 07:11:42 INFO - 2015-11-19 07:11:42,950 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 72.0 73.0 76.0 137.0 72.0 72.0 72.0 73.0 07:11:42 INFO - 2015-11-19 07:11:42,950 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,950 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.20 Median:90.50 stddev:20.43 (22.6%) stddev-sans-first:21.11 07:11:42 INFO - 2015-11-19 07:11:42,950 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 128.0 91.0 90.0 90.0 136.0 91.0 91.0 134.0 07:11:42 INFO - 2015-11-19 07:11:42,950 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,951 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 07:11:42 INFO - 2015-11-19 07:11:42,951 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 109.0 110.0 110.0 111.0 110.0 110.0 07:11:42 INFO - 2015-11-19 07:11:42,951 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,951 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:11:42 INFO - 2015-11-19 07:11:42,951 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 07:11:42 INFO - 2015-11-19 07:11:42,951 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,951 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.97 (1.0%) stddev-sans-first:0.88 07:11:42 INFO - 2015-11-19 07:11:42,951 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 96.0 97.0 97.0 98.0 97.0 95.0 96.0 96.0 07:11:42 INFO - 2015-11-19 07:11:42,952 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,952 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:1.35 (2.1%) stddev-sans-first:1.09 07:11:42 INFO - 2015-11-19 07:11:42,952 DEBUG : BROWSER_OUTPUT: Values: 65.0 63.0 63.0 61.0 63.0 63.0 62.0 63.0 62.0 60.0 07:11:42 INFO - 2015-11-19 07:11:42,952 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,952 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 07:11:42 INFO - 2015-11-19 07:11:42,952 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 70.0 70.0 71.0 71.0 71.0 70.0 69.0 69.0 07:11:42 INFO - 2015-11-19 07:11:42,952 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,953 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:87.00 stddev:4.40 (5.1%) stddev-sans-first:4.57 07:11:42 INFO - 2015-11-19 07:11:42,953 DEBUG : BROWSER_OUTPUT: Values: 86.0 95.0 87.0 97.0 92.0 85.0 87.0 86.0 86.0 85.0 07:11:42 INFO - 2015-11-19 07:11:42,953 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,953 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:124.00 stddev:3.38 (2.7%) stddev-sans-first:3.50 07:11:42 INFO - 2015-11-19 07:11:42,953 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 121.0 122.0 115.0 123.0 126.0 127.0 122.0 123.0 07:11:42 INFO - 2015-11-19 07:11:42,953 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,953 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:152.00 stddev:8.68 (5.7%) stddev-sans-first:9.07 07:11:42 INFO - 2015-11-19 07:11:42,953 DEBUG : BROWSER_OUTPUT: Values: 146.0 152.0 156.0 152.0 150.0 140.0 163.0 140.0 163.0 141.0 07:11:42 INFO - 2015-11-19 07:11:42,954 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,954 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.00 stddev:2.54 (3.7%) stddev-sans-first:1.83 07:11:42 INFO - 2015-11-19 07:11:42,954 DEBUG : BROWSER_OUTPUT: Values: 74.0 70.0 67.0 68.0 68.0 68.0 72.0 67.0 67.0 66.0 07:11:42 INFO - 2015-11-19 07:11:42,954 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:11:42 INFO - 2015-11-19 07:11:42,954 DEBUG : BROWSER_OUTPUT: 07:11:43 INFO - 2015-11-19 07:11:43,994 INFO : Browser exited with error code: 0 07:11:44 INFO - 2015-11-19 07:11:44,045 INFO : Completed test kraken (00:00:59) 07:11:44 INFO - 2015-11-19 07:11:44,045 INFO : Starting test v8_7 07:11:44 INFO - 2015-11-19 07:11:44,045 DEBUG : operating with platform_type : linux_ 07:11:44 INFO - 2015-11-19 07:11:44,045 INFO : Initialising browser for v8_7 test... 07:11:44 INFO - 2015-11-19 07:11:44,051 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAMraLA/profile http://localhost:50881/getInfo.html 07:11:48 INFO - 2015-11-19 07:11:48,571 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:11:48 INFO - 2015-11-19 07:11:48,571 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:11:48 INFO - 2015-11-19 07:11:48,571 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:11:48 INFO - 2015-11-19 07:11:48,571 DEBUG : BROWSER_OUTPUT: __metrics 07:11:49 INFO - 2015-11-19 07:11:49,582 INFO : Browser initialized. 07:11:49 INFO - 2015-11-19 07:11:49,583 INFO : Running cycle 1/1 for v8_7 test... 07:11:49 INFO - 2015-11-19 07:11:49,583 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAMraLA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:12:01 INFO - 2015-11-19 07:12:01,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 141578240 07:12:01 INFO - 2015-11-19 07:12:01,354 DEBUG : BROWSER_OUTPUT: 07:12:22 INFO - 2015-11-19 07:12:22,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50881/tests/v8_7/run.html (next: http://localhost:50881/tests/v8_7/run.html) 07:12:23 INFO - 2015-11-19 07:12:23,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 138452992 07:12:23 INFO - 2015-11-19 07:12:23,053 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,053 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:12:23 INFO - 2015-11-19 07:12:23,053 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:12:23 INFO - 2015-11-19 07:12:23,053 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:12:23 INFO - 2015-11-19 07:12:23,053 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:12:23 INFO - 2015-11-19 07:12:23,053 DEBUG : BROWSER_OUTPUT: |0;Richards;168.54879487611663 07:12:23 INFO - 2015-11-19 07:12:23,053 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.51468585878234 07:12:23 INFO - 2015-11-19 07:12:23,054 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.2253280091272 07:12:23 INFO - 2015-11-19 07:12:23,054 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 07:12:23 INFO - 2015-11-19 07:12:23,054 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1063.8297872340424 07:12:23 INFO - 2015-11-19 07:12:23,054 DEBUG : BROWSER_OUTPUT: |5;Earley;716.8458781362007 07:12:23 INFO - 2015-11-19 07:12:23,054 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 07:12:23 INFO - 2015-11-19 07:12:23,054 DEBUG : BROWSER_OUTPUT: |7;RegExp;25525 07:12:23 INFO - 2015-11-19 07:12:23,054 DEBUG : BROWSER_OUTPUT: |8;Splay;626.4760720944686 07:12:23 INFO - 2015-11-19 07:12:23,055 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 07:12:23 INFO - 2015-11-19 07:12:23,055 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:12:23 INFO - 2015-11-19 07:12:23,055 DEBUG : BROWSER_OUTPUT: __startTimestamp1447945943051__endTimestamp 07:12:23 INFO - 2015-11-19 07:12:23,055 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,055 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:12:23 INFO - 2015-11-19 07:12:23,056 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:12:23 INFO - 2015-11-19 07:12:23,056 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,056 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.55 Median:168.55 stddev:0.00 (0.0%) 07:12:23 INFO - 2015-11-19 07:12:23,057 DEBUG : BROWSER_OUTPUT: Values: 168.5 07:12:23 INFO - 2015-11-19 07:12:23,057 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,057 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.51 Median:194.51 stddev:0.00 (0.0%) 07:12:23 INFO - 2015-11-19 07:12:23,057 DEBUG : BROWSER_OUTPUT: Values: 194.5 07:12:23 INFO - 2015-11-19 07:12:23,057 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,058 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.23 Median:285.23 stddev:0.00 (0.0%) 07:12:23 INFO - 2015-11-19 07:12:23,058 DEBUG : BROWSER_OUTPUT: Values: 285.2 07:12:23 INFO - 2015-11-19 07:12:23,058 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,058 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 07:12:23 INFO - 2015-11-19 07:12:23,058 DEBUG : BROWSER_OUTPUT: Values: 5040.2 07:12:23 INFO - 2015-11-19 07:12:23,058 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,059 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 07:12:23 INFO - 2015-11-19 07:12:23,059 DEBUG : BROWSER_OUTPUT: Values: 1063.8 07:12:23 INFO - 2015-11-19 07:12:23,059 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,059 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:716.85 Median:716.85 stddev:0.00 (0.0%) 07:12:23 INFO - 2015-11-19 07:12:23,059 DEBUG : BROWSER_OUTPUT: Values: 716.8 07:12:23 INFO - 2015-11-19 07:12:23,060 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,060 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 07:12:23 INFO - 2015-11-19 07:12:23,060 DEBUG : BROWSER_OUTPUT: Values: 12195.1 07:12:23 INFO - 2015-11-19 07:12:23,060 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,060 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25525.00 Median:25525.00 stddev:0.00 (0.0%) 07:12:23 INFO - 2015-11-19 07:12:23,060 DEBUG : BROWSER_OUTPUT: Values: 25525.0 07:12:23 INFO - 2015-11-19 07:12:23,061 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,061 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:626.48 Median:626.48 stddev:0.00 (0.0%) 07:12:23 INFO - 2015-11-19 07:12:23,061 DEBUG : BROWSER_OUTPUT: Values: 626.5 07:12:23 INFO - 2015-11-19 07:12:23,061 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,061 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 07:12:23 INFO - 2015-11-19 07:12:23,061 DEBUG : BROWSER_OUTPUT: Values: 4840.6 07:12:23 INFO - 2015-11-19 07:12:23,062 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:12:23 INFO - 2015-11-19 07:12:23,062 DEBUG : BROWSER_OUTPUT: 07:12:23 INFO - 2015-11-19 07:12:23,950 INFO : Browser exited with error code: 0 07:12:23 INFO - 2015-11-19 07:12:23,967 INFO : Completed test v8_7 (00:00:39) 07:12:24 INFO - 2015-11-19 07:12:24,049 INFO : Completed test suite (00:20:10) 07:12:24 INFO - 2015-11-19 07:12:24,049 DEBUG : Working with test: dromaeo_css 07:12:24 INFO - 2015-11-19 07:12:24,050 DEBUG : Generating results file: dromaeo_css 07:12:24 INFO - 2015-11-19 07:12:24,051 DEBUG : Working with test: kraken 07:12:24 INFO - 2015-11-19 07:12:24,051 DEBUG : Generating results file: kraken 07:12:24 INFO - 2015-11-19 07:12:24,051 INFO : javascript benchmark 07:12:24 INFO - 2015-11-19 07:12:24,051 DEBUG : Working with test: v8_7 07:12:24 INFO - 2015-11-19 07:12:24,051 DEBUG : Generating results file: v8_7 07:12:24 INFO - 2015-11-19 07:12:24,052 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:24 INFO - 2015-11-19 07:12:24,104 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 07:12:24 INFO - 2015-11-19 07:12:24,104 DEBUG : process_Request line: dromaeo_css 6763.10 graph.html#tests=[[72,64,43]] 07:12:24 INFO - 2015-11-19 07:12:24,104 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:24 INFO - 2015-11-19 07:12:24,135 DEBUG : process_Request line: kraken 1520.90 graph.html#tests=[[232,64,43]] 07:12:24 INFO - 2015-11-19 07:12:24,135 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:24 INFO - 2015-11-19 07:12:24,167 DEBUG : process_Request line: v8_7 21202.98 graph.html#tests=[[230,64,43]] 07:12:24 INFO - 2015-11-19 07:12:24,168 INFO : javascript benchmark 07:12:24 INFO - 2015-11-19 07:12:24,172 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3221.6778322167784, 3318.8672453101863, 3333.250018745784, 3346.330733853229, 3359.193793489563, 5257.86855328617, 5398.919016214755, 5431.701256430894, 5456.345238571372, 5468.425815289397, 5322.840314790563, 5376.4085950545405, 5421.918671219925, 5463.836084917449, 5471.835844924659, 4686.0, 4890.046440944008, 5090.465501122366, 5090.592752579785, 5094.261332106861, 4870.293807397925, 5008.599312055045, 5053.343065401493, 5074.670146440488, 5093.363329583802, 4828.661993660445, 4913.361263035818, 4936.80252789888, 4940.28365886948, 4957.479464656195, 4929.383827021622, 4943.060818444484, 4963.255511673242, 4996.975015124937, 4998.7250701211415, 4789.760511974422, 4878.390201224847, 4925.827596034122, 4943.8022479101155, 4997.450280469182, 5103.132467480537, 5144.9742751286, 5158.303629010074, 5177.689338639656, 5244.81643142492, 5886.175935369051, 5887.61730487517, 5895.705214739246, 5897.73460194288, 5904.911426328608, 5781.479666830005, 5816.82549523515, 5895.64626122434, 5899.32157801854, 5899.970500147515, 5487.478689524529, 5491.203775452577, 5492.313460817398, 5492.47821456961, 5539.529140023103, 5817.301923769175, 5830.446107619854, 5838.591298609056, 5839.9124013139835, 5909.527237820964, 5618.325800903917, 5734.426557344315, 5745.0, 5749.712514374264, 5814.854628634233, 5768.913466298009, 5860.765569377262, 5868.67722275279, 5872.823815285548, 5921.904447677193, 5837.357890632027, 5838.766449341979, 5841.094630332305, 5849.678267695318, 5856.355800861902, 5663.716814159276, 5752.597318187687, 5844.1233814927255, 5864.530837532987, 6023.156758053876, 4569.543045695404, 4578.084383123389, 4584.724916504953, 4597.356370108188, 4607.07858428309, 4077.55146933837, 4086.7139300248696, 4092.6112019358116, 4097.426360309559, 4118.382242663564, 5479.479449452296, 5513.145462453326, 5563.888722225533, 5611.9438805612235, 5617.354004289477, 5864.44287792659, 5891.9705401473575, 5908.379620139909, 5927.73325200367, 5937.703114844327, 5419.864503387447, 5612.102063669793, 5625.521830644359, 5627.099664053813, 5628.774849005994, 5029.0, 5109.284700141983, 5134.204198349262, 5148.9485105149215, 5168.095583272912, 5927.318358388754, 6032.276126864805, 6040.244969378828, 6041.969790151021, 6067.302260240129, 5776.537876969748, 5858.0, 5885.823425297248, 5886.23478947734, 5887.146363777143, 5922.7334769936315, 6018.398160183947, 6090.451859332681, 6095.420935011167, 6135.938640613536, 5696.430356964271, 5726.828195154152, 5753.8561535961935, 5764.106563482667, 5823.4467725566, 5643.294588176478, 5730.3410107838135, 5833.125031245348, 5844.1525978732, 5860.501857342003, 5698.116791897262, 5717.228174196596, 5789.681567513827, 5801.854953626024, 5825.766969321349, 5748.281464816898, 5767.452092051416, 5768.53851691872, 5789.884202316014, 5807.157962095557, 5483.232347471437, 5605.103183490622, 5608.747606357642, 5686.317641883001, 5713.485786279255, 5731.713414329351, 5751.654900705971, 5783.797567085132, 5802.767889284381, 5805.419458054161, 5608.663480191039, 5631.605787594993, 5662.943370566241, 5670.319561652628, 5674.744636491285], "unit": "ms", "name": "dojo.html", "value": 5397.528586236959}, {"lowerIsBetter": false, "replicates": [550.0281584381453, 583.9182514447976, 589.2722487727656, 597.4413922982014, 609.7621927448296, 39728.801355993215, 40884.59115408845, 40901.795491022574, 40952.18095638086, 40960.38559421611, 42474.15051698964, 42636.573634263645, 42668.359974600404, 42897.35653965193, 43096.0, 8712.695055673054, 8796.69211577595, 8833.11668833118, 8855.24730397917, 8903.198712115909, 8633.309335253165, 8664.61009254582, 8705.695300664478, 8741.300695944341, 8743.387962842604, 8677.783055423633, 8720.694775682852, 8744.475331480131, 8746.037935827055, 8753.299736021136, 8673.69642062528, 8768.868466972937, 8790.428622139605, 8794.208521233088, 8796.648134074629, 8558.144185581454, 8621.224089831945, 8626.396152269344, 8657.134286571356, 8666.956665216634, 39364.0, 39398.01504962399, 39740.0, 39748.20503589912, 39753.0, 3218.742500599946, 3391.4573668213216, 3430.7426942979127, 3443.2080621457203, 3884.2037382336835, 28897.56653650197, 29512.409751804844, 29664.406711865857, 29736.8513157435, 29979.70020299791, 3538.7876727396438, 3569.214772749991, 3658.798766067865, 3681.392570225936, 3682.4660424238605, 260846.0, 262155.0, 262649.0, 263753.0, 264235.0, 42365.0, 42488.3626745599, 56883.43116568781, 57393.0, 57393.0, 42610.57389426128, 42660.57339426566, 42721.35917961233, 42769.57230427656, 42980.355294670604, 13150.60548183556, 13294.268815215257, 13330.800037999437, 13357.866421335857, 13379.331033448289, 11394.715132121763, 11436.428178591037, 11514.194006419637, 11531.827022594667, 11554.0, 14313.499027534195, 14404.351804168837, 14418.062825916282, 14488.492902748354, 14510.782338264935, 5841.094630332305, 5950.761969521257, 6005.789797357072, 6034.607750496204, 6078.1186727924205, 959.3476436023572, 976.5800705696477, 1001.8146642871092, 1035.0115639564199, 1129.858917351614, 28583.0, 28718.0, 28814.711852881203, 28870.0, 28891.0, 1039.6205385034407, 1064.5156453813497, 1082.5561519777011, 1122.5958654884234, 1125.983110253347, 14575.562733117811, 14595.197264150574, 14627.78058329126, 14683.926580367244, 14882.10707357562, 403782.0, 409010.0, 409183.0, 409205.0, 410610.0, 52961.47038529642, 53036.0, 53278.0, 53453.99999999922, 53575.0, 1368.206440264644, 1374.0725010617793, 1384.7299776543477, 1391.3877893726728, 1399.839018512884, 26755.866220668773, 27573.0, 27693.446131076864, 27703.0, 27861.303467413476, 43135.0, 43833.56166438422, 43903.560964389944, 43962.34056489091, 43968.12063758771, 291473.0, 292472.0, 293469.0, 294254.0, 294304.0, 32296.0, 46216.537834621224, 46227.3065904005, 46963.765181173876, 47190.05619887652, 43549.56450435582, 43667.56332436635, 43695.12609747851, 44587.55412445964, 44673.32990005217, 36973.44539831851, 37070.62929370672, 37303.81348093242, 37480.437793433666, 38525.80737096297, 37492.81253593715, 37632.81183594174, 37709.0, 38148.427773582865, 38174.80912595419, 36518.26963460769, 36691.44962825613, 36769.816150919076, 36906.81546592357, 37307.44038839474, 32886.177845554055, 33217.169570760925, 33629.3274134511, 33803.0, 34041.0, 25594.0, 25746.35634109162, 26042.609360859224, 26099.73900260973, 26258.474830503666], "unit": "ms", "name": "ext.html", "value": 18247.35598335438}, {"lowerIsBetter": false, "replicates": [359.73918908791114, 360.682599312605, 365.9030356955407, 366.4978978799045, 368.9151495156114, 14673.559793206194, 15767.211639418012, 16698.66602667946, 17489.212985415656, 18184.54538636533, 16764.66470670586, 16769.580760480963, 16799.664006719857, 16934.661306773887, 16981.660366792657, 5240.292560504321, 5338.06583847827, 5390.056740070491, 5399.136138217886, 5402.37872644645, 4756.9286460703115, 4909.680870743408, 4916.3608730864935, 4921.606271498289, 5386.057439948013, 4766.2374020156785, 4776.68951518152, 4807.23084306511, 4828.806847726104, 5006.599472042246, 4956.132676781584, 4970.304157417964, 4982.0, 4986.850394488171, 4986.850394488171, 4274.893127671802, 4304.483461984551, 4321.7406955582455, 4335.1329734053, 4338.891527711801, 12961.675958101123, 13317.53388631403, 13491.527796527074, 13502.864971350258, 13714.451421943111, 1965.8820470771657, 2025.9696104558443, 2029.8985050747551, 2048.6312463756517, 2256.6727824465524, 9667.419954802665, 9829.90170098297, 9979.501024948797, 9987.80024399508, 10254.53854576546, 1714.2885702433475, 1723.913804309792, 1755.6576467588825, 1765.3115285038846, 1775.9289628414847, 58494.41505584932, 60936.0, 61188.69405652988, 61302.0, 62892.685536572026, 7058.823529411703, 7100.431965442752, 7150.821229469201, 7153.749618763319, 7157.57054576727, 8413.915860841313, 8420.621072051772, 8434.746957591282, 8497.150284971452, 8504.362172837062, 5329.25390445338, 5385.461453854661, 5451.781928722886, 5457.481539253765, 5496.258005169331, 5524.364698059694, 5525.143602741581, 5555.472230138131, 5592.692401917933, 5592.832215033555, 3218.8551515181402, 3313.0, 3336.182635254378, 3358.2108204571905, 3388.6950174484414, 1166.935818529989, 1167.6847251242118, 1175.042340492496, 1180.6458062581362, 1231.2489381477292, 474.11814025911775, 476.066908858634, 479.1638590659322, 482.4138671514127, 488.33098654843093, 11626.0, 12184.329861857506, 12300.261984280973, 12498.875011249953, 12528.310942898046, 503.7103665392414, 508.11334221783227, 516.8036146264395, 524.9160134378482, 546.0335206684147, 6551.312112228147, 6693.163354580677, 6772.153480814898, 6863.176418829772, 6873.48448866337, 506859.0, 514678.0, 526457.0, 531939.0, 534876.0, 70356.296437036, 74468.62765686137, 76369.61815190999, 76791.0, 79357.60321198472, 544.1945920038287, 550.9504144627003, 551.4760977071797, 559.3315987395024, 562.8705397758539, 10886.530318406914, 11036.448177591248, 11146.777064458827, 11172.720681983015, 11184.94407527957, 33263.16842078871, 34268.31463370669, 35314.11714707153, 36389.27221455609, 36713.44929826108, 46283.3057504131, 47238.291425627955, 49312.50687493222, 49867.50132498628, 49922.0, 6833.521653484208, 6854.760083397057, 6872.518923675495, 6905.620190889348, 6929.1684997800585, 12240.143189976616, 12544.435500402686, 12680.175788573713, 12716.237025778482, 12794.936025319814, 10551.0, 10665.786684266115, 10905.727356815825, 11105.167112466435, 11175.608853690082, 10585.52365143555, 10824.134069274282, 10998.835017474905, 11034.668959931216, 11211.60759373418, 11099.611513596985, 11330.433478326215, 11357.829632555353, 11426.800185980352, 11471.770564588494, 6798.830029249309, 6832.93167068323, 6841.692123854538, 6885.758998435031, 6888.690008949709, 10870.836937446104, 11112.611058612909, 11150.55397784112, 11156.49795759209, 11180.944095279472], "unit": "ms", "name": "jquery.html", "value": 7103.579986227991}, {"lowerIsBetter": false, "replicates": [1394.8326200855895, 1468.2145052396966, 1591.0453727763343, 1625.894316869404, 1758.525198196487, 7487.588182649952, 7546.471746977707, 7690.5770182639935, 7696.692132314701, 7706.0, 7518.0, 7524.209957954418, 7585.582792946386, 7589.279018493235, 7592.354649854769, 2241.68616393705, 2262.309995451387, 2274.238130226368, 2281.0, 2281.9845168899847, 2246.3148739634403, 2284.908603655852, 2289.828262880282, 2297.058206135485, 2302.458922153293, 2186.726659167604, 2239.2722365231366, 2244.0, 2277.089164334271, 2284.0, 2250.2799104286637, 2259.5029093599464, 2336.6495025746103, 2338.7193536775526, 2341.3561270650453, 2299.540091981594, 2307.734610519795, 2311.3643747969277, 2318.8492747971327, 2319.5360927814504, 7576.28025337592, 7660.808479787994, 7668.463207575472, 7682.884756728654, 7693.846123077507, 4467.5755803198645, 4513.323001549794, 4559.589636932659, 4570.314452832102, 4578.702384345007, 3084.506478963355, 3106.9378612427627, 3165.6042994625673, 3167.1765341011273, 3196.5045417960023, 1078.8327809189589, 1078.9352638841617, 1103.5034234594384, 1110.0231796019532, 1116.263266244275, 10241.795164096751, 10246.180305575535, 10262.692119236435, 10359.63741269052, 10367.79264414715, 4089.427480152781, 4110.23960567296, 4143.212789569972, 4228.598283163156, 4249.80875860587, 8516.233538981398, 8544.0, 8549.914500855037, 8552.0, 8561.871571926426, 4625.884352891205, 4676.321933319649, 4684.2271025281125, 4686.66430067436, 4695.647826413033, 4211.684123690736, 4222.514410842731, 4226.915461690749, 4238.0888109056705, 4244.129953359554, 3363.0919651694394, 3430.0052984634176, 3449.4308439107767, 3467.687908088284, 3471.323091997087, 1068.6420049283422, 1076.671615157369, 1087.499750114956, 1090.0734375780683, 1103.5598543900287, 977.5845265762023, 1023.0792286941663, 1058.3649810114025, 1192.6422073377953, 1310.5020092364841, 7057.294270572902, 7062.823429414203, 7116.395106415909, 7149.249328820503, 7187.532810367309, 1121.966341009771, 1122.0518661730825, 1127.774445110981, 1142.2061667141422, 1163.069544364505, 5673.432656734293, 5694.202811606378, 5696.0, 5739.569532285095, 5755.65466072037, 8768.956155219183, 8887.289016878634, 8993.235574976201, 9170.495622740813, 9171.58727857248, 8957.731268061969, 8969.910300896907, 8990.865137022949, 9026.593803278869, 9089.27285817133, 6964.582125072512, 7067.92932070683, 7129.39400150993, 7143.89284160738, 7193.352598266181, 7066.7173313066905, 7099.574025558483, 7126.251743566851, 7155.928440715735, 7158.0, 7817.843643126992, 7836.451448398785, 7991.920080799117, 8067.475614085066, 8086.1913808618665, 7996.960015199887, 8138.104808470945, 8158.551279679675, 8165.428420010542, 8167.3466122711225, 6466.224053113657, 6668.133142691419, 6744.7976560703255, 6747.493937954575, 6860.4168645663685, 7262.128544574685, 7307.976883236457, 7308.8903666443985, 7312.488125831141, 7317.707291708272, 6821.3519715626935, 6896.620685862325, 6926.757563485254, 7022.719091236293, 7085.468589855678, 6638.867222655616, 6745.190577130776, 6821.317868213139, 6869.553479023847, 6949.791506254821, 6699.263081060982, 6712.563683360566, 6725.19297684281, 6730.0, 6780.0, 6264.21697287839, 6321.462675672619, 6341.524385671185, 6351.9047214290895, 6373.0, 6335.809925702052, 6348.841278968062, 6352.428281454691, 6368.235811702625, 6383.840403989938], "unit": "ms", "name": "mootools.html", "value": 4407.367727038344}, {"lowerIsBetter": false, "replicates": [341.96409377015397, 342.9571303587052, 343.9484077388393, 347.5724858424138, 356.8590406789318, 6240.43836054755, 6271.090691849679, 6285.088662143987, 6315.242170939488, 6498.870022599545, 6306.274778400485, 6314.958031924738, 6319.146915166451, 6336.176297081373, 6352.6188428694195, 4776.71339719617, 4786.449558300805, 4786.4974177711365, 4789.7844596993045, 4794.592459640935, 4801.0157917626975, 4804.87987800306, 4815.566599006089, 4820.71075735457, 4823.059503396821, 4641.257398816173, 4741.288806679008, 4744.976275118637, 4746.24060150376, 4774.80900763969, 4745.169595320823, 4748.287756836467, 4748.643851711118, 4755.286706993961, 4764.976175119137, 4109.486314210723, 4123.9381409278885, 4125.381192821071, 4126.174765046972, 4128.091819799639, 6060.30306514752, 6065.666388348639, 6067.787627433018, 6071.2714474263375, 6073.483753880925, 5443.482869127427, 5603.215549823028, 5606.691631960241, 5610.410906854803, 5615.1857980592995, 6758.898616520756, 6768.8307792305095, 6777.966110169467, 6779.694913728845, 6797.864042719168, 4604.424446944132, 4605.424321959755, 4606.631469482433, 4609.423822022247, 4616.122936642061, 6698.59808411492, 6867.690953907087, 6900.516963812535, 6923.584584924921, 6972.930270697329, 4688.906221875543, 4693.460252070987, 4696.741679207608, 4722.70125715431, 4735.573798358164, 4778.1399348117675, 4797.232442809134, 4809.0, 4825.469198388175, 4826.372571565674, 5515.917261241085, 5558.082916318843, 5568.220449137124, 5571.303587051619, 5595.048841696921, 6520.641364724986, 6641.169853768279, 6642.701078451481, 6737.461003119836, 6772.255051944282, 1638.279157170841, 1657.77620021298, 1675.8324167583144, 1676.9413070542716, 1684.4778118783217, 1120.1934607082887, 1131.2025022359217, 1132.6771870017171, 1136.2216881436077, 1145.66202970124, 6335.0, 6337.429631333202, 6343.397377249154, 6349.746010159634, 6358.918983772677, 6806.693698783567, 6833.214180369321, 6845.931540684529, 6876.277990810993, 6881.793546193522, 6362.0, 6402.9359706403275, 6411.6153030818305, 6414.230292364946, 6414.230292364946, 3771.17034252464, 3806.7335286530233, 3807.657310841982, 3809.0, 3809.695224382043, 7254.0, 7290.8177295566975, 7292.0, 7296.927030729625, 7311.817204569822, 7039.964800176069, 7190.496665233488, 7198.676059577331, 7214.278572142849, 7232.602206878672, 7251.746188883364, 7252.2747725227055, 7256.8911466328045, 7273.345398914017, 7275.527090739085, 6955.617441040589, 6966.198887127843, 6973.79078627642, 6978.406835418843, 6990.335918087773, 6726.932730672631, 6851.212110607344, 6876.896846547406, 6907.412869905913, 6947.548409353376, 7236.674349654173, 7265.309795569412, 7266.1280646322775, 7282.45381596393, 7285.344319011315, 4670.3228031934495, 4706.623470122314, 4717.339572459927, 4723.811047558197, 4730.858074257778, 6697.564658297195, 6736.5958042517605, 6807.659617019228, 6950.339717726808, 6997.685104170427, 6659.467242620675, 6695.799126026227, 6711.261761206166, 6714.3957043866285, 6734.023566582916, 6698.430633396216, 6717.932820671731, 6739.460843132636, 6756.6959486822225, 6760.492963027694, 6496.155499784998, 6580.670966451563, 6588.176477940257, 6623.768168114093, 6625.039369291522, 6749.0888730020815, 6799.490038247052, 6822.863542729018, 6827.658617069226, 6831.521793474608, 6556.2788093308745, 6561.409473147249, 6619.900701489578, 6631.0, 6634.237062737654], "unit": "ms", "name": "prototype.html", "value": 5047.78232968103}, {"lowerIsBetter": false, "replicates": [854.8461276970143, 856.3834039491568, 860.4794099569759, 873.5195642396681, 876.1501343696613, 13632.18206907585, 13872.237026963512, 13905.88752899768, 13911.721765564695, 13977.580672579827, 13522.323883805819, 13594.592162235149, 13604.795928061063, 13616.659583510393, 13617.387217575208, 812.1513018895254, 814.9348052155843, 826.8635675113599, 827.3339961331126, 827.6234313387395, 833.7540425574471, 834.7913021744564, 840.5839109640737, 842.9157084291583, 843.9240468357847, 865.6364326982682, 867.483847110968, 869.678219058946, 871.6034204436966, 871.6600525794913, 846.86026805577, 848.8854004709409, 850.4727069217063, 851.6678495386773, 853.6670698427587, 630.0171732097942, 631.2897989761518, 631.8515148939996, 632.5256057956533, 633.4235845380681, 13807.654808629864, 13925.651858703512, 13930.93034534831, 13933.094348867393, 13935.651608709863, 10449.164066874631, 10495.63265285719, 10799.4060326682, 10850.403227822546, 10904.182186336056, 9701.466419346933, 9885.159761420287, 10170.0, 10325.58697652093, 10549.314294570828, 3262.2986057997646, 3336.1492819331156, 3349.422044008807, 3375.088726043979, 3433.759636825423, 47171.05657886823, 47509.0, 47949.0, 48209.51790482085, 48290.51709482895, 7353.816154596071, 8193.79515512105, 8268.173182681683, 8268.710595129261, 8474.1949514796, 12778.0, 12821.23072615646, 12894.161879477804, 12915.483380664857, 12969.092163548461, 6660.234073081658, 6850.0752398425575, 6988.126484189476, 7062.646867656596, 7215.701173788769, 4112.547619761824, 4187.288161012635, 4210.2842516772225, 4214.325707886785, 4222.0500387412585, 2885.4084912592866, 2889.971100289012, 2897.2901639098554, 2902.622659054309, 2910.97089029107, 445.04093678123047, 456.6324109092213, 458.68580022683904, 467.5534864204744, 469.9271612900006, 662.2318110991323, 680.343468552839, 688.5283580747205, 694.1773997812609, 698.2682946293221, 9021.368504204642, 9083.0, 9157.267418606496, 9239.72280831576, 9277.721668349961, 581.8167277307634, 671.6910221298258, 698.078536332047, 705.3651713457826, 707.345705222667, 4301.505326887448, 4354.651627869763, 4367.650587952956, 4392.414281581374, 4528.5245049270015, 60564.39435605676, 60831.695841521396, 60887.82453491414, 61058.38941610527, 61714.0, 52713.2093018605, 53494.0, 53533.73233133809, 53555.0, 53852.192217116775, 48272.0, 48737.0, 48759.756201219476, 49027.75486122618, 49759.0, 8266.297364724065, 8352.707655232038, 8430.40591579537, 8490.23587877094, 8598.097199794182, 36081.639183607826, 36097.81951090228, 36890.63109368979, 37108.814455927546, 37167.25665486729, 43295.783521082194, 46278.0, 46751.53248467608, 46859.297110542684, 47394.28908566443, 8065.435419520577, 8092.433529652868, 8138.3082437993435, 8278.627461764356, 8423.536705481258, 11375.544978201111, 11488.48301826403, 11510.53957841677, 11802.94098529502, 11987.820182697442, 11010.779784404427, 11011.61459348951, 11258.7748245033, 11389.259698119928, 11505.194636375709, 10331.32846364984, 10395.584176633152, 10512.159027277952, 10760.408177549996, 11323.660290191307, 9594.712158635251, 9691.563879625575, 11023.779524409307, 11486.483108260316, 11819.0, 9471.0, 9526.428414294887, 9620.037996200324, 10010.599576016877, 10367.170626350025, 9087.954560227157, 9129.269658427176, 9184.448933064037, 9893.35693179941, 9902.950485247527], "unit": "ms", "name": "yui.html", "value": 6147.360077060282}], "name": "dromaeo_css", "value": 6763.103104598057}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 110.0, 110.0, 112.0, 123.0, 111.0, 110.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [157.0, 135.0, 151.0, 169.0, 129.0, 152.0, 150.0, 131.0, 161.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 164.0, 165.0, 162.0, 161.0, 162.0, 166.0, 169.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 72.0, 73.0, 76.0, 137.0, 72.0, 72.0, 72.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 128.0, 91.0, 90.0, 90.0, 136.0, 91.0, 91.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 97.0, 97.0, 98.0, 97.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 63.0, 61.0, 63.0, 63.0, 62.0, 63.0, 62.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 62.5}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 70.0, 71.0, 71.0, 71.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.0}, {"lowerIsBetter": true, "replicates": [86.0, 95.0, 87.0, 97.0, 92.0, 85.0, 87.0, 86.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.6}, {"lowerIsBetter": true, "replicates": [125.0, 125.0, 121.0, 122.0, 115.0, 123.0, 126.0, 127.0, 122.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [146.0, 152.0, 156.0, 152.0, 150.0, 140.0, 163.0, 140.0, 163.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [74.0, 70.0, 67.0, 68.0, 68.0, 68.0, 72.0, 67.0, 67.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1520.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.54879487611663], "unit": "score", "name": "Richards", "value": 209.44676600000008}, {"lowerIsBetter": false, "replicates": [194.51468585878234], "unit": "score", "name": "DeltaBlue", "value": 339.9126379999999}, {"lowerIsBetter": false, "replicates": [285.2253280091272], "unit": "score", "name": "Encrypt", "value": 933.2305859999998}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [716.8458781362007], "unit": "score", "name": "Earley", "value": 929.7158849999997}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [25525.0], "unit": "score", "name": "RegExp", "value": 35.689911851126354}, {"lowerIsBetter": false, "replicates": [626.4760720944686], "unit": "score", "name": "Splay", "value": 130.07839186507942}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21202.976411434356}]} 07:12:24 INFO - RETURN: dromaeo_css: 6763.10 07:12:24 INFO - RETURN: kraken: 1520.90 07:12:24 INFO - RETURN: v8_7: 21202.98 07:12:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21202.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1520.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6763.10"}}} 07:12:24 INFO - Return code: 0 07:12:24 INFO - # TBPL SUCCESS # 07:12:24 INFO - Running post-action listener: _resource_record_post_action 07:12:24 INFO - Running post-run listener: _resource_record_post_run 07:12:25 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509210624; Read time: 8; Write time: 389156 07:12:25 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 230309888; Read time: 0; Write time: 225844 07:12:25 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 278900736; Read time: 0; Write time: 163312 07:12:25 INFO - Running post-run listener: _upload_blobber_files 07:12:25 INFO - Blob upload gear active. 07:12:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:12:25 INFO - Copying logs to upload dir... 07:12:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.984840 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-19 07:12:24.788518) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 07:12:24.792121) ========= 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=5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009959 build_url: 'https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 07:12:24.843536) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:12:24.843943) ========= 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=5752742a61d0f534093fa7a9000001cb-1447944463.578788-691315305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:12:24.893460) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 07:12:24.893829) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 07:12:24.894146) ========= ========= Total master_lag: 0.20 =========