builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1448466586.8 results: success (0) buildid: 20151125053453 builduid: 71fa2468bdfe486b8183b4ea7f4ea531 revision: ba1686bae88d9ef8b01d16f2e89d0bec5c79e85f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:46.802818) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:46.803480) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:46.803773) ========= 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=d6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006643 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:46.827571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:46.827854) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:46.859628) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:46.859891) ========= 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=d6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:46.909137) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:46.909460) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:46.909872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:46.910209) ========= 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=d6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 07:49:46-- 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% 43.5M=0s 2015-11-25 07:49:47 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099643 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:47.022036) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:47.022349) ========= 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=d6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022489 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:47.071676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 07:49:47.072068) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ba1686bae88d9ef8b01d16f2e89d0bec5c79e85f --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 ba1686bae88d9ef8b01d16f2e89d0bec5c79e85f --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=d6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 07:49:47,153 truncating revision to first 12 chars 2015-11-25 07:49:47,153 Setting DEBUG logging. 2015-11-25 07:49:47,153 attempt 1/10 2015-11-25 07:49:47,153 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ba1686bae88d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 07:49:48,364 unpacking tar archive at: fx-team-ba1686bae88d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.480583 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 07:49:48.567224) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:48.567728) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:48.664212) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:48.664583) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 07:49:48.665104) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-25 07:49:48.665532) ========= /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=d6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:49:48 INFO - MultiFileLogger online at 20151125 07:49:48 in /builds/slave/test-pgo 07:49:48 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 07:49:48 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:49:48 INFO - {'append_to_log': False, 07:49:48 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:49:48 INFO - 'blob_upload_branch': 'Fx-Team', 07:49:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:49:48 INFO - 'branch': 'Fx-Team', 07:49:48 INFO - 'buildbot_json_path': 'buildprops.json', 07:49:48 INFO - 'config_files': ('talos/linux_config.py',), 07:49:48 INFO - 'default_actions': ('clobber', 07:49:48 INFO - 'read-buildbot-config', 07:49:48 INFO - 'download-and-extract', 07:49:48 INFO - 'populate-webroot', 07:49:48 INFO - 'create-virtualenv', 07:49:48 INFO - 'install', 07:49:48 INFO - 'run-tests'), 07:49:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:49:48 INFO - 'download_minidump_stackwalk': True, 07:49:48 INFO - 'download_symbols': 'ondemand', 07:49:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:49:48 INFO - 'tooltool.py': '/tools/tooltool.py', 07:49:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:49:48 INFO - '/tools/misc-python/virtualenv.py')}, 07:49:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:49:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:49:48 INFO - 'installer_path': 'installer.exe', 07:49:48 INFO - 'log_level': 'info', 07:49:48 INFO - 'log_name': 'talos', 07:49:48 INFO - 'log_to_console': True, 07:49:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:49:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:49:48 INFO - 'opt_config_files': (), 07:49:48 INFO - 'pip_index': False, 07:49:48 INFO - 'sps_profile': False, 07:49:48 INFO - 'sps_profile_interval': 0, 07:49:48 INFO - 'suite': 'dromaeojs-e10s', 07:49:48 INFO - 'system_bits': '64', 07:49:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:49:48 INFO - 'title': 'talos-linux64-ix-016', 07:49:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:49:48 INFO - 'use_talos_json': True, 07:49:48 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:49:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:49:48 INFO - 'work_dir': 'build'} 07:49:48 INFO - ##### 07:49:48 INFO - ##### Running clobber step. 07:49:48 INFO - ##### 07:49:48 INFO - Running pre-action listener: _resource_record_pre_action 07:49:48 INFO - Running main action method: clobber 07:49:48 INFO - rmtree: /builds/slave/test-pgo/build 07:49:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:49:49 INFO - Running post-action listener: _resource_record_post_action 07:49:49 INFO - ##### 07:49:49 INFO - ##### Running read-buildbot-config step. 07:49:49 INFO - ##### 07:49:49 INFO - Running pre-action listener: _resource_record_pre_action 07:49:49 INFO - Running main action method: read_buildbot_config 07:49:49 INFO - Using buildbot properties: 07:49:49 INFO - { 07:49:49 INFO - "properties": { 07:49:49 INFO - "buildnumber": 356, 07:49:49 INFO - "product": "firefox", 07:49:49 INFO - "script_repo_revision": "production", 07:49:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:49:49 INFO - "repository": "", 07:49:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 07:49:49 INFO - "buildid": "20151125053453", 07:49:49 INFO - "slavename": "talos-linux64-ix-016", 07:49:49 INFO - "pgo_build": "True", 07:49:49 INFO - "basedir": "/builds/slave/test-pgo", 07:49:49 INFO - "project": "", 07:49:49 INFO - "platform": "ubuntu64_hw", 07:49:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:49:49 INFO - "slavebuilddir": "test", 07:49:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:49:49 INFO - "branch": "fx-team", 07:49:49 INFO - "repo_path": "integration/fx-team", 07:49:49 INFO - "stage_platform": "linux64-pgo", 07:49:49 INFO - "builduid": "71fa2468bdfe486b8183b4ea7f4ea531", 07:49:49 INFO - "revision": "ba1686bae88d9ef8b01d16f2e89d0bec5c79e85f" 07:49:49 INFO - }, 07:49:49 INFO - "sourcestamp": { 07:49:49 INFO - "repository": "", 07:49:49 INFO - "hasPatch": false, 07:49:49 INFO - "project": "", 07:49:49 INFO - "branch": "fx-team-linux64-pgo-talos", 07:49:49 INFO - "changes": [ 07:49:49 INFO - { 07:49:49 INFO - "category": null, 07:49:49 INFO - "files": [ 07:49:49 INFO - { 07:49:49 INFO - "url": null, 07:49:49 INFO - "name": "https://queue.taskcluster.net/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:49:49 INFO - } 07:49:49 INFO - ], 07:49:49 INFO - "repository": "", 07:49:49 INFO - "rev": "ba1686bae88d9ef8b01d16f2e89d0bec5c79e85f", 07:49:49 INFO - "who": "sendchange", 07:49:49 INFO - "when": 1448466572, 07:49:49 INFO - "number": 6706175, 07:49:49 INFO - "comments": "", 07:49:49 INFO - "project": "", 07:49:49 INFO - "at": "Wed 25 Nov 2015 07:49:32", 07:49:49 INFO - "branch": "fx-team-linux64-pgo-talos", 07:49:49 INFO - "revlink": "", 07:49:49 INFO - "properties": [ 07:49:49 INFO - [ 07:49:49 INFO - "buildid", 07:49:49 INFO - "20151125053453", 07:49:49 INFO - "Change" 07:49:49 INFO - ], 07:49:49 INFO - [ 07:49:49 INFO - "builduid", 07:49:49 INFO - "71fa2468bdfe486b8183b4ea7f4ea531", 07:49:49 INFO - "Change" 07:49:49 INFO - ], 07:49:49 INFO - [ 07:49:49 INFO - "pgo_build", 07:49:49 INFO - "True", 07:49:49 INFO - "Change" 07:49:49 INFO - ] 07:49:49 INFO - ], 07:49:49 INFO - "revision": "ba1686bae88d9ef8b01d16f2e89d0bec5c79e85f" 07:49:49 INFO - } 07:49:49 INFO - ], 07:49:49 INFO - "revision": "ba1686bae88d9ef8b01d16f2e89d0bec5c79e85f" 07:49:49 INFO - } 07:49:49 INFO - } 07:49:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:49:49 INFO - Running post-action listener: _resource_record_post_action 07:49:49 INFO - ##### 07:49:49 INFO - ##### Running download-and-extract step. 07:49:49 INFO - ##### 07:49:49 INFO - Running pre-action listener: _resource_record_pre_action 07:49:49 INFO - Running main action method: download_and_extract 07:49:49 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:49 INFO - https://queue.taskcluster.net/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:49:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/test_packages.json 07:49:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/test_packages.json 07:49:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:49:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:49:50 INFO - Downloaded 1302 bytes. 07:49:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:49:50 INFO - Using the following test package requirements: 07:49:50 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:49:50 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:49:50 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:50 INFO - u'jsshell-linux-x86_64.zip'], 07:49:50 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:49:50 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:49:50 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:49:50 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:49:50 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:49:50 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:49:50 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:49:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:50 INFO - https://queue.taskcluster.net/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:49:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:49:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:49:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:49:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:49:51 INFO - Downloaded 22754332 bytes. 07:49:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:49:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:49:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:49:52 INFO - Return code: 0 07:49:52 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:52 INFO - https://queue.taskcluster.net/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:49:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:49:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:49:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:49:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:49:54 INFO - Downloaded 22754332 bytes. 07:49:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:49:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:49:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:49:55 INFO - Return code: 0 07:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:55 INFO - https://queue.taskcluster.net/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:49:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:49:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:49:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:49:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:49:56 INFO - Downloaded 11131717 bytes. 07:49:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 07:49:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:49:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:49:57 INFO - Return code: 0 07:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:57 INFO - https://queue.taskcluster.net/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:49:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:49:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:49:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:49:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:49:58 INFO - Downloaded 58395032 bytes. 07:49:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:49:58 INFO - mkdir: /builds/slave/test-pgo/properties 07:49:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:49:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:49:58 INFO - Contents: 07:49:58 INFO - build_url:https://queue.taskcluster.net/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:49:58 INFO - Running post-action listener: _resource_record_post_action 07:49:58 INFO - Running post-action listener: set_extra_try_arguments 07:49:58 INFO - ##### 07:49:58 INFO - ##### Running populate-webroot step. 07:49:58 INFO - ##### 07:49:58 INFO - Running pre-action listener: _resource_record_pre_action 07:49:58 INFO - Running main action method: populate_webroot 07:49:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:49:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:49:58 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:49:58 INFO - '../fennec_ids.txt'], 07:49:58 INFO - 'tests': ['tcheck2']}, 07:49:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:49:58 INFO - '--tppagecycles', 07:49:58 INFO - '7'], 07:49:58 INFO - 'tests': ['tsvgm']}}, 07:49:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:49:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:49:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:49:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:49:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:49:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:49:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:49:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:58 INFO - 'talos_options': ['--e10s'], 07:49:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:49:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:58 INFO - 'tests': ['damp', 'tps']}, 07:49:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:58 INFO - 'talos_options': ['--e10s'], 07:49:58 INFO - 'tests': ['damp', 'tps']}, 07:49:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:49:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:49:58 INFO - 'other': {'tests': ['a11yr', 07:49:58 INFO - 'ts_paint', 07:49:58 INFO - 'tpaint', 07:49:58 INFO - 'sessionrestore', 07:49:58 INFO - 'sessionrestore_no_auto_restore']}, 07:49:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:49:58 INFO - 'tests': ['a11yr', 07:49:58 INFO - 'ts_paint', 07:49:58 INFO - 'tpaint', 07:49:58 INFO - 'sessionrestore', 07:49:58 INFO - 'sessionrestore_no_auto_restore']}, 07:49:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:49:58 INFO - 'tests': ['a11yr', 07:49:58 INFO - 'ts_paint', 07:49:58 INFO - 'tpaint', 07:49:58 INFO - 'sessionrestore', 07:49:58 INFO - 'sessionrestore_no_auto_restore']}, 07:49:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:49:58 INFO - 'tests': ['a11yr', 07:49:58 INFO - 'ts_paint', 07:49:58 INFO - 'tpaint', 07:49:58 INFO - 'sessionrestore', 07:49:58 INFO - 'sessionrestore_no_auto_restore']}, 07:49:58 INFO - 'other_l64': {'tests': ['a11yr', 07:49:58 INFO - 'ts_paint', 07:49:58 INFO - 'tpaint', 07:49:58 INFO - 'sessionrestore', 07:49:58 INFO - 'sessionrestore_no_auto_restore']}, 07:49:58 INFO - 'other_nol64': {'tests': ['a11yr', 07:49:58 INFO - 'ts_paint', 07:49:58 INFO - 'tpaint', 07:49:58 INFO - 'sessionrestore', 07:49:58 INFO - 'sessionrestore_no_auto_restore']}, 07:49:58 INFO - 'svgr': {'tests': ['tsvgx', 07:49:58 INFO - 'tsvgr_opacity', 07:49:58 INFO - 'tart', 07:49:58 INFO - 'tscrollx', 07:49:58 INFO - 'cart']}, 07:49:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:49:58 INFO - 'tests': ['tsvgx', 07:49:58 INFO - 'tsvgr_opacity', 07:49:58 INFO - 'tart', 07:49:58 INFO - 'tscrollx', 07:49:58 INFO - 'cart']}, 07:49:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:58 INFO - 'tests': ['tp5o']}, 07:49:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:58 INFO - 'talos_options': ['--e10s'], 07:49:58 INFO - 'tests': ['tp5o']}, 07:49:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:58 INFO - 'talos_options': ['--xperf_path', 07:49:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:49:58 INFO - 'tests': ['tp5n']}, 07:49:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:58 INFO - 'talos_options': ['--e10s', 07:49:58 INFO - '--xperf_path', 07:49:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:49:58 INFO - 'tests': ['tp5n']}}, 07:49:58 INFO - 'talos.zip': {'path': '', 07:49:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:49:58 INFO - Running post-action listener: _resource_record_post_action 07:49:58 INFO - ##### 07:49:58 INFO - ##### Running create-virtualenv step. 07:49:58 INFO - ##### 07:49:58 INFO - Running pre-action listener: _resource_record_pre_action 07:49:58 INFO - Running main action method: create_virtualenv 07:49:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:49:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 07:49:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:49:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:49:58 INFO - Using real prefix '/usr' 07:49:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:49:59 INFO - Installing distribute.............................................................................................................................................................................................done. 07:50:01 INFO - Installing pip.................done. 07:50:01 INFO - Return code: 0 07:50:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:01 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 0x218d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449640>, '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 0x244a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a9d0>, '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': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:50:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:50:01 INFO - Using env: {'DISPLAY': ':0', 07:50:01 INFO - 'HOME': '/home/cltbld', 07:50:01 INFO - 'LANG': 'en_US.UTF-8', 07:50:01 INFO - 'LANGUAGE': 'en_US:en', 07:50:01 INFO - 'LOGNAME': 'cltbld', 07:50:01 INFO - 'MAIL': '/var/mail/cltbld', 07:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:01 INFO - 'MOZ_NO_REMOTE': '1', 07:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:01 INFO - 'NO_EM_RESTART': '1', 07:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:50:01 INFO - 'PWD': '/builds/slave/test-pgo', 07:50:01 INFO - 'SHELL': '/bin/bash', 07:50:01 INFO - 'SHLVL': '1', 07:50:01 INFO - 'TERM': 'linux', 07:50:01 INFO - 'TMOUT': '86400', 07:50:01 INFO - 'USER': 'cltbld', 07:50:01 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 07:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:01 INFO - '_': '/tools/buildbot/bin/python'} 07:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:50:01 INFO - Cleaning up... 07:50:01 INFO - Return code: 0 07:50:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:01 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 0x218d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449640>, '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 0x244a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a9d0>, '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': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:50:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:50:01 INFO - Using env: {'DISPLAY': ':0', 07:50:01 INFO - 'HOME': '/home/cltbld', 07:50:01 INFO - 'LANG': 'en_US.UTF-8', 07:50:01 INFO - 'LANGUAGE': 'en_US:en', 07:50:01 INFO - 'LOGNAME': 'cltbld', 07:50:01 INFO - 'MAIL': '/var/mail/cltbld', 07:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:01 INFO - 'MOZ_NO_REMOTE': '1', 07:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:01 INFO - 'NO_EM_RESTART': '1', 07:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:50:01 INFO - 'PWD': '/builds/slave/test-pgo', 07:50:01 INFO - 'SHELL': '/bin/bash', 07:50:01 INFO - 'SHLVL': '1', 07:50:01 INFO - 'TERM': 'linux', 07:50:01 INFO - 'TMOUT': '86400', 07:50:01 INFO - 'USER': 'cltbld', 07:50:01 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 07:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:01 INFO - '_': '/tools/buildbot/bin/python'} 07:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:01 INFO - Downloading/unpacking psutil>=0.7.1 07:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:50:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:50:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:50:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:50:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:50:03 INFO - Installing collected packages: psutil 07:50:03 INFO - Running setup.py install for psutil 07:50:03 INFO - building 'psutil._psutil_linux' extension 07:50:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:50:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:50:03 INFO - building 'psutil._psutil_posix' extension 07:50:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:50:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:50:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:50:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:50:03 INFO - Successfully installed psutil 07:50:03 INFO - Cleaning up... 07:50:04 INFO - Return code: 0 07:50:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:04 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 0x218d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449640>, '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 0x244a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a9d0>, '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': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:50:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:50:04 INFO - Using env: {'DISPLAY': ':0', 07:50:04 INFO - 'HOME': '/home/cltbld', 07:50:04 INFO - 'LANG': 'en_US.UTF-8', 07:50:04 INFO - 'LANGUAGE': 'en_US:en', 07:50:04 INFO - 'LOGNAME': 'cltbld', 07:50:04 INFO - 'MAIL': '/var/mail/cltbld', 07:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:04 INFO - 'MOZ_NO_REMOTE': '1', 07:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:04 INFO - 'NO_EM_RESTART': '1', 07:50:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:50:04 INFO - 'PWD': '/builds/slave/test-pgo', 07:50:04 INFO - 'SHELL': '/bin/bash', 07:50:04 INFO - 'SHLVL': '1', 07:50:04 INFO - 'TERM': 'linux', 07:50:04 INFO - 'TMOUT': '86400', 07:50:04 INFO - 'USER': 'cltbld', 07:50:04 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 07:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:04 INFO - '_': '/tools/buildbot/bin/python'} 07:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:50:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:50:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:50:05 INFO - Installing collected packages: mozsystemmonitor 07:50:05 INFO - Running setup.py install for mozsystemmonitor 07:50:06 INFO - Successfully installed mozsystemmonitor 07:50:06 INFO - Cleaning up... 07:50:06 INFO - Return code: 0 07:50:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:06 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 0x218d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449640>, '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 0x244a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a9d0>, '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': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:50:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:50:06 INFO - Using env: {'DISPLAY': ':0', 07:50:06 INFO - 'HOME': '/home/cltbld', 07:50:06 INFO - 'LANG': 'en_US.UTF-8', 07:50:06 INFO - 'LANGUAGE': 'en_US:en', 07:50:06 INFO - 'LOGNAME': 'cltbld', 07:50:06 INFO - 'MAIL': '/var/mail/cltbld', 07:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:06 INFO - 'MOZ_NO_REMOTE': '1', 07:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:06 INFO - 'NO_EM_RESTART': '1', 07:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:50:06 INFO - 'PWD': '/builds/slave/test-pgo', 07:50:06 INFO - 'SHELL': '/bin/bash', 07:50:06 INFO - 'SHLVL': '1', 07:50:06 INFO - 'TERM': 'linux', 07:50:06 INFO - 'TMOUT': '86400', 07:50:06 INFO - 'USER': 'cltbld', 07:50:06 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 07:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:06 INFO - '_': '/tools/buildbot/bin/python'} 07:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:50:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:50:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:50:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:50:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:50:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:08 INFO - Downloading docopt-0.6.1.tar.gz 07:50:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:50:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:50:08 INFO - Installing collected packages: blobuploader, requests, docopt 07:50:08 INFO - Running setup.py install for blobuploader 07:50:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:50:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:50:08 INFO - Running setup.py install for requests 07:50:09 INFO - Running setup.py install for docopt 07:50:09 INFO - Successfully installed blobuploader requests docopt 07:50:09 INFO - Cleaning up... 07:50:09 INFO - Return code: 0 07:50:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:09 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 0x218d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449640>, '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 0x244a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a9d0>, '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': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:50:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:50:09 INFO - Using env: {'DISPLAY': ':0', 07:50:09 INFO - 'HOME': '/home/cltbld', 07:50:09 INFO - 'LANG': 'en_US.UTF-8', 07:50:09 INFO - 'LANGUAGE': 'en_US:en', 07:50:09 INFO - 'LOGNAME': 'cltbld', 07:50:09 INFO - 'MAIL': '/var/mail/cltbld', 07:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:09 INFO - 'MOZ_NO_REMOTE': '1', 07:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:09 INFO - 'NO_EM_RESTART': '1', 07:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:50:09 INFO - 'PWD': '/builds/slave/test-pgo', 07:50:09 INFO - 'SHELL': '/bin/bash', 07:50:09 INFO - 'SHLVL': '1', 07:50:09 INFO - 'TERM': 'linux', 07:50:09 INFO - 'TMOUT': '86400', 07:50:09 INFO - 'USER': 'cltbld', 07:50:09 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 07:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:09 INFO - '_': '/tools/buildbot/bin/python'} 07:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:50:09 INFO - Running setup.py (path:/tmp/pip-mfLakR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:50:09 INFO - Running setup.py (path:/tmp/pip-qghLij-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:50:09 INFO - Running setup.py (path:/tmp/pip-1loMmS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:50:09 INFO - Running setup.py (path:/tmp/pip-paDCCb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:50:09 INFO - Running setup.py (path:/tmp/pip-WtqFdG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:50:09 INFO - Running setup.py (path:/tmp/pip-PA7VxN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:50:09 INFO - Running setup.py (path:/tmp/pip-iiyKw9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:50:10 INFO - Running setup.py (path:/tmp/pip-R98UE3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:50:10 INFO - Running setup.py (path:/tmp/pip-CBHF_i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:50:10 INFO - Running setup.py (path:/tmp/pip-oCAaLu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:50:10 INFO - Running setup.py (path:/tmp/pip-ypLqJ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:50:10 INFO - Running setup.py (path:/tmp/pip-r7PEPY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:50:10 INFO - Running setup.py (path:/tmp/pip-YyH0hf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:50:10 INFO - Running setup.py (path:/tmp/pip-UnxgdS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:50:10 INFO - Running setup.py (path:/tmp/pip-t7XFoh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:50:10 INFO - Running setup.py (path:/tmp/pip-0k7DuA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:50:10 INFO - Running setup.py (path:/tmp/pip-JI6A7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:50:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:50:10 INFO - Running setup.py install for manifestparser 07:50:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:50:10 INFO - Running setup.py install for mozcrash 07:50:10 INFO - Running setup.py install for mozdebug 07:50:11 INFO - Running setup.py install for mozdevice 07:50:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:50:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:50:11 INFO - Running setup.py install for mozfile 07:50:11 INFO - Running setup.py install for mozhttpd 07:50:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:50:11 INFO - Running setup.py install for mozinfo 07:50:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:50:11 INFO - Running setup.py install for mozInstall 07:50:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:50:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:50:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:50:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:50:11 INFO - Running setup.py install for mozleak 07:50:11 INFO - Running setup.py install for mozlog 07:50:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:50:11 INFO - Running setup.py install for moznetwork 07:50:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:50:11 INFO - Running setup.py install for mozprocess 07:50:11 INFO - Running setup.py install for mozprofile 07:50:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:50:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:50:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:50:12 INFO - Running setup.py install for mozrunner 07:50:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:50:12 INFO - Running setup.py install for mozscreenshot 07:50:12 INFO - Running setup.py install for moztest 07:50:12 INFO - Running setup.py install for mozversion 07:50:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:50:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:50:12 INFO - Cleaning up... 07:50:12 INFO - Return code: 0 07:50:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:12 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 0x218d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449640>, '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 0x244a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a9d0>, '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': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:50:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:50:12 INFO - Using env: {'DISPLAY': ':0', 07:50:12 INFO - 'HOME': '/home/cltbld', 07:50:12 INFO - 'LANG': 'en_US.UTF-8', 07:50:12 INFO - 'LANGUAGE': 'en_US:en', 07:50:12 INFO - 'LOGNAME': 'cltbld', 07:50:12 INFO - 'MAIL': '/var/mail/cltbld', 07:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:12 INFO - 'MOZ_NO_REMOTE': '1', 07:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:12 INFO - 'NO_EM_RESTART': '1', 07:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:50:12 INFO - 'PWD': '/builds/slave/test-pgo', 07:50:12 INFO - 'SHELL': '/bin/bash', 07:50:12 INFO - 'SHLVL': '1', 07:50:12 INFO - 'TERM': 'linux', 07:50:12 INFO - 'TMOUT': '86400', 07:50:12 INFO - 'USER': 'cltbld', 07:50:12 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 07:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:12 INFO - '_': '/tools/buildbot/bin/python'} 07:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:50:12 INFO - Running setup.py (path:/tmp/pip-p1PCEA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 07:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:50:12 INFO - Running setup.py (path:/tmp/pip-LzfVI6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:50:12 INFO - Running setup.py (path:/tmp/pip-RKX81n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:50:12 INFO - Running setup.py (path:/tmp/pip-HHk_0x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:50:13 INFO - Running setup.py (path:/tmp/pip-Wxc7cf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:50:13 INFO - Running setup.py (path:/tmp/pip-OZDvnM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:50:13 INFO - Running setup.py (path:/tmp/pip-m38qkl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:50:13 INFO - Running setup.py (path:/tmp/pip-Pv6Otn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:50:13 INFO - Running setup.py (path:/tmp/pip-XU_54x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:50:13 INFO - Running setup.py (path:/tmp/pip-T4t5i7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:50:13 INFO - Running setup.py (path:/tmp/pip-4rdwpa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:50:13 INFO - Running setup.py (path:/tmp/pip-kv5YmD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:50:13 INFO - Running setup.py (path:/tmp/pip-xEZgu0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:50:13 INFO - Running setup.py (path:/tmp/pip-7twXOz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:50:13 INFO - Running setup.py (path:/tmp/pip-pbJllG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:50:13 INFO - Running setup.py (path:/tmp/pip-Yhhiy_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 07:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:50:13 INFO - Running setup.py (path:/tmp/pip-PN8Go2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:50:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:15 INFO - Downloading blessings-1.5.1.tar.gz 07:50:15 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:50:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:50:15 INFO - Installing collected packages: blessings 07:50:15 INFO - Running setup.py install for blessings 07:50:15 INFO - Successfully installed blessings 07:50:15 INFO - Cleaning up... 07:50:15 INFO - Return code: 0 07:50:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:50:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:50:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:50:16 INFO - Reading from file tmpfile_stdout 07:50:16 INFO - Current package versions: 07:50:16 INFO - argparse == 1.2.1 07:50:16 INFO - blessings == 1.5.1 07:50:16 INFO - blobuploader == 1.2.4 07:50:16 INFO - docopt == 0.6.1 07:50:16 INFO - manifestparser == 1.1 07:50:16 INFO - mozInstall == 1.12 07:50:16 INFO - mozcrash == 0.16 07:50:16 INFO - mozdebug == 0.1 07:50:16 INFO - mozdevice == 0.47 07:50:16 INFO - mozfile == 1.2 07:50:16 INFO - mozhttpd == 0.7 07:50:16 INFO - mozinfo == 0.9 07:50:16 INFO - mozleak == 0.1 07:50:16 INFO - mozlog == 3.1 07:50:16 INFO - moznetwork == 0.27 07:50:16 INFO - mozprocess == 0.22 07:50:16 INFO - mozprofile == 0.27 07:50:16 INFO - mozrunner == 6.11 07:50:16 INFO - mozscreenshot == 0.1 07:50:16 INFO - mozsystemmonitor == 0.0 07:50:16 INFO - moztest == 0.7 07:50:16 INFO - mozversion == 1.4 07:50:16 INFO - psutil == 3.1.1 07:50:16 INFO - requests == 1.2.3 07:50:16 INFO - wsgiref == 0.1.2 07:50:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:16 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 0x218d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449640>, '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 0x244a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a9d0>, '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': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:50:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:50:16 INFO - Using env: {'DISPLAY': ':0', 07:50:16 INFO - 'HOME': '/home/cltbld', 07:50:16 INFO - 'LANG': 'en_US.UTF-8', 07:50:16 INFO - 'LANGUAGE': 'en_US:en', 07:50:16 INFO - 'LOGNAME': 'cltbld', 07:50:16 INFO - 'MAIL': '/var/mail/cltbld', 07:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:16 INFO - 'MOZ_NO_REMOTE': '1', 07:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:16 INFO - 'NO_EM_RESTART': '1', 07:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:50:16 INFO - 'PWD': '/builds/slave/test-pgo', 07:50:16 INFO - 'SHELL': '/bin/bash', 07:50:16 INFO - 'SHLVL': '1', 07:50:16 INFO - 'TERM': 'linux', 07:50:16 INFO - 'TMOUT': '86400', 07:50:16 INFO - 'USER': 'cltbld', 07:50:16 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 07:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:16 INFO - '_': '/tools/buildbot/bin/python'} 07:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 07:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 07:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 07:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 07:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 07:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:50:16 INFO - Cleaning up... 07:50:16 INFO - Return code: 0 07:50:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:16 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449640>, '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 0x244a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a9d0>, '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': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:16 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', 'jsonschema'] in /builds/slave/test-pgo/build 07:50:16 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 jsonschema 07:50:16 INFO - Using env: {'DISPLAY': ':0', 07:50:16 INFO - 'HOME': '/home/cltbld', 07:50:16 INFO - 'LANG': 'en_US.UTF-8', 07:50:16 INFO - 'LANGUAGE': 'en_US:en', 07:50:16 INFO - 'LOGNAME': 'cltbld', 07:50:16 INFO - 'MAIL': '/var/mail/cltbld', 07:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:16 INFO - 'MOZ_NO_REMOTE': '1', 07:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:16 INFO - 'NO_EM_RESTART': '1', 07:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:50:16 INFO - 'PWD': '/builds/slave/test-pgo', 07:50:16 INFO - 'SHELL': '/bin/bash', 07:50:16 INFO - 'SHLVL': '1', 07:50:16 INFO - 'TERM': 'linux', 07:50:16 INFO - 'TMOUT': '86400', 07:50:16 INFO - 'USER': 'cltbld', 07:50:16 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 07:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:16 INFO - '_': '/tools/buildbot/bin/python'} 07:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:16 INFO - Downloading/unpacking jsonschema 07:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:50:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:50:18 INFO - Downloading/unpacking functools32 (from jsonschema) 07:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:18 INFO - Downloading functools32-3.2.3-2.tar.gz 07:50:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:50:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:50:18 INFO - warning: no files found matching '*.txt' 07:50:18 INFO - no previously-included directories found matching 'build' 07:50:18 INFO - no previously-included directories found matching 'dist' 07:50:18 INFO - no previously-included directories found matching '.git*' 07:50:18 INFO - Installing collected packages: jsonschema, functools32 07:50:18 INFO - Running setup.py install for functools32 07:50:18 INFO - warning: no files found matching '*.txt' 07:50:18 INFO - no previously-included directories found matching 'build' 07:50:18 INFO - no previously-included directories found matching 'dist' 07:50:18 INFO - no previously-included directories found matching '.git*' 07:50:18 INFO - Successfully installed jsonschema functools32 07:50:18 INFO - Cleaning up... 07:50:18 INFO - Return code: 0 07:50:18 INFO - Running post-action listener: _resource_record_post_action 07:50:18 INFO - Running post-action listener: _start_resource_monitoring 07:50:18 INFO - Starting resource monitoring. 07:50:18 INFO - ##### 07:50:18 INFO - ##### Running install step. 07:50:18 INFO - ##### 07:50:18 INFO - Running pre-action listener: _resource_record_pre_action 07:50:18 INFO - Running main action method: install 07:50:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:50:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:50:18 INFO - Reading from file tmpfile_stdout 07:50:18 INFO - Detecting whether we're running mozinstall >=1.0... 07:50:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:50:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:50:19 INFO - Reading from file tmpfile_stdout 07:50:19 INFO - Output received: 07:50:19 INFO - Usage: mozinstall [options] installer 07:50:19 INFO - Options: 07:50:19 INFO - -h, --help show this help message and exit 07:50:19 INFO - -d DEST, --destination=DEST 07:50:19 INFO - Directory to install application into. [default: 07:50:19 INFO - "/builds/slave/test-pgo"] 07:50:19 INFO - --app=APP Application being installed. [default: firefox] 07:50:19 INFO - mkdir: /builds/slave/test-pgo/build/application 07:50:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:50:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:50:33 INFO - Reading from file tmpfile_stdout 07:50:33 INFO - Output received: 07:50:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:50:33 INFO - Running post-action listener: _resource_record_post_action 07:50:33 INFO - ##### 07:50:33 INFO - ##### Running run-tests step. 07:50:33 INFO - ##### 07:50:33 INFO - Running pre-action listener: _resource_record_pre_action 07:50:33 INFO - Running main action method: run_tests 07:50:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:50:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:50:33 INFO - Python 2.7.3 07:50:33 INFO - Return code: 0 07:50:33 INFO - grabbing minidump binary from tooltool 07:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449640>, '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 0x244a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244a9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:50:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 07:50:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:50:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:50:34 INFO - Return code: 0 07:50:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:50:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:50:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:50:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:50:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:50:34 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/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:50:34 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/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost 07:50:34 INFO - Using env: {'DISPLAY': ':0', 07:50:34 INFO - 'HOME': '/home/cltbld', 07:50:34 INFO - 'LANG': 'en_US.UTF-8', 07:50:34 INFO - 'LANGUAGE': 'en_US:en', 07:50:34 INFO - 'LOGNAME': 'cltbld', 07:50:34 INFO - 'MAIL': '/var/mail/cltbld', 07:50:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:50:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:34 INFO - 'MOZ_NO_REMOTE': '1', 07:50:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:34 INFO - 'NO_EM_RESTART': '1', 07:50:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:50:34 INFO - 'PWD': '/builds/slave/test-pgo', 07:50:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:50:34 INFO - 'SHELL': '/bin/bash', 07:50:34 INFO - 'SHLVL': '1', 07:50:34 INFO - 'TERM': 'linux', 07:50:34 INFO - 'TMOUT': '86400', 07:50:34 INFO - 'USER': 'cltbld', 07:50:34 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897', 07:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:34 INFO - '_': '/tools/buildbot/bin/python'} 07:50:34 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/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] with output_timeout 3600 07:50:34 INFO - mozversion INFO | application_buildid: 20151125053453 07:50:34 INFO - mozversion INFO | application_changeset: ba1686bae88d9ef8b01d16f2e89d0bec5c79e85f 07:50:34 INFO - mozversion INFO | application_display_name: Nightly 07:50:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:50:34 INFO - mozversion INFO | application_name: Firefox 07:50:34 INFO - mozversion INFO | application_remotingname: firefox 07:50:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:50:34 INFO - mozversion INFO | application_vendor: Mozilla 07:50:34 INFO - mozversion INFO | application_version: 45.0a1 07:50:34 INFO - mozversion INFO | platform_buildid: 20151125053453 07:50:34 INFO - mozversion INFO | platform_changeset: ba1686bae88d9ef8b01d16f2e89d0bec5c79e85f 07:50:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:50:34 INFO - mozversion INFO | platform_version: 45.0a1 07:50:34 INFO - 2015-11-25 07:50:34,219 DEBUG : using testdate: 1448466634 07:50:34 INFO - 2015-11-25 07:50:34,219 DEBUG : actual date: 1448466634 07:50:34 INFO - 2015-11-25 07:50:34,229 INFO : starting webserver on 'localhost:41386' 07:50:34 INFO - 2015-11-25 07:50:34,230 INFO : Starting test suite talos-linux64-ix-016.e 07:50:34 INFO - 2015-11-25 07:50:34,230 INFO : Starting test dromaeo_css 07:50:34 INFO - 2015-11-25 07:50:34,230 DEBUG : operating with platform_type : linux_ 07:50:34 INFO - 2015-11-25 07:50:34,231 INFO : Initialising browser for dromaeo_css test... 07:50:34 INFO - 2015-11-25 07:50:34,244 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvynJj0/profile http://localhost:41386/getInfo.html 07:50:38 INFO - 2015-11-25 07:50:38,414 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:50:38 INFO - 2015-11-25 07:50:38,414 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:50:38 INFO - 2015-11-25 07:50:38,415 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:50:38 INFO - 2015-11-25 07:50:38,415 DEBUG : BROWSER_OUTPUT: __metrics 07:50:39 INFO - 2015-11-25 07:50:39,397 INFO : Browser initialized. 07:50:39 INFO - 2015-11-25 07:50:39,398 INFO : Running cycle 1/1 for dromaeo_css test... 07:50:39 INFO - 2015-11-25 07:50:39,398 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvynJj0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:50:51 INFO - 2015-11-25 07:50:51,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 140607488 07:50:51 INFO - 2015-11-25 07:50:51,178 DEBUG : BROWSER_OUTPUT: 07:51:40 INFO - 2015-11-25 07:51:40,785 DEBUG : BROWSER_OUTPUT: 1448466700780 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:53:49 INFO - 2015-11-25 07:53:49,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41386/tests/dromaeo/cssquery-ext.html) 07:53:50 INFO - 2015-11-25 07:53:50,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 149782528 07:53:50 INFO - 2015-11-25 07:53:50,891 DEBUG : BROWSER_OUTPUT: 07:56:52 INFO - 2015-11-25 07:56:52,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/dromaeo/cssquery-ext.html (next: http://localhost:41386/tests/dromaeo/cssquery-jquery.html) 07:56:53 INFO - 2015-11-25 07:56:53,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 141647872 07:56:53 INFO - 2015-11-25 07:56:53,390 DEBUG : BROWSER_OUTPUT: 07:59:55 INFO - 2015-11-25 07:59:55,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41386/tests/dromaeo/cssquery-mootools.html) 07:59:55 INFO - 2015-11-25 07:59:55,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 144838656 07:59:55 INFO - 2015-11-25 07:59:55,678 DEBUG : BROWSER_OUTPUT: 08:02:57 INFO - 2015-11-25 08:02:57,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41386/tests/dromaeo/cssquery-prototype.html) 08:02:57 INFO - 2015-11-25 08:02:57,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 140931072 08:02:57 INFO - 2015-11-25 08:02:57,907 DEBUG : BROWSER_OUTPUT: 08:06:00 INFO - 2015-11-25 08:06:00,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41386/tests/dromaeo/cssquery-yui.html) 08:06:00 INFO - 2015-11-25 08:06:00,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 142913536 08:06:00 INFO - 2015-11-25 08:06:00,856 DEBUG : BROWSER_OUTPUT: 08:09:03 INFO - 2015-11-25 08:09:03,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/dromaeo/cssquery-yui.html (next: http://localhost:41386/tests/dromaeo/cssquery-dojo.html) 08:09:03 INFO - 2015-11-25 08:09:03,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 144531456 08:09:03 INFO - 2015-11-25 08:09:03,572 DEBUG : BROWSER_OUTPUT: 08:09:03 INFO - 2015-11-25 08:09:03,572 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:09:03 INFO - 2015-11-25 08:09:03,572 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:09:03 INFO - 2015-11-25 08:09:03,572 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:09:03 INFO - 2015-11-25 08:09:03,572 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:09:03 INFO - 2015-11-25 08:09:03,572 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3166.1134882232977;3250.3661785951736;3269.591301087364;3288.177955511123;3299.4720844664844;5255.842324730254;5424.755885985131;5436.18457231415;5455.318085239345;5458.153986132151;5291.629585928987;5358.383785864627;5360.088784906566;5414.702191379472;5431.511163995239;4671.299305104228;4931.334269873575;5124.333836601237;5130.256112863633;5149.974250128744;4783.210770222909;5035.446100928895;5051.0403023425615;5102.821401250957;5130.358705161855;4902.975485122587;4914.213725803872;4952.900941981176;4987.501249875019;5027.547520723116;4964.60283177345;4982.87542811429;4983.90032199354;5019.67372120811;5019.723915184663;4806.567408933178;4917.50824917509;4945.455999840015;4971.900561988776;5051.494850514956;5150.175971844525;5167.302414174076;5196.61025423091;5237.554807841338;5271.314729085195;5880.911786323166;5938.851528711773;5941.881162376728;5945.8810823783715;5957.493613042897;5699.145128230757;5846.473817356458;5847.2983242010805;5941.257342832146;5965.910511342333;5467.097928841776;5551.139573366135;5551.694656793875;5562.666240025612;5585.301837270341;5992.131140984533;6008.399160084044;6012.248468941382;6019.909701354483;6054.031354983182;5599.552035837123;5707.514861236758;5727.5990680652785;5793.652380857077;5852.268466441695;5819.767209311664;5824.330202026821;5834.824955251349;5841.795537156264;5882.3529411764675;5719.170720245541;5725;5761.711914404263;5787.363390027093;5829.125631155361;5673.290838645169;5785.537157027427;5800.767969281266;5886.676232807236;5950.315713692894;4510.481294651157;4523.140603285366;4528.773561321921;4542.454905411372;4553.5218802025975;3945.6054394560315;4035.1122752994293;4045.8786236412957;4063;4092.2633925893624;5477.3427188737605;5537.335519737577;5581.720913954286;5607;5642.463965923231;5888.735006924699;5928.851778705481;5935.228420305332;5936.614120082181;5960.6721630309885;5512.0905050667;5618.606697531215;5660.971695141498;5665;5672.461116193955;5071.847844564669;5073.720945348041;5134.255532947702;5142.485751424828;5175.663581867167;6060.575759696867;6071.696415179224;6097.664628445478;6102.938970610326;6109.908351374733;5692.7722891083895;5806.390329015561;5813.273340832396;5854.531637469077;5880.588358814842;6135.693215339126;6136.243373036893;6152;6157.507399408126;6161.969190154021;5828.650280982985;5829.94170058294;5872.882542349214;5901;5924.348321684525;5769;5839.620424672383;5916.763329466773;5918.112283157561;5970.5223582114195;5741.167530708108;5753.712314384347;5767.134929760569;5826.096954971986;5866.120081987736;5740.253767010262;5752.194692743103;5757.222774925499;5759.65442073477;5763.366029736641;5451.073317536107;5563.554915606823;5610.186522954067;5644.379118297066;5652.886942261214;5676.347220069745;5756.539476841759;5771.422857714195;5780.739866705924;5808.970955145197;5536.280283563111;5566.860828479321;5634.4365563443325;5636.689982050862;5643.7742490299925 08:09:03 INFO - 2015-11-25 08:09:03,572 DEBUG : BROWSER_OUTPUT: |1;ext.html;574.6982834012146;584.9064149736043;588.6438704583726;591.964482131072;594.0880748051742;30897.22756931075;40142;40517.594824051754;40650.39024414636;40650.59349406505;43550.56449435505;44009;44202.778986105026;44296.11407771843;44382.55617443832;8696.260817830493;8830.955845220766;8933.330000249975;8943.95528022359;8946.686865959693;8651.264642505395;8754.6935857245;8774.956125219396;8779.34154938379;8783.077776833436;8765.211130998208;8777.253933415668;8856.690015849446;8861;8896.243819275369;8713.041565427799;8786.956065219632;8787.824243515093;8803.163699448542;8805.515696636683;8577.442466239674;8698.782530436727;8707.912920870773;8725.476471411735;8742;39717.20565588701;40271;40593;40602.187956241;40626.593734062575;3219.3722224166295;3336.7163791077787;3351.1287065362935;3353.396388650042;3565.625609311037;29979.850100749576;30371.848140759375;30603.69396306031;30908.227294317596;31110.377792444026;3099.4266060778605;3146.685331466835;3191.12244132863;3257.8859739909226;3321.4021476134285;275310;276162;276568;277197;278189;52374.47625523772;53088.73455632697;60530;61007.6949615258;67593.66203168953;64258;64433;64449;64591;64617.353826461134;15121.395144194328;15179.241037948059;15253.237338133049;15302.464413745689;15317.004394714531;11702.76594468106;11719.179657423898;11754.588589399502;11763;11801.822972655416;20715.171393144406;21177.89411052935;21203.575928481343;21224.575508489743;21275.574488510145;7664.271894170045;7869.095054068741;7873.5275883447175;7946.721864734706;7957.442978991415;943.7310366545502;970.1801977329145;975.6048800235916;979.7256768104942;1049.4752623688155;29283.560746588817;29430.411391772046;29756.2560935974;31866.362672746414;32430.513542296885;1024.6925922223304;1067.0983019348637;1099.5766629847567;1102.8897110288906;1125.4991528769783;14711.705765884837;14875.70248595022;14918;15039.323230454656;15075.170865602497;328772;333984;334343;335175;335778;52860;52898.206526902126;53102.468975309755;53107.73446132745;53225.46774532205;1340.8390993080893;1342.3154191362476;1344.5159742492694;1345.0719003887286;1350.7303135053214;27716.168514944584;28947.56578651364;28969.7103028967;29102.70897291;29105.417891641624;49744.75127624339;50453;50700.23949640832;50728.746356267984;50826;230105;230992;231033;231496;231652;30088.54867177038;32388;32434.513482298258;32702;32918.177045574055;39749.40375894306;39864.800675996434;39892.60107399005;40510;40710.1857962845;34021.65978340185;34291.14272143116;34655.82672086624;34763.65236347604;37131.07172320713;35624.64375356317;36381.27237455183;36611;36821.63178368182;37643.81178094092;35878.28243435169;35970;36838.8158059208;36883.44674829826;36963.63036369602;32490;32707.182320442178;33667;33744.662553375136;34281.314373712885;24604.876975615007;24628.50742985166;26088.478230434906;26279.868600656875;26583.7341626589 08:09:03 INFO - 2015-11-25 08:09:03,572 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.0591614473212;352.3165059784019;353.4203905594824;354.84032185516526;355.0449291406117;16225.350985960562;16623.335066597338;17328.65342693147;17666.911665441654;18337.633247335045;10931.945340273307;10985.066269367093;11119.777604447907;11135.665930022093;11246.606368777095;4942.18453955097;5096.898062038757;5101.336826212587;5140.948590514085;5502.9174562381395;5397.001554712391;5474.808381706641;5477.397486276506;5484.2596249506405;5485.945140548583;5168.22476628505;5328.5470734987575;5338.412774594811;5511.448855114477;5561.249231353756;5345.518903298703;5359.356877174744;5362.008028514737;5369.731513424333;5646.6894320812335;5307.601929855237;5310.44240354761;5337.733113344356;5352.437994010612;5356.892862142735;12463.626091217187;12601.74796504074;18793.342233021915;19474.707879381822;19544.80455195444;2030.1879248300797;2204.75747667758;2263.6717675936898;2267.3878052925784;2290.209877592228;9721.270904682106;9898.713167288279;10039.498025098788;11018.559257629686;13051.151675141085;1802.8647851411197;1842.6959551673958;1845;1883.2467013194694;1924.0956750327323;64247;65393.019104713465;66966.66516667386;67419.66290168518;67705.66147169232;9817.263705222136;10205.948970255102;10294.794104117876;10318.122959548373;10342.534585943651;13260.403281852146;13284.867151328557;13302.534411295559;13304.268265245311;13330.133541319978;7506.474546781782;7672.079350477979;7681.807954801175;7719.807004824925;7763.72826951054;7098.893516597152;7388.408927285805;7450.888236676454;7498.700051997968;7513.2111128331835;4258.510271318838;4323.156984388077;4480.39514665516;4487.820487180542;4490;1777.413453560322;1843.3640394064028;1860.8232217939274;1870.747449094382;1873.7657792775904;948.5731420860641;957.5834511987308;1000.5347513406156;1013.2248829645328;1029.840374741916;13947.86052139486;16248.431304904272;17061.658766824596;17264.654706905792;17583.912080439517;961.4087336288133;967.5936106835146;1000.6797824696027;1006.0744115413837;1063.7234319077095;9614;10158.695239142837;10178.592856285666;10180.185585153318;10229.43738094412;501421;516090;526248;529878;547964;80380;82635.99999999879;83553.16446835455;83747;83759;1188.7503624238834;1190.4464424042687;1238.6779437346354;1239.070696977267;1256.7298030923396;15438.5368438947;15631.84368156304;15643.608909777347;15662.765058523903;15685.398390451626;34729.65270347264;35115.586725010144;35165.64834351726;35524.46713299251;36248.637513624526;47559.76220118877;49086.75456622837;49109.754451228946;49608.75195623999;49709.50290497049;9354.906450935403;9765.804683906425;9855.901440985785;9915.801683966425;10060.49697515136;11376.715582110182;11468.31190128595;11531.711707207387;11540.480678369662;13411.664708382368;13615.25116118623;13772.862271377558;14394.568162955127;14555.12669239849;14698.55904322872;14723.92638036803;14906.403743850124;14919.701605967603;14959.626009349853;15020;14800;14820.629484262548;15212.771808423104;15306.923465382602;15404.691906162037;9726.70819875405;9858.704238872846;9984.900150998397;10015.449150296512;10019.897811240611;13426;14147;14920.104793712411;14986.100833949999;15402.46091386796 08:09:03 INFO - 2015-11-25 08:09:03,572 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1505.0743792567573;1672.2725614357753;1726.9034163306296;1735.9045252511114;1739.8260173982599;6557.409833115019;6700.664966751655;6910.447164226863;7234.674439650215;7243.8913416298665;6938.583684978905;7118.074650295467;7133.429325653949;7137.60743159126;7139.785806425815;2188.8248940084754;2207.4702071502884;2220.1563405905813;2224.5662095891307;2229.063793206857;2215.1360969222014;2221.1448592292004;2295.449092217864;2298.0348253733387;2298.367948814081;2202.8458007939453;2217.6008318502663;2242.5402792427512;2252.76098146019;2253.267688001398;2213.7786221377733;2233.084435381494;2259.2318611672026;2261.7172853393326;2271.068861766668;2247.359502541784;2264.8188144948363;2272.1933713531625;2274.9545009099725;2276.2488378834946;7228.168760592546;7277.854442911165;7296.343329100407;7299.708011679527;7327;4480.126375356806;4513.842015529473;4536.3422303765765;4558.635309175291;4560.019595786922;2920.32832448538;3065.4482193205213;3074.2468095316567;3092.8298943558098;3098.7675924305768;967.7870868408938;976.4580657735025;982.4350998176077;1010.0909181736423;1019.5819713917332;9615.807683846284;9616.423014619075;9623.518824058769;9690.32167748258;9707.757306067404;4131.338985762263;4141.254574176617;4153.480814898137;4178.373244013423;4216.2832318505925;8214.424990250745;8267.62795674196;8279.213474719892;8297.170282971776;8308.086110527836;4559.088182363541;4559.247724125482;4568.497465278817;4580.885477863014;4589.0821835633005;4105.261053010427;4170.854020109282;4192.685548583869;4199.895002624959;4201.054762678373;3475.8609655614;3503.089196808848;3508.193115583379;3532.7527073104634;3533.982330088333;1092.0390056750168;1092.9945350273197;1094.874089479704;1098.0940723902813;1103.0568863621647;1282.3844554613838;1289.2715615677112;1305.1320871620267;1332.920024798496;1340.7921772125337;6609.405153536109;6771.085903402977;6796.150481189851;6803.285655006153;6817.659117044128;486.4260172995899;501.19307914258013;505.0656285871109;505.23709199109607;506.86821426429395;5512.145617429305;5527.806526771544;5540.168974653753;5544.667319960815;5552.500274975271;8439.451435656663;8545.743627691056;8551.401401901932;8561.743147705454;8637.568121593895;8518.105598912025;8521;8544.61549230286;8544.871826922601;8570.100139485388;6381.361863813581;6474.741010359533;6528.412442880163;6942.895856562156;7038.824029399306;6970.337817907291;6996.160460744743;7036.401905838061;7038.577685338896;7039.964800175966;7666.38668906475;7885.842283154419;7936.365090792839;8032.879506807286;8071.959640201761;7976.441649084509;8022.478538894953;8081.83836323282;8094.595270236347;8136.471129376809;6095.2685677718955;6594.175728033996;6608.273089960005;6619.834504137242;6667.766628168185;7011.754588589375;7045.26024767392;7047.224805271519;7056.188538318159;7059.047028651272;6534.497065674826;6594.4724422045165;6679;6703.061571380108;6781.321867813376;6514.706838192387;6589.637569933508;6595.373439523238;6671.66641667905;6681.365270299314;6555.573887697285;6569.967150164219;6573.474122070318;6589.571677840925;6606.10817539626;5869.7945571904775;5892.499137573354;5909.409059094056;5930.495907847881;5933.792317268875;5947.613405128653;5963.493103086286;5990.311114221746;6005.159277701038;6015.12780646795 08:09:03 INFO - 2015-11-25 08:09:03,572 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.6617050608379;332.55437713463954;332.80530889429684;340.3601229688186;342.8662821499615;6259.968700156499;6264.5928014679075;6276.780312689057;6335.524835637329;6420.7752728654505;6229.626222426647;6233.376662333764;6275.874482510347;6285.811425657226;6287.30839607644;4744.217204161309;4760.952390476103;4761.952380476186;4764.880877978044;4767.499412561683;4762.785674644632;4766.094442055998;4776.80892764289;4777.426708794932;4789.473157952622;4626.583607475327;4703.15343238217;4720.1739695553315;4728.881777955544;4742.715437073786;4709.364235828154;4713.670043096968;4721.787519561628;4727.196376615983;4735.360726301974;4077.7757223352705;4084.36692312692;4092.283850326181;4098.077932465201;4108.465899433085;5853.970730146322;5944.405559444064;5985.431384018555;6002.699865006733;6014.428629280212;5386.515213630752;5473.589480788957;5507.118860982224;5511.696856672881;5522.199281104257;6657.800265992028;6666.333366663295;6673.165854268216;6677.565958212701;6688.83277918051;4539.909201815978;4541.795619197144;4543.341215523764;4548.499665036877;4550;6822.863542729167;6903.378695917341;6930.61881596512;6954.235034146291;6985.336393042653;4629.3518907353;4629.745364004944;4633.258678611473;4638.1187574360765;4641.2109941310055;4684;4691.108689349013;4700.224462963641;4702.95297047032;4720;5481;5483.588730845203;5487.478689524489;5490.039243132436;5496.945030549723;6522.412982831473;6673.499487538357;6744.898826517606;6745.156855393076;6750.561213521106;1632.306269835339;1654.2555849867608;1670.607407259293;1675.1875340459867;1675.354988329502;1100.9614663486739;1101.7465982823996;1112.1214240749878;1118.1893127482672;1125.1111621818836;6342.809715708536;6421.8073457796345;6429.324920883333;6473.449756770728;6490.318516555788;6752.662366881636;6786.626735529593;6814.386705196556;6834.555753876081;6835.282295359015;6444.420002199825;6454.2577603575255;6462.838429039311;6472;6475.190601174853;3788.6211378862445;3796.2976849282973;3817.6373244541724;3819.388897776342;3829.5978922213326;7325.377342925911;7325.523840950428;7333.413326933833;7338.302861228175;7346.63266836656;7049.89425158623;7211.314925082109;7225.205227424979;7225.494215404871;7235.963820180866;7233.1681856587165;7294.3799777018485;7299.489035767445;7307.7807665770115;7314.634268286564;6949.68726407323;6968.581885086911;6971.3028697129885;6975.267596902252;6997.650117494003;6696.7656132035145;6812.182538095461;6831.316868313129;6913.101296831581;6914.757983470555;7252.528585641917;7255.673494692857;7266.89099663516;7271.490995630255;7323.816904577428;4611.538846115362;4617.0996655651825;4627.629789616755;4637.39713837199;4639.188142075056;6734.764283250062;6788.083608712761;6910.343517365842;6965.024896514391;6968.059311992816;6675.766348177791;6696.5647232929705;6704.497162712913;6744;6793.116894803644;6763.222229443677;6765.898511522233;6774.796756097325;6774.898376524455;6803.557768745016;6466.741330346734;6598.571092878948;6628.5691430056895;6647.567908085959;6654.068430419842;6757.189137303555;6767.93232067673;6768.9661551691925;6775.762848300285;6805.877030289947;6603.669816509251;6623.867522649423;6624.436922861611;6638.236602790547;6659.633720145439 08:09:03 INFO - 2015-11-25 08:09:03,572 DEBUG : BROWSER_OUTPUT: |5;yui.html;628.600838467573;673.7170388436856;677.1806114601333;705.9939586089822;732.882738761798;13238.801417978739;13764.174149551009;13814.861851381484;13954;13966.511172108965;13092.934535327335;13287.468501259938;13346.599602011931;13394.59816205513;13398.464061437555;795.2643804480861;808.8422757562278;826.2687521543447;832.4464231286188;846.2552953400999;842.7893026743315;844.5312851367488;846.6401779243828;847.8261956298975;847.8473874702551;882.4484697064335;884.6903583745702;887.6893087419417;891.7413949954538;892.0410558649445;868.288003836854;868.8045189832237;872.646578135856;876.5091548732698;877.4472082587961;634.5082561015204;642.6401215319436;644.7614382678439;648.3548868875451;652.6834485274638;12755.872441275562;12841.036922230776;12845.165064270886;12880.549180778722;12882;11550.884491155064;11555.133364997659;11766.176367654267;11857.347845868473;12049.57826476078;9487.241020718326;9589.18491928187;9816.361936474177;9989.950050249703;10055.245856560714;3547.8758243461357;3573.3210689969083;3609.6029436761937;3654.634536546324;3663.87176448823;48797.26804097941;49728;49861.252081218445;49913.50086499125;49927.75036124796;9004;9114;9191.724248272563;9292.767680808034;9357.39176953496;17478.825211747975;17563.64872702539;17570.209340579706;17573.297068117132;17733.37933172333;7306.2693730626515;7425.591592462359;7449.813754656177;7537.133229678548;7628.923710762932;4215.936760948588;4423.093265880487;4436.6228870546365;4441.711288766284;4454.37638730578;2868.6127372804403;2882.884684612592;2897.6233089698203;2900.419916016805;2904.997775767357;527.1276038156857;533.9279197308391;534.5723421263052;535.1865164949334;539.9460053994648;477.29360546391536;546.4016901492859;568.4372471253429;575.9078547432391;583.9941600584025;7706.229377062249;7944.721934732373;8035.397345199133;8038.477498962548;8183.181681831769;501.25563538145826;512.6872607709295;526.6550409481796;543.2774410034723;633.1104797759064;3791.6018818024263;3815.275097731422;3863.1114843586133;3968.8412463501713;3970.2258059678084;56879;57918;57936.710316448145;58034;61758.69120654368;54484.182737258976;54571.81712731446;54689.726551367785;55225;55379;49127.26309105366;49281.75359123181;49952.500474994784;50108.74945625249;50275.497245027815;8356;8483.74548763538;8523.531205783742;8542.615582298935;8544.700935467228;36376.27247455089;36436.81781591075;37240;37774.24451511009;37867;44932.77533612311;46218.30672539847;46306.76846615745;46378.07243855036;46734;10384.221183411426;10554.683359499228;10690.89309106899;10789.56841726322;10837.837432438362;10413.219008574539;10473.685789426025;10665.680029599125;11617.186796924134;11999.460024299102;10241.180705543688;10546.367217966947;10691.679249622524;10699.732506687395;10739.14086873064;10065.748356291151;10132.544035518567;10505.68482945513;10805.45972701346;10828.24202305831;10147.949260253652;10202.897971020491;10220.591176352862;10332.638357657446;10412.32319899204;9261.490618016074;9643.614255429984;9679.66121185755;9832.410055396698;9841.557129929028;8642.913570864212;8748.518831464331;9253.67612133599;9291.581878815334;9296.163345298955 08:09:03 INFO - 2015-11-25 08:09:03,573 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:09:03 INFO - 2015-11-25 08:09:03,573 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:09:03 INFO - 2015-11-25 08:09:03,573 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,303 08:09:03 INFO - 2015-11-25 08:09:03,573 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:09:03 INFO - 2015-11-25 08:09:03,573 DEBUG : BROWSER_OUTPUT: __startTimestamp1448467743564__endTimestamp 08:09:03 INFO - 2015-11-25 08:09:03,573 DEBUG : BROWSER_OUTPUT: 08:09:03 INFO - 2015-11-25 08:09:03,573 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:09:03 INFO - 2015-11-25 08:09:03,573 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:09:03 INFO - 2015-11-25 08:09:03,573 DEBUG : BROWSER_OUTPUT: 08:09:03 INFO - 2015-11-25 08:09:03,573 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5447.54 Median:5652.89 stddev:611.97 (10.8%) stddev-sans-first:587.10 08:09:03 INFO - 2015-11-25 08:09:03,574 DEBUG : BROWSER_OUTPUT: Values: 3166.1 3250.4 3269.6 3288.2 3299.5 5255.8 5424.8 5436.2 5455.3 5458.2 5291.6 5358.4 5360.1 5414.7 5431.5 4671.3 4931.3 5124.3 5130.3 5150.0 4783.2 5035.4 5051.0 5102.8 5130.4 4903.0 4914.2 4952.9 4987.5 5027.5 4964.6 4982.9 4983.9 5019.7 5019.7 4806.6 4917.5 4945.5 4971.9 5051.5 5150.2 5167.3 5196.6 5237.6 5271.3 5880.9 5938.9 5941.9 5945.9 5957.5 5699.1 5846.5 5847.3 5941.3 5965.9 5467.1 5551.1 5551.7 5562.7 5585.3 5992.1 6008.4 6012.2 6019.9 6054.0 5599.6 5707.5 5727.6 5793.7 5852.3 5819.8 5824.3 5834.8 5841.8 5882.4 5719.2 5725.0 5761.7 5787.4 5829.1 5673.3 5785.5 5800.8 5886.7 5950.3 4510.5 4523.1 4528.8 4542.5 4553.5 3945.6 4035.1 4045.9 4063.0 4092.3 5477.3 5537.3 5581.7 5607.0 5642.5 5888.7 5928.9 5935.2 5936.6 5960.7 5512.1 5618.6 5661.0 5665.0 5672.5 5071.8 5073.7 5134.3 5142.5 5175.7 6060.6 6071.7 6097.7 6102.9 6109.9 5692.8 5806.4 5813.3 5854.5 5880.6 6135.7 6136.2 6152.0 6157.5 6162.0 5828.7 5829.9 5872.9 5901.0 5924.3 5769.0 5839.6 5916.8 5918.1 5970.5 5741.2 5753.7 5767.1 5826.1 5866.1 5740.3 5752.2 5757.2 5759.7 5763.4 5451.1 5563.6 5610.2 5644.4 5652.9 5676.3 5756.5 5771.4 5780.7 5809.0 5536.3 5566.9 5634.4 5636.7 5643.8 08:09:03 INFO - 2015-11-25 08:09:03,575 DEBUG : BROWSER_OUTPUT: 08:09:03 INFO - 2015-11-25 08:09:03,575 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45720.73 Median:19595.13 stddev:74108.33 (378.2%) stddev-sans-first:74238.70 08:09:03 INFO - 2015-11-25 08:09:03,575 DEBUG : BROWSER_OUTPUT: Values: 574.7 584.9 588.6 592.0 594.1 30897.2 40142.0 40517.6 40650.4 40650.6 43550.6 44009.0 44202.8 44296.1 44382.6 8696.3 8831.0 8933.3 8944.0 8946.7 8651.3 8754.7 8775.0 8779.3 8783.1 8765.2 8777.3 8856.7 8861.0 8896.2 8713.0 8787.0 8787.8 8803.2 8805.5 8577.4 8698.8 8707.9 8725.5 8742.0 39717.2 40271.0 40593.0 40602.2 40626.6 3219.4 3336.7 3351.1 3353.4 3565.6 29979.9 30371.8 30603.7 30908.2 31110.4 3099.4 3146.7 3191.1 3257.9 3321.4 275310.0 276162.0 276568.0 277197.0 278189.0 52374.5 53088.7 60530.0 61007.7 67593.7 64258.0 64433.0 64449.0 64591.0 64617.4 15121.4 15179.2 15253.2 15302.5 15317.0 11702.8 11719.2 11754.6 11763.0 11801.8 20715.2 21177.9 21203.6 21224.6 21275.6 7664.3 7869.1 7873.5 7946.7 7957.4 943.7 970.2 975.6 979.7 1049.5 29283.6 29430.4 29756.3 31866.4 32430.5 1024.7 1067.1 1099.6 1102.9 1125.5 14711.7 14875.7 14918.0 15039.3 15075.2 328772.0 333984.0 334343.0 335175.0 335778.0 52860.0 52898.2 53102.5 53107.7 53225.5 1340.8 1342.3 1344.5 1345.1 1350.7 27716.2 28947.6 28969.7 29102.7 29105.4 49744.8 50453.0 50700.2 50728.7 50826.0 230105.0 230992.0 231033.0 231496.0 231652.0 30088.5 32388.0 32434.5 32702.0 32918.2 39749.4 39864.8 39892.6 40510.0 40710.2 34021.7 34291.1 34655.8 34763.7 37131.1 35624.6 36381.3 36611.0 36821.6 37643.8 35878.3 35970.0 36838.8 36883.4 36963.6 32490.0 32707.2 33667.0 33744.7 34281.3 24604.9 24628.5 26088.5 26279.9 26583.7 08:09:03 INFO - 2015-11-25 08:09:03,575 DEBUG : BROWSER_OUTPUT: 08:09:03 INFO - 2015-11-25 08:09:03,575 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28476.94 Median:2117.47 stddev:85887.67 (4056.1%) stddev-sans-first:86102.64 08:09:03 INFO - 2015-11-25 08:09:03,575 DEBUG : BROWSER_OUTPUT: Values: 351.1 352.3 353.4 354.8 355.0 16225.4 16623.3 17328.7 17666.9 18337.6 10931.9 10985.1 11119.8 11135.7 11246.6 4942.2 5096.9 5101.3 5140.9 5502.9 5397.0 5474.8 5477.4 5484.3 5485.9 5168.2 5328.5 5338.4 5511.4 5561.2 5345.5 5359.4 5362.0 5369.7 5646.7 5307.6 5310.4 5337.7 5352.4 5356.9 12463.6 12601.7 18793.3 19474.7 19544.8 2030.2 2204.8 2263.7 2267.4 2290.2 9721.3 9898.7 10039.5 11018.6 13051.2 1802.9 1842.7 1845.0 1883.2 1924.1 64247.0 65393.0 66966.7 67419.7 67705.7 9817.3 10205.9 10294.8 10318.1 10342.5 13260.4 13284.9 13302.5 13304.3 13330.1 7506.5 7672.1 7681.8 7719.8 7763.7 7098.9 7388.4 7450.9 7498.7 7513.2 4258.5 4323.2 4480.4 4487.8 4490.0 1777.4 1843.4 1860.8 1870.7 1873.8 948.6 957.6 1000.5 1013.2 1029.8 13947.9 16248.4 17061.7 17264.7 17583.9 961.4 967.6 1000.7 1006.1 1063.7 9614.0 10158.7 10178.6 10180.2 10229.4 501421.0 516090.0 526248.0 529878.0 547964.0 80380.0 82636.0 83553.2 83747.0 83759.0 1188.8 1190.4 1238.7 1239.1 1256.7 15438.5 15631.8 15643.6 15662.8 15685.4 34729.7 35115.6 35165.6 35524.5 36248.6 47559.8 49086.8 49109.8 49608.8 49709.5 9354.9 9765.8 9855.9 9915.8 10060.5 11376.7 11468.3 11531.7 11540.5 13411.7 13615.3 13772.9 14394.6 14555.1 14698.6 14723.9 14906.4 14919.7 14959.6 15020.0 14800.0 14820.6 15212.8 15306.9 15404.7 9726.7 9858.7 9984.9 10015.4 10019.9 13426.0 14147.0 14920.1 14986.1 15402.5 08:09:03 INFO - 2015-11-25 08:09:03,575 DEBUG : BROWSER_OUTPUT: 08:09:03 INFO - 2015-11-25 08:09:03,575 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5121.92 Median:6010.14 stddev:2571.48 (42.8%) stddev-sans-first:2564.32 08:09:03 INFO - 2015-11-25 08:09:03,576 DEBUG : BROWSER_OUTPUT: Values: 1505.1 1672.3 1726.9 1735.9 1739.8 6557.4 6700.7 6910.4 7234.7 7243.9 6938.6 7118.1 7133.4 7137.6 7139.8 2188.8 2207.5 2220.2 2224.6 2229.1 2215.1 2221.1 2295.4 2298.0 2298.4 2202.8 2217.6 2242.5 2252.8 2253.3 2213.8 2233.1 2259.2 2261.7 2271.1 2247.4 2264.8 2272.2 2275.0 2276.2 7228.2 7277.9 7296.3 7299.7 7327.0 4480.1 4513.8 4536.3 4558.6 4560.0 2920.3 3065.4 3074.2 3092.8 3098.8 967.8 976.5 982.4 1010.1 1019.6 9615.8 9616.4 9623.5 9690.3 9707.8 4131.3 4141.3 4153.5 4178.4 4216.3 8214.4 8267.6 8279.2 8297.2 8308.1 4559.1 4559.2 4568.5 4580.9 4589.1 4105.3 4170.9 4192.7 4199.9 4201.1 3475.9 3503.1 3508.2 3532.8 3534.0 1092.0 1093.0 1094.9 1098.1 1103.1 1282.4 1289.3 1305.1 1332.9 1340.8 6609.4 6771.1 6796.2 6803.3 6817.7 486.4 501.2 505.1 505.2 506.9 5512.1 5527.8 5540.2 5544.7 5552.5 8439.5 8545.7 8551.4 8561.7 8637.6 8518.1 8521.0 8544.6 8544.9 8570.1 6381.4 6474.7 6528.4 6942.9 7038.8 6970.3 6996.2 7036.4 7038.6 7040.0 7666.4 7885.8 7936.4 8032.9 8072.0 7976.4 8022.5 8081.8 8094.6 8136.5 6095.3 6594.2 6608.3 6619.8 6667.8 7011.8 7045.3 7047.2 7056.2 7059.0 6534.5 6594.5 6679.0 6703.1 6781.3 6514.7 6589.6 6595.4 6671.7 6681.4 6555.6 6570.0 6573.5 6589.6 6606.1 5869.8 5892.5 5909.4 5930.5 5933.8 5947.6 5963.5 5990.3 6005.2 6015.1 08:09:03 INFO - 2015-11-25 08:09:03,576 DEBUG : BROWSER_OUTPUT: 08:09:03 INFO - 2015-11-25 08:09:03,576 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5589.64 Median:6421.29 stddev:1720.93 (26.8%) stddev-sans-first:1679.89 08:09:03 INFO - 2015-11-25 08:09:03,577 DEBUG : BROWSER_OUTPUT: Values: 331.7 332.6 332.8 340.4 342.9 6260.0 6264.6 6276.8 6335.5 6420.8 6229.6 6233.4 6275.9 6285.8 6287.3 4744.2 4761.0 4762.0 4764.9 4767.5 4762.8 4766.1 4776.8 4777.4 4789.5 4626.6 4703.2 4720.2 4728.9 4742.7 4709.4 4713.7 4721.8 4727.2 4735.4 4077.8 4084.4 4092.3 4098.1 4108.5 5854.0 5944.4 5985.4 6002.7 6014.4 5386.5 5473.6 5507.1 5511.7 5522.2 6657.8 6666.3 6673.2 6677.6 6688.8 4539.9 4541.8 4543.3 4548.5 4550.0 6822.9 6903.4 6930.6 6954.2 6985.3 4629.4 4629.7 4633.3 4638.1 4641.2 4684.0 4691.1 4700.2 4703.0 4720.0 5481.0 5483.6 5487.5 5490.0 5496.9 6522.4 6673.5 6744.9 6745.2 6750.6 1632.3 1654.3 1670.6 1675.2 1675.4 1101.0 1101.7 1112.1 1118.2 1125.1 6342.8 6421.8 6429.3 6473.4 6490.3 6752.7 6786.6 6814.4 6834.6 6835.3 6444.4 6454.3 6462.8 6472.0 6475.2 3788.6 3796.3 3817.6 3819.4 3829.6 7325.4 7325.5 7333.4 7338.3 7346.6 7049.9 7211.3 7225.2 7225.5 7236.0 7233.2 7294.4 7299.5 7307.8 7314.6 6949.7 6968.6 6971.3 6975.3 6997.7 6696.8 6812.2 6831.3 6913.1 6914.8 7252.5 7255.7 7266.9 7271.5 7323.8 4611.5 4617.1 4627.6 4637.4 4639.2 6734.8 6788.1 6910.3 6965.0 6968.1 6675.8 6696.6 6704.5 6744.0 6793.1 6763.2 6765.9 6774.8 6774.9 6803.6 6466.7 6598.6 6628.6 6647.6 6654.1 6757.2 6767.9 6769.0 6775.8 6805.9 6603.7 6623.9 6624.4 6638.2 6659.6 08:09:03 INFO - 2015-11-25 08:09:03,577 DEBUG : BROWSER_OUTPUT: 08:09:03 INFO - 2015-11-25 08:09:03,577 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13917.65 Median:25305.00 stddev:16762.09 (66.2%) stddev-sans-first:16779.41 08:09:03 INFO - 2015-11-25 08:09:03,577 DEBUG : BROWSER_OUTPUT: Values: 628.6 673.7 677.2 706.0 732.9 13238.8 13764.2 13814.9 13954.0 13966.5 13092.9 13287.5 13346.6 13394.6 13398.5 795.3 808.8 826.3 832.4 846.3 842.8 844.5 846.6 847.8 847.8 882.4 884.7 887.7 891.7 892.0 868.3 868.8 872.6 876.5 877.4 634.5 642.6 644.8 648.4 652.7 12755.9 12841.0 12845.2 12880.5 12882.0 11550.9 11555.1 11766.2 11857.3 12049.6 9487.2 9589.2 9816.4 9990.0 10055.2 3547.9 3573.3 3609.6 3654.6 3663.9 48797.3 49728.0 49861.3 49913.5 49927.8 9004.0 9114.0 9191.7 9292.8 9357.4 17478.8 17563.6 17570.2 17573.3 17733.4 7306.3 7425.6 7449.8 7537.1 7628.9 4215.9 4423.1 4436.6 4441.7 4454.4 2868.6 2882.9 2897.6 2900.4 2905.0 527.1 533.9 534.6 535.2 539.9 477.3 546.4 568.4 575.9 584.0 7706.2 7944.7 8035.4 8038.5 8183.2 501.3 512.7 526.7 543.3 633.1 3791.6 3815.3 3863.1 3968.8 3970.2 56879.0 57918.0 57936.7 58034.0 61758.7 54484.2 54571.8 54689.7 55225.0 55379.0 49127.3 49281.8 49952.5 50108.7 50275.5 8356.0 8483.7 8523.5 8542.6 8544.7 36376.3 36436.8 37240.0 37774.2 37867.0 44932.8 46218.3 46306.8 46378.1 46734.0 10384.2 10554.7 10690.9 10789.6 10837.8 10413.2 10473.7 10665.7 11617.2 11999.5 10241.2 10546.4 10691.7 10699.7 10739.1 10065.7 10132.5 10505.7 10805.5 10828.2 10147.9 10202.9 10220.6 10332.6 10412.3 9261.5 9643.6 9679.7 9832.4 9841.6 8642.9 8748.5 9253.7 9291.6 9296.2 08:09:03 INFO - 2015-11-25 08:09:03,577 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:09:03 INFO - 2015-11-25 08:09:03,577 DEBUG : BROWSER_OUTPUT: 08:09:04 INFO - 2015-11-25 08:09:04,305 INFO : Browser exited with error code: 0 08:09:04 INFO - 2015-11-25 08:09:04,329 INFO : Completed test dromaeo_css (00:18:30) 08:09:04 INFO - 2015-11-25 08:09:04,329 INFO : Starting test kraken 08:09:04 INFO - 2015-11-25 08:09:04,329 DEBUG : operating with platform_type : linux_ 08:09:04 INFO - 2015-11-25 08:09:04,329 INFO : Initialising browser for kraken test... 08:09:04 INFO - 2015-11-25 08:09:04,335 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpm6okNH/profile http://localhost:41386/getInfo.html 08:09:08 INFO - 2015-11-25 08:09:08,715 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:09:08 INFO - 2015-11-25 08:09:08,715 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:09:08 INFO - 2015-11-25 08:09:08,715 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:09:08 INFO - 2015-11-25 08:09:08,715 DEBUG : BROWSER_OUTPUT: __metrics 08:09:09 INFO - 2015-11-25 08:09:09,697 INFO : Browser initialized. 08:09:09 INFO - 2015-11-25 08:09:09,698 INFO : Running cycle 1/1 for kraken test... 08:09:09 INFO - 2015-11-25 08:09:09,698 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpm6okNH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:09:21 INFO - 2015-11-25 08:09:21,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 138223616 08:09:21 INFO - 2015-11-25 08:09:21,449 DEBUG : BROWSER_OUTPUT: 08:09:23 INFO - 2015-11-25 08:09:23,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41386/tests/kraken/driver.html?testName=audio-beat-detection) 08:09:24 INFO - 2015-11-25 08:09:24,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 140947456 08:09:24 INFO - 2015-11-25 08:09:24,536 DEBUG : BROWSER_OUTPUT: 08:09:27 INFO - 2015-11-25 08:09:27,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41386/tests/kraken/driver.html?testName=audio-dft) 08:09:27 INFO - 2015-11-25 08:09:27,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 140787712 08:09:27 INFO - 2015-11-25 08:09:27,740 DEBUG : BROWSER_OUTPUT: 08:09:30 INFO - 2015-11-25 08:09:30,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41386/tests/kraken/driver.html?testName=audio-fft) 08:09:31 INFO - 2015-11-25 08:09:31,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 135512064 08:09:31 INFO - 2015-11-25 08:09:31,169 DEBUG : BROWSER_OUTPUT: 08:09:33 INFO - 2015-11-25 08:09:33,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41386/tests/kraken/driver.html?testName=audio-oscillator) 08:09:33 INFO - 2015-11-25 08:09:33,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 135593984 08:09:33 INFO - 2015-11-25 08:09:33,780 DEBUG : BROWSER_OUTPUT: 08:09:35 INFO - 2015-11-25 08:09:35,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41386/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:09:36 INFO - 2015-11-25 08:09:36,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 136732672 08:09:36 INFO - 2015-11-25 08:09:36,572 DEBUG : BROWSER_OUTPUT: 08:09:39 INFO - 2015-11-25 08:09:39,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41386/tests/kraken/driver.html?testName=imaging-darkroom) 08:09:40 INFO - 2015-11-25 08:09:40,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 137060352 08:09:40 INFO - 2015-11-25 08:09:40,104 DEBUG : BROWSER_OUTPUT: 08:09:43 INFO - 2015-11-25 08:09:43,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41386/tests/kraken/driver.html?testName=imaging-desaturate) 08:09:44 INFO - 2015-11-25 08:09:44,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 137232384 08:09:44 INFO - 2015-11-25 08:09:44,078 DEBUG : BROWSER_OUTPUT: 08:09:46 INFO - 2015-11-25 08:09:46,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41386/tests/kraken/driver.html?testName=json-parse-financial) 08:09:47 INFO - 2015-11-25 08:09:47,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 137809920 08:09:47 INFO - 2015-11-25 08:09:47,523 DEBUG : BROWSER_OUTPUT: 08:09:49 INFO - 2015-11-25 08:09:49,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41386/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:09:49 INFO - 2015-11-25 08:09:49,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 138821632 08:09:49 INFO - 2015-11-25 08:09:49,692 DEBUG : BROWSER_OUTPUT: 08:09:51 INFO - 2015-11-25 08:09:51,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:09:52 INFO - 2015-11-25 08:09:52,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 138506240 08:09:52 INFO - 2015-11-25 08:09:52,218 DEBUG : BROWSER_OUTPUT: 08:09:54 INFO - 2015-11-25 08:09:54,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:09:54 INFO - 2015-11-25 08:09:54,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 139653120 08:09:54 INFO - 2015-11-25 08:09:54,883 DEBUG : BROWSER_OUTPUT: 08:09:57 INFO - 2015-11-25 08:09:57,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:09:57 INFO - 2015-11-25 08:09:57,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 137699328 08:09:57 INFO - 2015-11-25 08:09:57,934 DEBUG : BROWSER_OUTPUT: 08:10:00 INFO - 2015-11-25 08:10:00,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:10:01 INFO - 2015-11-25 08:10:01,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 139079680 08:10:01 INFO - 2015-11-25 08:10:01,083 DEBUG : BROWSER_OUTPUT: 08:10:02 INFO - 2015-11-25 08:10:02,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41386/tests/kraken/driver.html?testName=ai-astar) 08:10:03 INFO - 2015-11-25 08:10:03,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 138985472 08:10:03 INFO - 2015-11-25 08:10:03,003 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,004 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:10:03 INFO - 2015-11-25 08:10:03,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:10:03 INFO - 2015-11-25 08:10:03,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:10:03 INFO - 2015-11-25 08:10:03,005 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:10:03 INFO - 2015-11-25 08:10:03,005 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;111;113;111;122;111;111;109;110 08:10:03 INFO - 2015-11-25 08:10:03,006 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;132;150;164;126;153;157;127;156;128 08:10:03 INFO - 2015-11-25 08:10:03,006 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;163;162;161;163;161;163;163;173;164 08:10:03 INFO - 2015-11-25 08:10:03,006 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;75;72;71;73;137;74;72;72 08:10:03 INFO - 2015-11-25 08:10:03,006 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;146;94;93;93;137;94;95;139 08:10:03 INFO - 2015-11-25 08:10:03,007 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;111;110;110;109;110;110;110;110;110 08:10:03 INFO - 2015-11-25 08:10:03,007 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;146;147;148;149;147;148;147;147;147 08:10:03 INFO - 2015-11-25 08:10:03,007 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;96;96;96;97;96;97;96;96 08:10:03 INFO - 2015-11-25 08:10:03,008 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;68;66;62;64;62;65;59;62 08:10:03 INFO - 2015-11-25 08:10:03,008 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;71;70;70;70;70;70;71;71;71 08:10:03 INFO - 2015-11-25 08:10:03,008 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;86;87;85;85;86;85;88;87 08:10:03 INFO - 2015-11-25 08:10:03,008 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;127;118;118;125;114;134;126;117;126 08:10:03 INFO - 2015-11-25 08:10:03,009 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;150;160;148;147;148;149;148;148;147 08:10:03 INFO - 2015-11-25 08:10:03,009 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;66;68;67;68;66;67;66;67 08:10:03 INFO - 2015-11-25 08:10:03,009 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:10:03 INFO - 2015-11-25 08:10:03,009 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:10:03 INFO - 2015-11-25 08:10:03,010 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,725 08:10:03 INFO - 2015-11-25 08:10:03,010 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:10:03 INFO - 2015-11-25 08:10:03,010 DEBUG : BROWSER_OUTPUT: __startTimestamp1448467803004__endTimestamp 08:10:03 INFO - 2015-11-25 08:10:03,010 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,012 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:10:03 INFO - 2015-11-25 08:10:03,012 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:10:03 INFO - 2015-11-25 08:10:03,012 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,012 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:4.12 (3.7%) stddev-sans-first:4.36 08:10:03 INFO - 2015-11-25 08:10:03,013 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 111.0 113.0 111.0 122.0 111.0 111.0 109.0 110.0 08:10:03 INFO - 2015-11-25 08:10:03,013 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,014 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.30 Median:151.50 stddev:14.45 (9.5%) stddev-sans-first:15.17 08:10:03 INFO - 2015-11-25 08:10:03,015 DEBUG : BROWSER_OUTPUT: Values: 150.0 132.0 150.0 164.0 126.0 153.0 157.0 127.0 156.0 128.0 08:10:03 INFO - 2015-11-25 08:10:03,015 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,015 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:3.53 (2.2%) stddev-sans-first:3.64 08:10:03 INFO - 2015-11-25 08:10:03,016 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 162.0 161.0 163.0 161.0 163.0 163.0 173.0 164.0 08:10:03 INFO - 2015-11-25 08:10:03,016 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,016 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.90 Median:72.00 stddev:20.45 (28.4%) stddev-sans-first:21.49 08:10:03 INFO - 2015-11-25 08:10:03,016 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 75.0 72.0 71.0 73.0 137.0 74.0 72.0 72.0 08:10:03 INFO - 2015-11-25 08:10:03,017 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,017 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.00 stddev:22.87 (24.6%) stddev-sans-first:23.63 08:10:03 INFO - 2015-11-25 08:10:03,017 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 146.0 94.0 93.0 93.0 137.0 94.0 95.0 139.0 08:10:03 INFO - 2015-11-25 08:10:03,017 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,017 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 08:10:03 INFO - 2015-11-25 08:10:03,017 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 08:10:03 INFO - 2015-11-25 08:10:03,018 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,018 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:0.87 08:10:03 INFO - 2015-11-25 08:10:03,018 DEBUG : BROWSER_OUTPUT: Values: 149.0 146.0 147.0 148.0 149.0 147.0 148.0 147.0 147.0 147.0 08:10:03 INFO - 2015-11-25 08:10:03,018 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,018 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:10:03 INFO - 2015-11-25 08:10:03,018 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 08:10:03 INFO - 2015-11-25 08:10:03,018 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,018 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.50 stddev:2.50 (3.9%) stddev-sans-first:2.65 08:10:03 INFO - 2015-11-25 08:10:03,019 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 68.0 66.0 62.0 64.0 62.0 65.0 59.0 62.0 08:10:03 INFO - 2015-11-25 08:10:03,019 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,019 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:71.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 08:10:03 INFO - 2015-11-25 08:10:03,019 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 70.0 70.0 70.0 70.0 71.0 71.0 71.0 08:10:03 INFO - 2015-11-25 08:10:03,019 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,019 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:1.23 (1.4%) stddev-sans-first:1.12 08:10:03 INFO - 2015-11-25 08:10:03,019 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 86.0 87.0 85.0 85.0 86.0 85.0 88.0 87.0 08:10:03 INFO - 2015-11-25 08:10:03,019 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,020 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:126.00 stddev:6.16 (4.9%) stddev-sans-first:6.38 08:10:03 INFO - 2015-11-25 08:10:03,020 DEBUG : BROWSER_OUTPUT: Values: 127.0 127.0 118.0 118.0 125.0 114.0 134.0 126.0 117.0 126.0 08:10:03 INFO - 2015-11-25 08:10:03,020 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,020 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:148.00 stddev:4.34 (2.9%) stddev-sans-first:4.07 08:10:03 INFO - 2015-11-25 08:10:03,020 DEBUG : BROWSER_OUTPUT: Values: 143.0 150.0 160.0 148.0 147.0 148.0 149.0 148.0 148.0 147.0 08:10:03 INFO - 2015-11-25 08:10:03,020 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,021 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 08:10:03 INFO - 2015-11-25 08:10:03,021 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 66.0 68.0 67.0 68.0 66.0 67.0 66.0 67.0 08:10:03 INFO - 2015-11-25 08:10:03,022 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:10:03 INFO - 2015-11-25 08:10:03,022 DEBUG : BROWSER_OUTPUT: 08:10:03 INFO - 2015-11-25 08:10:03,877 INFO : Browser exited with error code: 0 08:10:03 INFO - 2015-11-25 08:10:03,933 INFO : Completed test kraken (00:00:59) 08:10:03 INFO - 2015-11-25 08:10:03,933 INFO : Starting test v8_7 08:10:03 INFO - 2015-11-25 08:10:03,933 DEBUG : operating with platform_type : linux_ 08:10:03 INFO - 2015-11-25 08:10:03,933 INFO : Initialising browser for v8_7 test... 08:10:03 INFO - 2015-11-25 08:10:03,939 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgKDMC3/profile http://localhost:41386/getInfo.html 08:10:08 INFO - 2015-11-25 08:10:08,135 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:10:08 INFO - 2015-11-25 08:10:08,135 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:10:08 INFO - 2015-11-25 08:10:08,135 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:10:08 INFO - 2015-11-25 08:10:08,135 DEBUG : BROWSER_OUTPUT: __metrics 08:10:09 INFO - 2015-11-25 08:10:09,117 INFO : Browser initialized. 08:10:09 INFO - 2015-11-25 08:10:09,118 INFO : Running cycle 1/1 for v8_7 test... 08:10:09 INFO - 2015-11-25 08:10:09,118 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgKDMC3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:10:20 INFO - 2015-11-25 08:10:20,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 139010048 08:10:20 INFO - 2015-11-25 08:10:20,823 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41386/tests/v8_7/run.html (next: http://localhost:41386/tests/v8_7/run.html) 08:10:42 INFO - 2015-11-25 08:10:42,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 137875456 08:10:42 INFO - 2015-11-25 08:10:42,475 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,475 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:10:42 INFO - 2015-11-25 08:10:42,475 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:10:42 INFO - 2015-11-25 08:10:42,476 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:10:42 INFO - 2015-11-25 08:10:42,476 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:10:42 INFO - 2015-11-25 08:10:42,476 DEBUG : BROWSER_OUTPUT: |0;Richards;166.16816218012627 08:10:42 INFO - 2015-11-25 08:10:42,476 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.1850679575498 08:10:42 INFO - 2015-11-25 08:10:42,477 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 08:10:42 INFO - 2015-11-25 08:10:42,477 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 08:10:42 INFO - 2015-11-25 08:10:42,477 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1040.5827263267429 08:10:42 INFO - 2015-11-25 08:10:42,477 DEBUG : BROWSER_OUTPUT: |5;Earley;705.7163020465773 08:10:42 INFO - 2015-11-25 08:10:42,477 DEBUG : BROWSER_OUTPUT: |6;Boyer;12023.809523809523 08:10:42 INFO - 2015-11-25 08:10:42,477 DEBUG : BROWSER_OUTPUT: |7;RegExp;24878.048780487807 08:10:42 INFO - 2015-11-25 08:10:42,478 DEBUG : BROWSER_OUTPUT: |8;Splay;621.6053108026554 08:10:42 INFO - 2015-11-25 08:10:42,478 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 08:10:42 INFO - 2015-11-25 08:10:42,478 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:10:42 INFO - 2015-11-25 08:10:42,478 DEBUG : BROWSER_OUTPUT: __startTimestamp1448467842475__endTimestamp 08:10:42 INFO - 2015-11-25 08:10:42,478 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,478 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:10:42 INFO - 2015-11-25 08:10:42,478 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:10:42 INFO - 2015-11-25 08:10:42,478 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,479 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 08:10:42 INFO - 2015-11-25 08:10:42,479 DEBUG : BROWSER_OUTPUT: Values: 166.2 08:10:42 INFO - 2015-11-25 08:10:42,479 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,479 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.19 Median:186.19 stddev:0.00 (0.0%) 08:10:42 INFO - 2015-11-25 08:10:42,479 DEBUG : BROWSER_OUTPUT: Values: 186.2 08:10:42 INFO - 2015-11-25 08:10:42,479 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,479 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 08:10:42 INFO - 2015-11-25 08:10:42,480 DEBUG : BROWSER_OUTPUT: Values: 278.8 08:10:42 INFO - 2015-11-25 08:10:42,480 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,480 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 08:10:42 INFO - 2015-11-25 08:10:42,480 DEBUG : BROWSER_OUTPUT: Values: 5186.5 08:10:42 INFO - 2015-11-25 08:10:42,480 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,480 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1040.58 Median:1040.58 stddev:0.00 (0.0%) 08:10:42 INFO - 2015-11-25 08:10:42,480 DEBUG : BROWSER_OUTPUT: Values: 1040.6 08:10:42 INFO - 2015-11-25 08:10:42,481 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,481 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:705.72 Median:705.72 stddev:0.00 (0.0%) 08:10:42 INFO - 2015-11-25 08:10:42,481 DEBUG : BROWSER_OUTPUT: Values: 705.7 08:10:42 INFO - 2015-11-25 08:10:42,481 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,481 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12023.81 Median:12023.81 stddev:0.00 (0.0%) 08:10:42 INFO - 2015-11-25 08:10:42,481 DEBUG : BROWSER_OUTPUT: Values: 12023.8 08:10:42 INFO - 2015-11-25 08:10:42,481 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,482 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24878.05 Median:24878.05 stddev:0.00 (0.0%) 08:10:42 INFO - 2015-11-25 08:10:42,482 DEBUG : BROWSER_OUTPUT: Values: 24878.0 08:10:42 INFO - 2015-11-25 08:10:42,482 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,482 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:621.61 Median:621.61 stddev:0.00 (0.0%) 08:10:42 INFO - 2015-11-25 08:10:42,482 DEBUG : BROWSER_OUTPUT: Values: 621.6 08:10:42 INFO - 2015-11-25 08:10:42,482 DEBUG : BROWSER_OUTPUT: 08:10:42 INFO - 2015-11-25 08:10:42,482 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 08:10:42 INFO - 2015-11-25 08:10:42,483 DEBUG : BROWSER_OUTPUT: Values: 4835.7 08:10:42 INFO - 2015-11-25 08:10:42,483 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:10:42 INFO - 2015-11-25 08:10:42,483 DEBUG : BROWSER_OUTPUT: 08:10:43 INFO - 2015-11-25 08:10:43,317 INFO : Browser exited with error code: 0 08:10:43 INFO - 2015-11-25 08:10:43,337 INFO : Completed test v8_7 (00:00:39) 08:10:43 INFO - 2015-11-25 08:10:43,477 INFO : Completed test suite (00:20:09) 08:10:43 INFO - 2015-11-25 08:10:43,478 DEBUG : Working with test: dromaeo_css 08:10:43 INFO - 2015-11-25 08:10:43,478 DEBUG : Generating results file: dromaeo_css 08:10:43 INFO - 2015-11-25 08:10:43,479 DEBUG : Working with test: kraken 08:10:43 INFO - 2015-11-25 08:10:43,480 DEBUG : Generating results file: kraken 08:10:43 INFO - 2015-11-25 08:10:43,480 INFO : javascript benchmark 08:10:43 INFO - 2015-11-25 08:10:43,480 DEBUG : Working with test: v8_7 08:10:43 INFO - 2015-11-25 08:10:43,480 DEBUG : Generating results file: v8_7 08:10:43 INFO - 2015-11-25 08:10:43,481 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:10:43 INFO - 2015-11-25 08:10:43,542 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 08:10:43 INFO - 2015-11-25 08:10:43,542 DEBUG : process_Request line: dromaeo_css 6971.71 graph.html#tests=[[72,64,43]] 08:10:43 INFO - 2015-11-25 08:10:43,542 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:10:43 INFO - 2015-11-25 08:10:43,692 DEBUG : process_Request line: kraken 1518.10 graph.html#tests=[[232,64,43]] 08:10:43 INFO - 2015-11-25 08:10:43,692 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:10:43 INFO - 2015-11-25 08:10:43,818 DEBUG : process_Request line: v8_7 21498.67 graph.html#tests=[[230,64,43]] 08:10:43 INFO - 2015-11-25 08:10:43,819 INFO : javascript benchmark 08:10:43 INFO - 2015-11-25 08:10:43,823 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3166.1134882232977, 3250.3661785951736, 3269.591301087364, 3288.177955511123, 3299.4720844664844, 5255.842324730254, 5424.755885985131, 5436.18457231415, 5455.318085239345, 5458.153986132151, 5291.629585928987, 5358.383785864627, 5360.088784906566, 5414.702191379472, 5431.511163995239, 4671.299305104228, 4931.334269873575, 5124.333836601237, 5130.256112863633, 5149.974250128744, 4783.210770222909, 5035.446100928895, 5051.0403023425615, 5102.821401250957, 5130.358705161855, 4902.975485122587, 4914.213725803872, 4952.900941981176, 4987.501249875019, 5027.547520723116, 4964.60283177345, 4982.87542811429, 4983.90032199354, 5019.67372120811, 5019.723915184663, 4806.567408933178, 4917.50824917509, 4945.455999840015, 4971.900561988776, 5051.494850514956, 5150.175971844525, 5167.302414174076, 5196.61025423091, 5237.554807841338, 5271.314729085195, 5880.911786323166, 5938.851528711773, 5941.881162376728, 5945.8810823783715, 5957.493613042897, 5699.145128230757, 5846.473817356458, 5847.2983242010805, 5941.257342832146, 5965.910511342333, 5467.097928841776, 5551.139573366135, 5551.694656793875, 5562.666240025612, 5585.301837270341, 5992.131140984533, 6008.399160084044, 6012.248468941382, 6019.909701354483, 6054.031354983182, 5599.552035837123, 5707.514861236758, 5727.5990680652785, 5793.652380857077, 5852.268466441695, 5819.767209311664, 5824.330202026821, 5834.824955251349, 5841.795537156264, 5882.3529411764675, 5719.170720245541, 5725.0, 5761.711914404263, 5787.363390027093, 5829.125631155361, 5673.290838645169, 5785.537157027427, 5800.767969281266, 5886.676232807236, 5950.315713692894, 4510.481294651157, 4523.140603285366, 4528.773561321921, 4542.454905411372, 4553.5218802025975, 3945.6054394560315, 4035.1122752994293, 4045.8786236412957, 4063.0, 4092.2633925893624, 5477.3427188737605, 5537.335519737577, 5581.720913954286, 5607.0, 5642.463965923231, 5888.735006924699, 5928.851778705481, 5935.228420305332, 5936.614120082181, 5960.6721630309885, 5512.0905050667, 5618.606697531215, 5660.971695141498, 5665.0, 5672.461116193955, 5071.847844564669, 5073.720945348041, 5134.255532947702, 5142.485751424828, 5175.663581867167, 6060.575759696867, 6071.696415179224, 6097.664628445478, 6102.938970610326, 6109.908351374733, 5692.7722891083895, 5806.390329015561, 5813.273340832396, 5854.531637469077, 5880.588358814842, 6135.693215339126, 6136.243373036893, 6152.0, 6157.507399408126, 6161.969190154021, 5828.650280982985, 5829.94170058294, 5872.882542349214, 5901.0, 5924.348321684525, 5769.0, 5839.620424672383, 5916.763329466773, 5918.112283157561, 5970.5223582114195, 5741.167530708108, 5753.712314384347, 5767.134929760569, 5826.096954971986, 5866.120081987736, 5740.253767010262, 5752.194692743103, 5757.222774925499, 5759.65442073477, 5763.366029736641, 5451.073317536107, 5563.554915606823, 5610.186522954067, 5644.379118297066, 5652.886942261214, 5676.347220069745, 5756.539476841759, 5771.422857714195, 5780.739866705924, 5808.970955145197, 5536.280283563111, 5566.860828479321, 5634.4365563443325, 5636.689982050862, 5643.7742490299925], "unit": "ms", "name": "dojo.html", "value": 5407.506919669931}, {"lowerIsBetter": false, "replicates": [574.6982834012146, 584.9064149736043, 588.6438704583726, 591.964482131072, 594.0880748051742, 30897.22756931075, 40142.0, 40517.594824051754, 40650.39024414636, 40650.59349406505, 43550.56449435505, 44009.0, 44202.778986105026, 44296.11407771843, 44382.55617443832, 8696.260817830493, 8830.955845220766, 8933.330000249975, 8943.95528022359, 8946.686865959693, 8651.264642505395, 8754.6935857245, 8774.956125219396, 8779.34154938379, 8783.077776833436, 8765.211130998208, 8777.253933415668, 8856.690015849446, 8861.0, 8896.243819275369, 8713.041565427799, 8786.956065219632, 8787.824243515093, 8803.163699448542, 8805.515696636683, 8577.442466239674, 8698.782530436727, 8707.912920870773, 8725.476471411735, 8742.0, 39717.20565588701, 40271.0, 40593.0, 40602.187956241, 40626.593734062575, 3219.3722224166295, 3336.7163791077787, 3351.1287065362935, 3353.396388650042, 3565.625609311037, 29979.850100749576, 30371.848140759375, 30603.69396306031, 30908.227294317596, 31110.377792444026, 3099.4266060778605, 3146.685331466835, 3191.12244132863, 3257.8859739909226, 3321.4021476134285, 275310.0, 276162.0, 276568.0, 277197.0, 278189.0, 52374.47625523772, 53088.73455632697, 60530.0, 61007.6949615258, 67593.66203168953, 64258.0, 64433.0, 64449.0, 64591.0, 64617.353826461134, 15121.395144194328, 15179.241037948059, 15253.237338133049, 15302.464413745689, 15317.004394714531, 11702.76594468106, 11719.179657423898, 11754.588589399502, 11763.0, 11801.822972655416, 20715.171393144406, 21177.89411052935, 21203.575928481343, 21224.575508489743, 21275.574488510145, 7664.271894170045, 7869.095054068741, 7873.5275883447175, 7946.721864734706, 7957.442978991415, 943.7310366545502, 970.1801977329145, 975.6048800235916, 979.7256768104942, 1049.4752623688155, 29283.560746588817, 29430.411391772046, 29756.2560935974, 31866.362672746414, 32430.513542296885, 1024.6925922223304, 1067.0983019348637, 1099.5766629847567, 1102.8897110288906, 1125.4991528769783, 14711.705765884837, 14875.70248595022, 14918.0, 15039.323230454656, 15075.170865602497, 328772.0, 333984.0, 334343.0, 335175.0, 335778.0, 52860.0, 52898.206526902126, 53102.468975309755, 53107.73446132745, 53225.46774532205, 1340.8390993080893, 1342.3154191362476, 1344.5159742492694, 1345.0719003887286, 1350.7303135053214, 27716.168514944584, 28947.56578651364, 28969.7103028967, 29102.70897291, 29105.417891641624, 49744.75127624339, 50453.0, 50700.23949640832, 50728.746356267984, 50826.0, 230105.0, 230992.0, 231033.0, 231496.0, 231652.0, 30088.54867177038, 32388.0, 32434.513482298258, 32702.0, 32918.177045574055, 39749.40375894306, 39864.800675996434, 39892.60107399005, 40510.0, 40710.1857962845, 34021.65978340185, 34291.14272143116, 34655.82672086624, 34763.65236347604, 37131.07172320713, 35624.64375356317, 36381.27237455183, 36611.0, 36821.63178368182, 37643.81178094092, 35878.28243435169, 35970.0, 36838.8158059208, 36883.44674829826, 36963.63036369602, 32490.0, 32707.182320442178, 33667.0, 33744.662553375136, 34281.314373712885, 24604.876975615007, 24628.50742985166, 26088.478230434906, 26279.868600656875, 26583.7341626589], "unit": "ms", "name": "ext.html", "value": 18525.593643130032}, {"lowerIsBetter": false, "replicates": [351.0591614473212, 352.3165059784019, 353.4203905594824, 354.84032185516526, 355.0449291406117, 16225.350985960562, 16623.335066597338, 17328.65342693147, 17666.911665441654, 18337.633247335045, 10931.945340273307, 10985.066269367093, 11119.777604447907, 11135.665930022093, 11246.606368777095, 4942.18453955097, 5096.898062038757, 5101.336826212587, 5140.948590514085, 5502.9174562381395, 5397.001554712391, 5474.808381706641, 5477.397486276506, 5484.2596249506405, 5485.945140548583, 5168.22476628505, 5328.5470734987575, 5338.412774594811, 5511.448855114477, 5561.249231353756, 5345.518903298703, 5359.356877174744, 5362.008028514737, 5369.731513424333, 5646.6894320812335, 5307.601929855237, 5310.44240354761, 5337.733113344356, 5352.437994010612, 5356.892862142735, 12463.626091217187, 12601.74796504074, 18793.342233021915, 19474.707879381822, 19544.80455195444, 2030.1879248300797, 2204.75747667758, 2263.6717675936898, 2267.3878052925784, 2290.209877592228, 9721.270904682106, 9898.713167288279, 10039.498025098788, 11018.559257629686, 13051.151675141085, 1802.8647851411197, 1842.6959551673958, 1845.0, 1883.2467013194694, 1924.0956750327323, 64247.0, 65393.019104713465, 66966.66516667386, 67419.66290168518, 67705.66147169232, 9817.263705222136, 10205.948970255102, 10294.794104117876, 10318.122959548373, 10342.534585943651, 13260.403281852146, 13284.867151328557, 13302.534411295559, 13304.268265245311, 13330.133541319978, 7506.474546781782, 7672.079350477979, 7681.807954801175, 7719.807004824925, 7763.72826951054, 7098.893516597152, 7388.408927285805, 7450.888236676454, 7498.700051997968, 7513.2111128331835, 4258.510271318838, 4323.156984388077, 4480.39514665516, 4487.820487180542, 4490.0, 1777.413453560322, 1843.3640394064028, 1860.8232217939274, 1870.747449094382, 1873.7657792775904, 948.5731420860641, 957.5834511987308, 1000.5347513406156, 1013.2248829645328, 1029.840374741916, 13947.86052139486, 16248.431304904272, 17061.658766824596, 17264.654706905792, 17583.912080439517, 961.4087336288133, 967.5936106835146, 1000.6797824696027, 1006.0744115413837, 1063.7234319077095, 9614.0, 10158.695239142837, 10178.592856285666, 10180.185585153318, 10229.43738094412, 501421.0, 516090.0, 526248.0, 529878.0, 547964.0, 80380.0, 82635.99999999879, 83553.16446835455, 83747.0, 83759.0, 1188.7503624238834, 1190.4464424042687, 1238.6779437346354, 1239.070696977267, 1256.7298030923396, 15438.5368438947, 15631.84368156304, 15643.608909777347, 15662.765058523903, 15685.398390451626, 34729.65270347264, 35115.586725010144, 35165.64834351726, 35524.46713299251, 36248.637513624526, 47559.76220118877, 49086.75456622837, 49109.754451228946, 49608.75195623999, 49709.50290497049, 9354.906450935403, 9765.804683906425, 9855.901440985785, 9915.801683966425, 10060.49697515136, 11376.715582110182, 11468.31190128595, 11531.711707207387, 11540.480678369662, 13411.664708382368, 13615.25116118623, 13772.862271377558, 14394.568162955127, 14555.12669239849, 14698.55904322872, 14723.92638036803, 14906.403743850124, 14919.701605967603, 14959.626009349853, 15020.0, 14800.0, 14820.629484262548, 15212.771808423104, 15306.923465382602, 15404.691906162037, 9726.70819875405, 9858.704238872846, 9984.900150998397, 10015.449150296512, 10019.897811240611, 13426.0, 14147.0, 14920.104793712411, 14986.100833949999, 15402.46091386796], "unit": "ms", "name": "jquery.html", "value": 8831.701363077873}, {"lowerIsBetter": false, "replicates": [1505.0743792567573, 1672.2725614357753, 1726.9034163306296, 1735.9045252511114, 1739.8260173982599, 6557.409833115019, 6700.664966751655, 6910.447164226863, 7234.674439650215, 7243.8913416298665, 6938.583684978905, 7118.074650295467, 7133.429325653949, 7137.60743159126, 7139.785806425815, 2188.8248940084754, 2207.4702071502884, 2220.1563405905813, 2224.5662095891307, 2229.063793206857, 2215.1360969222014, 2221.1448592292004, 2295.449092217864, 2298.0348253733387, 2298.367948814081, 2202.8458007939453, 2217.6008318502663, 2242.5402792427512, 2252.76098146019, 2253.267688001398, 2213.7786221377733, 2233.084435381494, 2259.2318611672026, 2261.7172853393326, 2271.068861766668, 2247.359502541784, 2264.8188144948363, 2272.1933713531625, 2274.9545009099725, 2276.2488378834946, 7228.168760592546, 7277.854442911165, 7296.343329100407, 7299.708011679527, 7327.0, 4480.126375356806, 4513.842015529473, 4536.3422303765765, 4558.635309175291, 4560.019595786922, 2920.32832448538, 3065.4482193205213, 3074.2468095316567, 3092.8298943558098, 3098.7675924305768, 967.7870868408938, 976.4580657735025, 982.4350998176077, 1010.0909181736423, 1019.5819713917332, 9615.807683846284, 9616.423014619075, 9623.518824058769, 9690.32167748258, 9707.757306067404, 4131.338985762263, 4141.254574176617, 4153.480814898137, 4178.373244013423, 4216.2832318505925, 8214.424990250745, 8267.62795674196, 8279.213474719892, 8297.170282971776, 8308.086110527836, 4559.088182363541, 4559.247724125482, 4568.497465278817, 4580.885477863014, 4589.0821835633005, 4105.261053010427, 4170.854020109282, 4192.685548583869, 4199.895002624959, 4201.054762678373, 3475.8609655614, 3503.089196808848, 3508.193115583379, 3532.7527073104634, 3533.982330088333, 1092.0390056750168, 1092.9945350273197, 1094.874089479704, 1098.0940723902813, 1103.0568863621647, 1282.3844554613838, 1289.2715615677112, 1305.1320871620267, 1332.920024798496, 1340.7921772125337, 6609.405153536109, 6771.085903402977, 6796.150481189851, 6803.285655006153, 6817.659117044128, 486.4260172995899, 501.19307914258013, 505.0656285871109, 505.23709199109607, 506.86821426429395, 5512.145617429305, 5527.806526771544, 5540.168974653753, 5544.667319960815, 5552.500274975271, 8439.451435656663, 8545.743627691056, 8551.401401901932, 8561.743147705454, 8637.568121593895, 8518.105598912025, 8521.0, 8544.61549230286, 8544.871826922601, 8570.100139485388, 6381.361863813581, 6474.741010359533, 6528.412442880163, 6942.895856562156, 7038.824029399306, 6970.337817907291, 6996.160460744743, 7036.401905838061, 7038.577685338896, 7039.964800175966, 7666.38668906475, 7885.842283154419, 7936.365090792839, 8032.879506807286, 8071.959640201761, 7976.441649084509, 8022.478538894953, 8081.83836323282, 8094.595270236347, 8136.471129376809, 6095.2685677718955, 6594.175728033996, 6608.273089960005, 6619.834504137242, 6667.766628168185, 7011.754588589375, 7045.26024767392, 7047.224805271519, 7056.188538318159, 7059.047028651272, 6534.497065674826, 6594.4724422045165, 6679.0, 6703.061571380108, 6781.321867813376, 6514.706838192387, 6589.637569933508, 6595.373439523238, 6671.66641667905, 6681.365270299314, 6555.573887697285, 6569.967150164219, 6573.474122070318, 6589.571677840925, 6606.10817539626, 5869.7945571904775, 5892.499137573354, 5909.409059094056, 5930.495907847881, 5933.792317268875, 5947.613405128653, 5963.493103086286, 5990.311114221746, 6005.159277701038, 6015.12780646795], "unit": "ms", "name": "mootools.html", "value": 4206.645886725925}, {"lowerIsBetter": false, "replicates": [331.6617050608379, 332.55437713463954, 332.80530889429684, 340.3601229688186, 342.8662821499615, 6259.968700156499, 6264.5928014679075, 6276.780312689057, 6335.524835637329, 6420.7752728654505, 6229.626222426647, 6233.376662333764, 6275.874482510347, 6285.811425657226, 6287.30839607644, 4744.217204161309, 4760.952390476103, 4761.952380476186, 4764.880877978044, 4767.499412561683, 4762.785674644632, 4766.094442055998, 4776.80892764289, 4777.426708794932, 4789.473157952622, 4626.583607475327, 4703.15343238217, 4720.1739695553315, 4728.881777955544, 4742.715437073786, 4709.364235828154, 4713.670043096968, 4721.787519561628, 4727.196376615983, 4735.360726301974, 4077.7757223352705, 4084.36692312692, 4092.283850326181, 4098.077932465201, 4108.465899433085, 5853.970730146322, 5944.405559444064, 5985.431384018555, 6002.699865006733, 6014.428629280212, 5386.515213630752, 5473.589480788957, 5507.118860982224, 5511.696856672881, 5522.199281104257, 6657.800265992028, 6666.333366663295, 6673.165854268216, 6677.565958212701, 6688.83277918051, 4539.909201815978, 4541.795619197144, 4543.341215523764, 4548.499665036877, 4550.0, 6822.863542729167, 6903.378695917341, 6930.61881596512, 6954.235034146291, 6985.336393042653, 4629.3518907353, 4629.745364004944, 4633.258678611473, 4638.1187574360765, 4641.2109941310055, 4684.0, 4691.108689349013, 4700.224462963641, 4702.95297047032, 4720.0, 5481.0, 5483.588730845203, 5487.478689524489, 5490.039243132436, 5496.945030549723, 6522.412982831473, 6673.499487538357, 6744.898826517606, 6745.156855393076, 6750.561213521106, 1632.306269835339, 1654.2555849867608, 1670.607407259293, 1675.1875340459867, 1675.354988329502, 1100.9614663486739, 1101.7465982823996, 1112.1214240749878, 1118.1893127482672, 1125.1111621818836, 6342.809715708536, 6421.8073457796345, 6429.324920883333, 6473.449756770728, 6490.318516555788, 6752.662366881636, 6786.626735529593, 6814.386705196556, 6834.555753876081, 6835.282295359015, 6444.420002199825, 6454.2577603575255, 6462.838429039311, 6472.0, 6475.190601174853, 3788.6211378862445, 3796.2976849282973, 3817.6373244541724, 3819.388897776342, 3829.5978922213326, 7325.377342925911, 7325.523840950428, 7333.413326933833, 7338.302861228175, 7346.63266836656, 7049.89425158623, 7211.314925082109, 7225.205227424979, 7225.494215404871, 7235.963820180866, 7233.1681856587165, 7294.3799777018485, 7299.489035767445, 7307.7807665770115, 7314.634268286564, 6949.68726407323, 6968.581885086911, 6971.3028697129885, 6975.267596902252, 6997.650117494003, 6696.7656132035145, 6812.182538095461, 6831.316868313129, 6913.101296831581, 6914.757983470555, 7252.528585641917, 7255.673494692857, 7266.89099663516, 7271.490995630255, 7323.816904577428, 4611.538846115362, 4617.0996655651825, 4627.629789616755, 4637.39713837199, 4639.188142075056, 6734.764283250062, 6788.083608712761, 6910.343517365842, 6965.024896514391, 6968.059311992816, 6675.766348177791, 6696.5647232929705, 6704.497162712913, 6744.0, 6793.116894803644, 6763.222229443677, 6765.898511522233, 6774.796756097325, 6774.898376524455, 6803.557768745016, 6466.741330346734, 6598.571092878948, 6628.5691430056895, 6647.567908085959, 6654.068430419842, 6757.189137303555, 6767.93232067673, 6768.9661551691925, 6775.762848300285, 6805.877030289947, 6603.669816509251, 6623.867522649423, 6624.436922861611, 6638.236602790547, 6659.633720145439], "unit": "ms", "name": "prototype.html", "value": 5022.9894910440435}, {"lowerIsBetter": false, "replicates": [628.600838467573, 673.7170388436856, 677.1806114601333, 705.9939586089822, 732.882738761798, 13238.801417978739, 13764.174149551009, 13814.861851381484, 13954.0, 13966.511172108965, 13092.934535327335, 13287.468501259938, 13346.599602011931, 13394.59816205513, 13398.464061437555, 795.2643804480861, 808.8422757562278, 826.2687521543447, 832.4464231286188, 846.2552953400999, 842.7893026743315, 844.5312851367488, 846.6401779243828, 847.8261956298975, 847.8473874702551, 882.4484697064335, 884.6903583745702, 887.6893087419417, 891.7413949954538, 892.0410558649445, 868.288003836854, 868.8045189832237, 872.646578135856, 876.5091548732698, 877.4472082587961, 634.5082561015204, 642.6401215319436, 644.7614382678439, 648.3548868875451, 652.6834485274638, 12755.872441275562, 12841.036922230776, 12845.165064270886, 12880.549180778722, 12882.0, 11550.884491155064, 11555.133364997659, 11766.176367654267, 11857.347845868473, 12049.57826476078, 9487.241020718326, 9589.18491928187, 9816.361936474177, 9989.950050249703, 10055.245856560714, 3547.8758243461357, 3573.3210689969083, 3609.6029436761937, 3654.634536546324, 3663.87176448823, 48797.26804097941, 49728.0, 49861.252081218445, 49913.50086499125, 49927.75036124796, 9004.0, 9114.0, 9191.724248272563, 9292.767680808034, 9357.39176953496, 17478.825211747975, 17563.64872702539, 17570.209340579706, 17573.297068117132, 17733.37933172333, 7306.2693730626515, 7425.591592462359, 7449.813754656177, 7537.133229678548, 7628.923710762932, 4215.936760948588, 4423.093265880487, 4436.6228870546365, 4441.711288766284, 4454.37638730578, 2868.6127372804403, 2882.884684612592, 2897.6233089698203, 2900.419916016805, 2904.997775767357, 527.1276038156857, 533.9279197308391, 534.5723421263052, 535.1865164949334, 539.9460053994648, 477.29360546391536, 546.4016901492859, 568.4372471253429, 575.9078547432391, 583.9941600584025, 7706.229377062249, 7944.721934732373, 8035.397345199133, 8038.477498962548, 8183.181681831769, 501.25563538145826, 512.6872607709295, 526.6550409481796, 543.2774410034723, 633.1104797759064, 3791.6018818024263, 3815.275097731422, 3863.1114843586133, 3968.8412463501713, 3970.2258059678084, 56879.0, 57918.0, 57936.710316448145, 58034.0, 61758.69120654368, 54484.182737258976, 54571.81712731446, 54689.726551367785, 55225.0, 55379.0, 49127.26309105366, 49281.75359123181, 49952.500474994784, 50108.74945625249, 50275.497245027815, 8356.0, 8483.74548763538, 8523.531205783742, 8542.615582298935, 8544.700935467228, 36376.27247455089, 36436.81781591075, 37240.0, 37774.24451511009, 37867.0, 44932.77533612311, 46218.30672539847, 46306.76846615745, 46378.07243855036, 46734.0, 10384.221183411426, 10554.683359499228, 10690.89309106899, 10789.56841726322, 10837.837432438362, 10413.219008574539, 10473.685789426025, 10665.680029599125, 11617.186796924134, 11999.460024299102, 10241.180705543688, 10546.367217966947, 10691.679249622524, 10699.732506687395, 10739.14086873064, 10065.748356291151, 10132.544035518567, 10505.68482945513, 10805.45972701346, 10828.24202305831, 10147.949260253652, 10202.897971020491, 10220.591176352862, 10332.638357657446, 10412.32319899204, 9261.490618016074, 9643.614255429984, 9679.66121185755, 9832.410055396698, 9841.557129929028, 8642.913570864212, 8748.518831464331, 9253.67612133599, 9291.581878815334, 9296.163345298955], "unit": "ms", "name": "yui.html", "value": 6141.611491015374}], "name": "dromaeo_css", "value": 6971.704240715228}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 111.0, 113.0, 111.0, 122.0, 111.0, 111.0, 109.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [150.0, 132.0, 150.0, 164.0, 126.0, 153.0, 157.0, 127.0, 156.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 161.0, 163.0, 161.0, 163.0, 163.0, 173.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 75.0, 72.0, 71.0, 73.0, 137.0, 74.0, 72.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 146.0, 94.0, 93.0, 93.0, 137.0, 94.0, 95.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 147.0, 148.0, 149.0, 147.0, 148.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 68.0, 66.0, 62.0, 64.0, 62.0, 65.0, 59.0, 62.0], "unit": "ms", "name": "json-parse-financial", "value": 63.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 70.0, 70.0, 70.0, 70.0, 71.0, 71.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.5}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 87.0, 85.0, 85.0, 86.0, 85.0, 88.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [127.0, 127.0, 118.0, 118.0, 125.0, 114.0, 134.0, 126.0, 117.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [143.0, 150.0, 160.0, 148.0, 147.0, 148.0, 149.0, 148.0, 148.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 68.0, 67.0, 68.0, 66.0, 67.0, 66.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1518.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.16816218012627], "unit": "score", "name": "Richards", "value": 212.4474360000001}, {"lowerIsBetter": false, "replicates": [186.1850679575498], "unit": "score", "name": "DeltaBlue", "value": 355.1197780000001}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1040.5827263267429], "unit": "score", "name": "RayTrace", "value": 711.1294289999997}, {"lowerIsBetter": false, "replicates": [705.7163020465773], "unit": "score", "name": "Earley", "value": 944.3780709999997}, {"lowerIsBetter": false, "replicates": [12023.809523809523], "unit": "score", "name": "Boyer", "value": 55.42860594059401}, {"lowerIsBetter": false, "replicates": [24878.048780487807], "unit": "score", "name": "RegExp", "value": 36.618024509803895}, {"lowerIsBetter": false, "replicates": [621.6053108026554], "unit": "score", "name": "Splay", "value": 131.09765728155338}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21498.66523240643}]} 08:10:43 INFO - RETURN: dromaeo_css: 6971.71 08:10:43 INFO - RETURN: kraken: 1518.10 08:10:43 INFO - RETURN: v8_7: 21498.67 08:10:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21498.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1518.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6971.71"}}} 08:10:43 INFO - Return code: 0 08:10:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:10:43 INFO - # TBPL SUCCESS # 08:10:43 INFO - Running post-action listener: _resource_record_post_action 08:10:43 INFO - Running post-run listener: _resource_record_post_run 08:10:45 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 8192; Write bytes: 523702272; Read time: 80; Write time: 396220 08:10:45 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 247787520; Read time: 0; Write time: 239660 08:10:45 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275894272; Read time: 68; Write time: 156560 08:10:45 INFO - Running post-run listener: _upload_blobber_files 08:10:45 INFO - Blob upload gear active. 08:10:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:10:45 INFO - Copying logs to upload dir... 08:10:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.382785 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-25 08:10:45.071711) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 08:10:45.075386) ========= 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=d6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/kR2TulyMTR6wwxFPVGNwJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009979 build_url: 'https://queue.taskcluster.net/v1/task/kR2TulyMTR6wwxFPVGNwJQ/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-25 08:10:45.125978) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 08:10:45.126314) ========= 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=d6a7e047ef025f707024e163000001c3-1448466139.680546-1048357897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 08:10:45.175844) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 08:10:45.176157) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 08:10:45.176431) ========= ========= Total master_lag: 0.22 =========