builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1448549429.0 results: success (0) buildid: 20151126053024 builduid: e34f1ed3e049451ba65a49ecadbb1f56 revision: 4aad8e3db7e990ccd2dfc6e7840632559272b22b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.002369) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.002803) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.003104) ========= 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=20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005989 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.022632) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.022922) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.032304) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.032595) ========= 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=20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003344 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.082330) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.082597) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.083299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.083583) ========= 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=20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 06:50:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 78.0M=0s 2015-11-26 06:50:29 (78.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142614 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.238536) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.238841) ========= 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=20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020354 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.287635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.287972) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4aad8e3db7e990ccd2dfc6e7840632559272b22b --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 4aad8e3db7e990ccd2dfc6e7840632559272b22b --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=20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 06:50:29,499 truncating revision to first 12 chars 2015-11-26 06:50:29,499 Setting DEBUG logging. 2015-11-26 06:50:29,499 attempt 1/10 2015-11-26 06:50:29,499 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4aad8e3db7e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 06:50:29,753 unpacking tar archive at: fx-team-4aad8e3db7e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535421 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.836676) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.837004) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.846468) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.846727) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 06:50:29.847124) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-26 06:50:29.847421) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:50:30 INFO - MultiFileLogger online at 20151126 06:50:30 in /builds/slave/test-pgo 06:50:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:50:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:50:30 INFO - {'append_to_log': False, 06:50:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:50:30 INFO - 'blob_upload_branch': 'Fx-Team', 06:50:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:50:30 INFO - 'branch': 'Fx-Team', 06:50:30 INFO - 'buildbot_json_path': 'buildprops.json', 06:50:30 INFO - 'config_files': ('talos/linux_config.py',), 06:50:30 INFO - 'default_actions': ('clobber', 06:50:30 INFO - 'read-buildbot-config', 06:50:30 INFO - 'download-and-extract', 06:50:30 INFO - 'populate-webroot', 06:50:30 INFO - 'create-virtualenv', 06:50:30 INFO - 'install', 06:50:30 INFO - 'run-tests'), 06:50:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:50:30 INFO - 'download_minidump_stackwalk': True, 06:50:30 INFO - 'download_symbols': 'ondemand', 06:50:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:50:30 INFO - 'tooltool.py': '/tools/tooltool.py', 06:50:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:50:30 INFO - '/tools/misc-python/virtualenv.py')}, 06:50:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:50:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:50:30 INFO - 'installer_path': 'installer.exe', 06:50:30 INFO - 'log_level': 'info', 06:50:30 INFO - 'log_name': 'talos', 06:50:30 INFO - 'log_to_console': True, 06:50:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:50:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:50:30 INFO - 'opt_config_files': (), 06:50:30 INFO - 'pip_index': False, 06:50:30 INFO - 'sps_profile': False, 06:50:30 INFO - 'sps_profile_interval': 0, 06:50:30 INFO - 'suite': 'dromaeojs', 06:50:30 INFO - 'system_bits': '64', 06:50:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:50:30 INFO - 'title': 'talos-linux64-ix-065', 06:50:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:50:30 INFO - 'use_talos_json': True, 06:50:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:50:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:50:30 INFO - 'work_dir': 'build'} 06:50:30 INFO - ##### 06:50:30 INFO - ##### Running clobber step. 06:50:30 INFO - ##### 06:50:30 INFO - Running pre-action listener: _resource_record_pre_action 06:50:30 INFO - Running main action method: clobber 06:50:30 INFO - rmtree: /builds/slave/test-pgo/build 06:50:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:50:30 INFO - Running post-action listener: _resource_record_post_action 06:50:30 INFO - ##### 06:50:30 INFO - ##### Running read-buildbot-config step. 06:50:30 INFO - ##### 06:50:30 INFO - Running pre-action listener: _resource_record_pre_action 06:50:30 INFO - Running main action method: read_buildbot_config 06:50:30 INFO - Using buildbot properties: 06:50:30 INFO - { 06:50:30 INFO - "properties": { 06:50:30 INFO - "buildnumber": 519, 06:50:30 INFO - "product": "firefox", 06:50:30 INFO - "script_repo_revision": "production", 06:50:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:50:30 INFO - "repository": "", 06:50:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:50:30 INFO - "buildid": "20151126053024", 06:50:30 INFO - "slavename": "talos-linux64-ix-065", 06:50:30 INFO - "pgo_build": "True", 06:50:30 INFO - "basedir": "/builds/slave/test-pgo", 06:50:30 INFO - "project": "", 06:50:30 INFO - "platform": "ubuntu64_hw", 06:50:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:50:30 INFO - "slavebuilddir": "test", 06:50:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:50:30 INFO - "branch": "fx-team", 06:50:30 INFO - "repo_path": "integration/fx-team", 06:50:30 INFO - "stage_platform": "linux64-pgo", 06:50:30 INFO - "builduid": "e34f1ed3e049451ba65a49ecadbb1f56", 06:50:30 INFO - "revision": "4aad8e3db7e990ccd2dfc6e7840632559272b22b" 06:50:30 INFO - }, 06:50:30 INFO - "sourcestamp": { 06:50:30 INFO - "repository": "", 06:50:30 INFO - "hasPatch": false, 06:50:30 INFO - "project": "", 06:50:30 INFO - "branch": "fx-team-linux64-pgo-talos", 06:50:30 INFO - "changes": [ 06:50:30 INFO - { 06:50:30 INFO - "category": null, 06:50:30 INFO - "files": [ 06:50:30 INFO - { 06:50:30 INFO - "url": null, 06:50:30 INFO - "name": "https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:50:30 INFO - } 06:50:30 INFO - ], 06:50:30 INFO - "repository": "", 06:50:30 INFO - "rev": "4aad8e3db7e990ccd2dfc6e7840632559272b22b", 06:50:30 INFO - "who": "sendchange", 06:50:30 INFO - "when": 1448549339, 06:50:30 INFO - "number": 6711025, 06:50:30 INFO - "comments": "", 06:50:30 INFO - "project": "", 06:50:30 INFO - "at": "Thu 26 Nov 2015 06:48:59", 06:50:30 INFO - "branch": "fx-team-linux64-pgo-talos", 06:50:30 INFO - "revlink": "", 06:50:30 INFO - "properties": [ 06:50:30 INFO - [ 06:50:30 INFO - "buildid", 06:50:30 INFO - "20151126053024", 06:50:30 INFO - "Change" 06:50:30 INFO - ], 06:50:30 INFO - [ 06:50:30 INFO - "builduid", 06:50:30 INFO - "e34f1ed3e049451ba65a49ecadbb1f56", 06:50:30 INFO - "Change" 06:50:30 INFO - ], 06:50:30 INFO - [ 06:50:30 INFO - "pgo_build", 06:50:30 INFO - "True", 06:50:30 INFO - "Change" 06:50:30 INFO - ] 06:50:30 INFO - ], 06:50:30 INFO - "revision": "4aad8e3db7e990ccd2dfc6e7840632559272b22b" 06:50:30 INFO - } 06:50:30 INFO - ], 06:50:30 INFO - "revision": "4aad8e3db7e990ccd2dfc6e7840632559272b22b" 06:50:30 INFO - } 06:50:30 INFO - } 06:50:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:50:30 INFO - Running post-action listener: _resource_record_post_action 06:50:30 INFO - ##### 06:50:30 INFO - ##### Running download-and-extract step. 06:50:30 INFO - ##### 06:50:30 INFO - Running pre-action listener: _resource_record_pre_action 06:50:30 INFO - Running main action method: download_and_extract 06:50:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:30 INFO - https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:50:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/test_packages.json 06:50:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/test_packages.json 06:50:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:50:34 INFO - Downloaded 1302 bytes. 06:50:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:50:34 INFO - Using the following test package requirements: 06:50:34 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:34 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:50:34 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:34 INFO - u'jsshell-linux-x86_64.zip'], 06:50:34 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:50:34 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:34 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:50:34 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:50:34 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:50:34 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:34 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:50:34 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:34 INFO - https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:50:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:50:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:50:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:50:38 INFO - Downloaded 22755976 bytes. 06:50:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:50:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:50:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:50:40 INFO - Return code: 0 06:50:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:40 INFO - https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:50:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:50:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:50:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:50:42 INFO - Downloaded 22755976 bytes. 06:50:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:50:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:50:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:50:43 INFO - Return code: 0 06:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:43 INFO - https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:50:44 INFO - Downloaded 11131717 bytes. 06:50:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 06:50:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:50:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:50:44 INFO - Return code: 0 06:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:44 INFO - https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:50:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:50:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:50:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:50:46 INFO - Downloaded 58387353 bytes. 06:50:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:50:46 INFO - mkdir: /builds/slave/test-pgo/properties 06:50:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:50:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:50:46 INFO - Contents: 06:50:46 INFO - build_url:https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:50:46 INFO - Running post-action listener: _resource_record_post_action 06:50:46 INFO - Running post-action listener: set_extra_try_arguments 06:50:46 INFO - ##### 06:50:46 INFO - ##### Running populate-webroot step. 06:50:46 INFO - ##### 06:50:46 INFO - Running pre-action listener: _resource_record_pre_action 06:50:46 INFO - Running main action method: populate_webroot 06:50:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:50:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:50:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:50:46 INFO - '../fennec_ids.txt'], 06:50:46 INFO - 'tests': ['tcheck2']}, 06:50:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:50:46 INFO - '--tppagecycles', 06:50:46 INFO - '7'], 06:50:46 INFO - 'tests': ['tsvgm']}}, 06:50:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:50:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:50:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:50:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:50:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:50:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:50:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:46 INFO - 'talos_options': ['--e10s'], 06:50:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:46 INFO - 'tests': ['damp', 'tps']}, 06:50:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:46 INFO - 'talos_options': ['--e10s'], 06:50:46 INFO - 'tests': ['damp', 'tps']}, 06:50:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:50:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:50:46 INFO - 'other': {'tests': ['a11yr', 06:50:46 INFO - 'ts_paint', 06:50:46 INFO - 'tpaint', 06:50:46 INFO - 'sessionrestore', 06:50:46 INFO - 'sessionrestore_no_auto_restore']}, 06:50:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:50:46 INFO - 'tests': ['a11yr', 06:50:46 INFO - 'ts_paint', 06:50:46 INFO - 'tpaint', 06:50:46 INFO - 'sessionrestore', 06:50:46 INFO - 'sessionrestore_no_auto_restore']}, 06:50:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:50:46 INFO - 'tests': ['a11yr', 06:50:46 INFO - 'ts_paint', 06:50:46 INFO - 'tpaint', 06:50:46 INFO - 'sessionrestore', 06:50:46 INFO - 'sessionrestore_no_auto_restore']}, 06:50:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:50:46 INFO - 'tests': ['a11yr', 06:50:46 INFO - 'ts_paint', 06:50:46 INFO - 'tpaint', 06:50:46 INFO - 'sessionrestore', 06:50:46 INFO - 'sessionrestore_no_auto_restore']}, 06:50:46 INFO - 'other_l64': {'tests': ['a11yr', 06:50:46 INFO - 'ts_paint', 06:50:46 INFO - 'tpaint', 06:50:46 INFO - 'sessionrestore', 06:50:46 INFO - 'sessionrestore_no_auto_restore']}, 06:50:46 INFO - 'other_nol64': {'tests': ['a11yr', 06:50:46 INFO - 'ts_paint', 06:50:46 INFO - 'tpaint', 06:50:46 INFO - 'sessionrestore', 06:50:46 INFO - 'sessionrestore_no_auto_restore']}, 06:50:46 INFO - 'svgr': {'tests': ['tsvgx', 06:50:46 INFO - 'tsvgr_opacity', 06:50:46 INFO - 'tart', 06:50:46 INFO - 'tscrollx', 06:50:46 INFO - 'cart']}, 06:50:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:50:46 INFO - 'tests': ['tsvgx', 06:50:46 INFO - 'tsvgr_opacity', 06:50:46 INFO - 'tart', 06:50:46 INFO - 'tscrollx', 06:50:46 INFO - 'cart']}, 06:50:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:46 INFO - 'tests': ['tp5o']}, 06:50:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:46 INFO - 'talos_options': ['--e10s'], 06:50:46 INFO - 'tests': ['tp5o']}, 06:50:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:46 INFO - 'talos_options': ['--xperf_path', 06:50:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:46 INFO - 'tests': ['tp5n']}, 06:50:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:46 INFO - 'talos_options': ['--e10s', 06:50:46 INFO - '--xperf_path', 06:50:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:46 INFO - 'tests': ['tp5n']}}, 06:50:46 INFO - 'talos.zip': {'path': '', 06:50:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:50:46 INFO - Running post-action listener: _resource_record_post_action 06:50:46 INFO - ##### 06:50:46 INFO - ##### Running create-virtualenv step. 06:50:46 INFO - ##### 06:50:46 INFO - Running pre-action listener: _resource_record_pre_action 06:50:46 INFO - Running main action method: create_virtualenv 06:50:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:50:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 06:50:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:50:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:50:46 INFO - Using real prefix '/usr' 06:50:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:50:47 INFO - Installing distribute.............................................................................................................................................................................................done. 06:50:49 INFO - Installing pip.................done. 06:50:49 INFO - Return code: 0 06:50:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:49 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 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b640>, '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 0xe3c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3c9d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:50:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:50:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:50:49 INFO - Using env: {'DISPLAY': ':0', 06:50:49 INFO - 'HOME': '/home/cltbld', 06:50:49 INFO - 'LANG': 'en_US.UTF-8', 06:50:49 INFO - 'LANGUAGE': 'en_US:en', 06:50:49 INFO - 'LOGNAME': 'cltbld', 06:50:49 INFO - 'MAIL': '/var/mail/cltbld', 06:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:49 INFO - 'MOZ_NO_REMOTE': '1', 06:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:49 INFO - 'NO_EM_RESTART': '1', 06:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:49 INFO - 'SHELL': '/bin/bash', 06:50:49 INFO - 'SHLVL': '1', 06:50:49 INFO - 'TERM': 'linux', 06:50:49 INFO - 'TMOUT': '86400', 06:50:49 INFO - 'USER': 'cltbld', 06:50:49 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 06:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:49 INFO - '_': '/tools/buildbot/bin/python'} 06:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:50:49 INFO - Cleaning up... 06:50:49 INFO - Return code: 0 06:50:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:49 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 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b640>, '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 0xe3c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3c9d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:50:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:50:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:50:49 INFO - Using env: {'DISPLAY': ':0', 06:50:49 INFO - 'HOME': '/home/cltbld', 06:50:49 INFO - 'LANG': 'en_US.UTF-8', 06:50:49 INFO - 'LANGUAGE': 'en_US:en', 06:50:49 INFO - 'LOGNAME': 'cltbld', 06:50:49 INFO - 'MAIL': '/var/mail/cltbld', 06:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:49 INFO - 'MOZ_NO_REMOTE': '1', 06:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:49 INFO - 'NO_EM_RESTART': '1', 06:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:49 INFO - 'SHELL': '/bin/bash', 06:50:49 INFO - 'SHLVL': '1', 06:50:49 INFO - 'TERM': 'linux', 06:50:49 INFO - 'TMOUT': '86400', 06:50:49 INFO - 'USER': 'cltbld', 06:50:49 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 06:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:49 INFO - '_': '/tools/buildbot/bin/python'} 06:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:49 INFO - Downloading/unpacking psutil>=0.7.1 06:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:50:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:50:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:51 INFO - Installing collected packages: psutil 06:50:51 INFO - Running setup.py install for psutil 06:50:51 INFO - building 'psutil._psutil_linux' extension 06:50:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:50:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:50:51 INFO - building 'psutil._psutil_posix' extension 06:50:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:50:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:51 INFO - Successfully installed psutil 06:50:51 INFO - Cleaning up... 06:50:51 INFO - Return code: 0 06:50:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:51 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 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b640>, '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 0xe3c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3c9d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:50:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:50:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:50:51 INFO - Using env: {'DISPLAY': ':0', 06:50:51 INFO - 'HOME': '/home/cltbld', 06:50:51 INFO - 'LANG': 'en_US.UTF-8', 06:50:51 INFO - 'LANGUAGE': 'en_US:en', 06:50:51 INFO - 'LOGNAME': 'cltbld', 06:50:51 INFO - 'MAIL': '/var/mail/cltbld', 06:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:51 INFO - 'MOZ_NO_REMOTE': '1', 06:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:51 INFO - 'NO_EM_RESTART': '1', 06:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:51 INFO - 'SHELL': '/bin/bash', 06:50:51 INFO - 'SHLVL': '1', 06:50:51 INFO - 'TERM': 'linux', 06:50:51 INFO - 'TMOUT': '86400', 06:50:51 INFO - 'USER': 'cltbld', 06:50:51 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 06:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:51 INFO - '_': '/tools/buildbot/bin/python'} 06:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:50:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:50:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:50:53 INFO - Installing collected packages: mozsystemmonitor 06:50:53 INFO - Running setup.py install for mozsystemmonitor 06:50:54 INFO - Successfully installed mozsystemmonitor 06:50:54 INFO - Cleaning up... 06:50:54 INFO - Return code: 0 06:50:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:54 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 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b640>, '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 0xe3c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3c9d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:50:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:50:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:50:54 INFO - Using env: {'DISPLAY': ':0', 06:50:54 INFO - 'HOME': '/home/cltbld', 06:50:54 INFO - 'LANG': 'en_US.UTF-8', 06:50:54 INFO - 'LANGUAGE': 'en_US:en', 06:50:54 INFO - 'LOGNAME': 'cltbld', 06:50:54 INFO - 'MAIL': '/var/mail/cltbld', 06:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:54 INFO - 'MOZ_NO_REMOTE': '1', 06:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:54 INFO - 'NO_EM_RESTART': '1', 06:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:54 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:54 INFO - 'SHELL': '/bin/bash', 06:50:54 INFO - 'SHLVL': '1', 06:50:54 INFO - 'TERM': 'linux', 06:50:54 INFO - 'TMOUT': '86400', 06:50:54 INFO - 'USER': 'cltbld', 06:50:54 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 06:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:54 INFO - '_': '/tools/buildbot/bin/python'} 06:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:54 INFO - Downloading/unpacking blobuploader==1.2.4 06:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:55 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:50:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:50:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:50:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:56 INFO - Downloading docopt-0.6.1.tar.gz 06:50:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:50:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:56 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:56 INFO - Running setup.py install for blobuploader 06:50:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:50:56 INFO - Running setup.py install for requests 06:50:57 INFO - Running setup.py install for docopt 06:50:57 INFO - Successfully installed blobuploader requests docopt 06:50:57 INFO - Cleaning up... 06:50:57 INFO - Return code: 0 06:50:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:57 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 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b640>, '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 0xe3c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3c9d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:50:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:50:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:50:57 INFO - Using env: {'DISPLAY': ':0', 06:50:57 INFO - 'HOME': '/home/cltbld', 06:50:57 INFO - 'LANG': 'en_US.UTF-8', 06:50:57 INFO - 'LANGUAGE': 'en_US:en', 06:50:57 INFO - 'LOGNAME': 'cltbld', 06:50:57 INFO - 'MAIL': '/var/mail/cltbld', 06:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:57 INFO - 'MOZ_NO_REMOTE': '1', 06:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:57 INFO - 'NO_EM_RESTART': '1', 06:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:57 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:57 INFO - 'SHELL': '/bin/bash', 06:50:57 INFO - 'SHLVL': '1', 06:50:57 INFO - 'TERM': 'linux', 06:50:57 INFO - 'TMOUT': '86400', 06:50:57 INFO - 'USER': 'cltbld', 06:50:57 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 06:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:57 INFO - '_': '/tools/buildbot/bin/python'} 06:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:57 INFO - Running setup.py (path:/tmp/pip-AoJUyM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:57 INFO - Running setup.py (path:/tmp/pip-ziNmQP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:57 INFO - Running setup.py (path:/tmp/pip-QvgDcj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:57 INFO - Running setup.py (path:/tmp/pip-3xhi3r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:57 INFO - Running setup.py (path:/tmp/pip-7d4k8Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:57 INFO - Running setup.py (path:/tmp/pip-Eeqp9Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:57 INFO - Running setup.py (path:/tmp/pip-OgX61F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:57 INFO - Running setup.py (path:/tmp/pip-_uFPJ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:58 INFO - Running setup.py (path:/tmp/pip-qh5iv7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:58 INFO - Running setup.py (path:/tmp/pip-vSySBJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:58 INFO - Running setup.py (path:/tmp/pip-bWX8sl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:58 INFO - Running setup.py (path:/tmp/pip-Qq88W5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:58 INFO - Running setup.py (path:/tmp/pip-jYNX6T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:58 INFO - Running setup.py (path:/tmp/pip-5pEVnn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:58 INFO - Running setup.py (path:/tmp/pip-x4tesa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:58 INFO - Running setup.py (path:/tmp/pip-wdGwSq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:58 INFO - Running setup.py (path:/tmp/pip-T3q7wg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:58 INFO - Running setup.py install for manifestparser 06:50:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:50:58 INFO - Running setup.py install for mozcrash 06:50:58 INFO - Running setup.py install for mozdebug 06:50:58 INFO - Running setup.py install for mozdevice 06:50:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Running setup.py install for mozfile 06:50:59 INFO - Running setup.py install for mozhttpd 06:50:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Running setup.py install for mozinfo 06:50:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Running setup.py install for mozInstall 06:50:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Running setup.py install for mozleak 06:50:59 INFO - Running setup.py install for mozlog 06:50:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Running setup.py install for moznetwork 06:50:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Running setup.py install for mozprocess 06:50:59 INFO - Running setup.py install for mozprofile 06:51:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:51:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:51:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:51:00 INFO - Running setup.py install for mozrunner 06:51:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:51:00 INFO - Running setup.py install for mozscreenshot 06:51:00 INFO - Running setup.py install for moztest 06:51:00 INFO - Running setup.py install for mozversion 06:51:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:51:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:51:00 INFO - Cleaning up... 06:51:00 INFO - Return code: 0 06:51:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:00 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 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b640>, '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 0xe3c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3c9d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:51:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:00 INFO - Using env: {'DISPLAY': ':0', 06:51:00 INFO - 'HOME': '/home/cltbld', 06:51:00 INFO - 'LANG': 'en_US.UTF-8', 06:51:00 INFO - 'LANGUAGE': 'en_US:en', 06:51:00 INFO - 'LOGNAME': 'cltbld', 06:51:00 INFO - 'MAIL': '/var/mail/cltbld', 06:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:00 INFO - 'MOZ_NO_REMOTE': '1', 06:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:00 INFO - 'NO_EM_RESTART': '1', 06:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:00 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:00 INFO - 'SHELL': '/bin/bash', 06:51:00 INFO - 'SHLVL': '1', 06:51:00 INFO - 'TERM': 'linux', 06:51:00 INFO - 'TMOUT': '86400', 06:51:00 INFO - 'USER': 'cltbld', 06:51:00 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 06:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:00 INFO - '_': '/tools/buildbot/bin/python'} 06:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:00 INFO - Running setup.py (path:/tmp/pip-AgA9RQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 06:51:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:00 INFO - Running setup.py (path:/tmp/pip-Hr_RqA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:00 INFO - Running setup.py (path:/tmp/pip-EzXXTy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:51:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:00 INFO - Running setup.py (path:/tmp/pip-eD2CBv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:01 INFO - Running setup.py (path:/tmp/pip-V2U1_R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:01 INFO - Running setup.py (path:/tmp/pip-dmUvQA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:01 INFO - Running setup.py (path:/tmp/pip-YRwPa3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:01 INFO - Running setup.py (path:/tmp/pip-EGwsda-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:01 INFO - Running setup.py (path:/tmp/pip-hHEF2G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:01 INFO - Running setup.py (path:/tmp/pip-yr4LuD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:01 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)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:01 INFO - Running setup.py (path:/tmp/pip-jJdKqD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:01 INFO - Running setup.py (path:/tmp/pip-CHJbg5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:01 INFO - Running setup.py (path:/tmp/pip-hQs4OP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:01 INFO - Running setup.py (path:/tmp/pip-7QSaxX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:01 INFO - Running setup.py (path:/tmp/pip-wgb56c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:01 INFO - Running setup.py (path:/tmp/pip-LS8Re7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:01 INFO - Running setup.py (path:/tmp/pip-W1lXhh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51:03 INFO - Downloading blessings-1.5.1.tar.gz 06:51:03 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 06:51:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:03 INFO - Installing collected packages: blessings 06:51:03 INFO - Running setup.py install for blessings 06:51:03 INFO - Successfully installed blessings 06:51:03 INFO - Cleaning up... 06:51:03 INFO - Return code: 0 06:51:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:51:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:51:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:51:04 INFO - Reading from file tmpfile_stdout 06:51:04 INFO - Current package versions: 06:51:04 INFO - argparse == 1.2.1 06:51:04 INFO - blessings == 1.5.1 06:51:04 INFO - blobuploader == 1.2.4 06:51:04 INFO - docopt == 0.6.1 06:51:04 INFO - manifestparser == 1.1 06:51:04 INFO - mozInstall == 1.12 06:51:04 INFO - mozcrash == 0.16 06:51:04 INFO - mozdebug == 0.1 06:51:04 INFO - mozdevice == 0.47 06:51:04 INFO - mozfile == 1.2 06:51:04 INFO - mozhttpd == 0.7 06:51:04 INFO - mozinfo == 0.9 06:51:04 INFO - mozleak == 0.1 06:51:04 INFO - mozlog == 3.1 06:51:04 INFO - moznetwork == 0.27 06:51:04 INFO - mozprocess == 0.22 06:51:04 INFO - mozprofile == 0.27 06:51:04 INFO - mozrunner == 6.11 06:51:04 INFO - mozscreenshot == 0.1 06:51:04 INFO - mozsystemmonitor == 0.0 06:51:04 INFO - moztest == 0.7 06:51:04 INFO - mozversion == 1.4 06:51:04 INFO - psutil == 3.1.1 06:51:04 INFO - requests == 1.2.3 06:51:04 INFO - wsgiref == 0.1.2 06:51:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51: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')]} 06:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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', '-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 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b640>, '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 0xe3c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3c9d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 06:51:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:04 INFO - Using env: {'DISPLAY': ':0', 06:51:04 INFO - 'HOME': '/home/cltbld', 06:51:04 INFO - 'LANG': 'en_US.UTF-8', 06:51:04 INFO - 'LANGUAGE': 'en_US:en', 06:51:04 INFO - 'LOGNAME': 'cltbld', 06:51:04 INFO - 'MAIL': '/var/mail/cltbld', 06:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:04 INFO - 'MOZ_NO_REMOTE': '1', 06:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:04 INFO - 'NO_EM_RESTART': '1', 06:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:04 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:04 INFO - 'SHELL': '/bin/bash', 06:51:04 INFO - 'SHLVL': '1', 06:51:04 INFO - 'TERM': 'linux', 06:51:04 INFO - 'TMOUT': '86400', 06:51:04 INFO - 'USER': 'cltbld', 06:51:04 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 06:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:04 INFO - '_': '/tools/buildbot/bin/python'} 06:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 06:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 06:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 06:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 06:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 06:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:51:04 INFO - Cleaning up... 06:51:04 INFO - Return code: 0 06:51:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:51: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')]} 06:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b640>, '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 0xe3c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3c9d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51: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', 'jsonschema'] in /builds/slave/test-pgo/build 06:51: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 jsonschema 06:51:04 INFO - Using env: {'DISPLAY': ':0', 06:51:04 INFO - 'HOME': '/home/cltbld', 06:51:04 INFO - 'LANG': 'en_US.UTF-8', 06:51:04 INFO - 'LANGUAGE': 'en_US:en', 06:51:04 INFO - 'LOGNAME': 'cltbld', 06:51:04 INFO - 'MAIL': '/var/mail/cltbld', 06:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:04 INFO - 'MOZ_NO_REMOTE': '1', 06:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:04 INFO - 'NO_EM_RESTART': '1', 06:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:04 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:04 INFO - 'SHELL': '/bin/bash', 06:51:04 INFO - 'SHLVL': '1', 06:51:04 INFO - 'TERM': 'linux', 06:51:04 INFO - 'TMOUT': '86400', 06:51:04 INFO - 'USER': 'cltbld', 06:51:04 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 06:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:04 INFO - '_': '/tools/buildbot/bin/python'} 06:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:04 INFO - Downloading/unpacking jsonschema 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:51:06 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 06:51:06 INFO - Downloading/unpacking functools32 (from jsonschema) 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51:06 INFO - Downloading functools32-3.2.3-2.tar.gz 06:51:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:51:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:51:06 INFO - warning: no files found matching '*.txt' 06:51:06 INFO - no previously-included directories found matching 'build' 06:51:06 INFO - no previously-included directories found matching 'dist' 06:51:06 INFO - no previously-included directories found matching '.git*' 06:51:06 INFO - Installing collected packages: jsonschema, functools32 06:51:06 INFO - Running setup.py install for functools32 06:51:06 INFO - warning: no files found matching '*.txt' 06:51:06 INFO - no previously-included directories found matching 'build' 06:51:06 INFO - no previously-included directories found matching 'dist' 06:51:06 INFO - no previously-included directories found matching '.git*' 06:51:06 INFO - Successfully installed jsonschema functools32 06:51:06 INFO - Cleaning up... 06:51:06 INFO - Return code: 0 06:51:06 INFO - Running post-action listener: _resource_record_post_action 06:51:06 INFO - Running post-action listener: _start_resource_monitoring 06:51:06 INFO - Starting resource monitoring. 06:51:06 INFO - ##### 06:51:06 INFO - ##### Running install step. 06:51:06 INFO - ##### 06:51:06 INFO - Running pre-action listener: _resource_record_pre_action 06:51:06 INFO - Running main action method: install 06:51:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:51:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:51:06 INFO - Reading from file tmpfile_stdout 06:51:06 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:51:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:51:07 INFO - Reading from file tmpfile_stdout 06:51:07 INFO - Output received: 06:51:07 INFO - Usage: mozinstall [options] installer 06:51:07 INFO - Options: 06:51:07 INFO - -h, --help show this help message and exit 06:51:07 INFO - -d DEST, --destination=DEST 06:51:07 INFO - Directory to install application into. [default: 06:51:07 INFO - "/builds/slave/test-pgo"] 06:51:07 INFO - --app=APP Application being installed. [default: firefox] 06:51:07 INFO - mkdir: /builds/slave/test-pgo/build/application 06:51:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:51:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:51:21 INFO - Reading from file tmpfile_stdout 06:51:21 INFO - Output received: 06:51:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:51:21 INFO - Running post-action listener: _resource_record_post_action 06:51:21 INFO - ##### 06:51:21 INFO - ##### Running run-tests step. 06:51:21 INFO - ##### 06:51:21 INFO - Running pre-action listener: _resource_record_pre_action 06:51:21 INFO - Running main action method: run_tests 06:51:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:51:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:51:21 INFO - Python 2.7.3 06:51:21 INFO - Return code: 0 06:51:21 INFO - grabbing minidump binary from tooltool 06:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:21 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 0xe3b640>, '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 0xe3c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3c9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:51:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 06:51:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:51:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:51:21 INFO - Return code: 0 06:51:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:51:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:51:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:51:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:51:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:51:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:51:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost 06:51:21 INFO - Using env: {'DISPLAY': ':0', 06:51:21 INFO - 'HOME': '/home/cltbld', 06:51:21 INFO - 'LANG': 'en_US.UTF-8', 06:51:21 INFO - 'LANGUAGE': 'en_US:en', 06:51:21 INFO - 'LOGNAME': 'cltbld', 06:51:21 INFO - 'MAIL': '/var/mail/cltbld', 06:51:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:51:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:21 INFO - 'MOZ_NO_REMOTE': '1', 06:51:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:21 INFO - 'NO_EM_RESTART': '1', 06:51:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:21 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:51:21 INFO - 'SHELL': '/bin/bash', 06:51:21 INFO - 'SHLVL': '1', 06:51:21 INFO - 'TERM': 'linux', 06:51:21 INFO - 'TMOUT': '86400', 06:51:21 INFO - 'USER': 'cltbld', 06:51:21 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574', 06:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:21 INFO - '_': '/tools/buildbot/bin/python'} 06:51:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] with output_timeout 3600 06:51:21 INFO - mozversion INFO | application_buildid: 20151126053024 06:51:21 INFO - mozversion INFO | application_changeset: 4aad8e3db7e990ccd2dfc6e7840632559272b22b 06:51:21 INFO - mozversion INFO | application_display_name: Nightly 06:51:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:51:21 INFO - mozversion INFO | application_name: Firefox 06:51:21 INFO - mozversion INFO | application_remotingname: firefox 06:51:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:51:21 INFO - mozversion INFO | application_vendor: Mozilla 06:51:21 INFO - mozversion INFO | application_version: 45.0a1 06:51:21 INFO - mozversion INFO | platform_buildid: 20151126053024 06:51:21 INFO - mozversion INFO | platform_changeset: 4aad8e3db7e990ccd2dfc6e7840632559272b22b 06:51:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:51:21 INFO - mozversion INFO | platform_version: 45.0a1 06:51:21 INFO - 2015-11-26 06:51:21,894 DEBUG : using testdate: 1448549481 06:51:21 INFO - 2015-11-26 06:51:21,895 DEBUG : actual date: 1448549481 06:51:21 INFO - 2015-11-26 06:51:21,981 INFO : starting webserver on 'localhost:43842' 06:51:21 INFO - 2015-11-26 06:51:21,982 INFO : Starting test suite talos-linux64-ix-065 06:51:21 INFO - 2015-11-26 06:51:21,982 INFO : Starting test dromaeo_css 06:51:21 INFO - 2015-11-26 06:51:21,982 DEBUG : operating with platform_type : linux_ 06:51:21 INFO - 2015-11-26 06:51:21,983 INFO : Initialising browser for dromaeo_css test... 06:51:21 INFO - 2015-11-26 06:51:21,995 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk0o5uH/profile http://localhost:43842/getInfo.html 06:51:26 INFO - 2015-11-26 06:51:26,072 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:51:26 INFO - 2015-11-26 06:51:26,072 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:51:26 INFO - 2015-11-26 06:51:26,072 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:51:26 INFO - 2015-11-26 06:51:26,072 DEBUG : BROWSER_OUTPUT: __metrics 06:51:26 INFO - 2015-11-26 06:51:26,136 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:51:27 INFO - 2015-11-26 06:51:27,415 INFO : Browser initialized. 06:51:27 INFO - 2015-11-26 06:51:27,415 INFO : Running cycle 1/1 for dromaeo_css test... 06:51:27 INFO - 2015-11-26 06:51:27,416 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk0o5uH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:51:39 INFO - 2015-11-26 06:51:39,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 138756096 06:51:39 INFO - 2015-11-26 06:51:39,159 DEBUG : BROWSER_OUTPUT: 06:52:30 INFO - 2015-11-26 06:52:30,712 DEBUG : BROWSER_OUTPUT: 1448549550706 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:54:39 INFO - 2015-11-26 06:54:39,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43842/tests/dromaeo/cssquery-ext.html) 06:54:40 INFO - 2015-11-26 06:54:40,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 255819776 06:54:40 INFO - 2015-11-26 06:54:40,727 DEBUG : BROWSER_OUTPUT: 06:57:43 INFO - 2015-11-26 06:57:43,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/dromaeo/cssquery-ext.html (next: http://localhost:43842/tests/dromaeo/cssquery-jquery.html) 06:57:43 INFO - 2015-11-26 06:57:43,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 225693696 06:57:43 INFO - 2015-11-26 06:57:43,607 DEBUG : BROWSER_OUTPUT: 07:00:45 INFO - 2015-11-26 07:00:45,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43842/tests/dromaeo/cssquery-mootools.html) 07:00:46 INFO - 2015-11-26 07:00:46,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 216047616 07:00:46 INFO - 2015-11-26 07:00:46,163 DEBUG : BROWSER_OUTPUT: 07:03:48 INFO - 2015-11-26 07:03:48,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43842/tests/dromaeo/cssquery-prototype.html) 07:03:48 INFO - 2015-11-26 07:03:48,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 201056256 07:03:48 INFO - 2015-11-26 07:03:48,577 DEBUG : BROWSER_OUTPUT: 07:06:51 INFO - 2015-11-26 07:06:51,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43842/tests/dromaeo/cssquery-yui.html) 07:06:51 INFO - 2015-11-26 07:06:51,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 202522624 07:06:51 INFO - 2015-11-26 07:06:51,646 DEBUG : BROWSER_OUTPUT: 07:09:54 INFO - 2015-11-26 07:09:54,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/dromaeo/cssquery-yui.html (next: http://localhost:43842/tests/dromaeo/cssquery-dojo.html) 07:09:54 INFO - 2015-11-26 07:09:54,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 273022976 07:09:54 INFO - 2015-11-26 07:09:54,643 DEBUG : BROWSER_OUTPUT: 07:09:54 INFO - 2015-11-26 07:09:54,643 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:09:54 INFO - 2015-11-26 07:09:54,643 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:09:54 INFO - 2015-11-26 07:09:54,643 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:09:54 INFO - 2015-11-26 07:09:54,643 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:09:54 INFO - 2015-11-26 07:09:54,644 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3184.554162417261;3208.7753857230005;3272.2146684795644;3273.4762438009925;3297.5383446317514;5248.134057880445;5393.81121660742;5420.457954204582;5437.211604317376;5466;5362;5382.703951282678;5425.3760817506;5428.077226871432;5521.889562208764;4935.111679897626;4977.751112444382;4982.377202849644;5002.374703162105;5028.120078986181;4857.149998750222;5065;5073.162928116856;5101.311322971388;5112.539871411572;4898.853034408973;4948.604111671058;4991.925121123186;5014.473480284554;5030.748462576893;4955.405351357824;4964.751762411865;4968.1554135797005;4970.701757894538;5015.623828212899;4742.810287588527;4971.304017437562;4975.203967365204;4986.401631804207;5039.496050394931;5184.948150518522;5200.947990520122;5265.0259701955265;5287.259783630295;5316.0165369406395;5929.762809487615;5930.347661757203;5932.495737862287;5937.079752638348;5975.671338076404;5706.828795136153;5819.912701309484;5954.315253745832;5962.791302304442;5963.821085367446;5438.184272359138;5441.673499590037;5554.694491802949;5557.972210139004;5575.219469274305;6031.517478601701;6038.064100064497;6042.123892035718;6060.454559089703;6088.330283668793;5735.340435849847;5815.505682016991;5818.854528636818;5822.970885145632;5827.155062515912;5656.264685590929;5751.079827227623;5764.221830052973;5765.077587585966;5910.674912879746;5857.238558987305;5922.111683247547;5934.37689042653;5943.58394912352;5944.078667806497;5937.851553711192;5940.435658612425;5944.256967879015;5947.107933809876;5948.762049517971;4381.2332841753205;4457.086297309044;4516.8193272268745;4555.908881822411;4561.543845615478;4019.33680942647;4051.6353528182603;4056.411820286042;4068.633822955889;4094.447249621263;5506.256655351476;5515.310586176728;5516.448355164532;5567.081431563746;5606.495415412633;5772.538196944234;5806.709664516758;5928.140419639214;5965.940340596625;5971.044632858809;5567.498925096761;5574.554035677136;5593.300837395325;5602.243697100839;5604.859878502988;5109.463506331856;5128.3333166688835;5128.8717782055;5139.152039913372;5184.922226166611;5902.586818922634;5984.670843103671;6015.187949626832;6017.428344307284;6143.600665956698;5956.880862382642;5980.700964951822;6050.031994880974;6056.757729690763;6056.939430605814;6127.724252408741;6176.289726681489;6184.319724830355;6192.071189321638;6194.5044396449075;5693.459121383462;5776.104703770922;5939.881202376015;5942.970285148546;5952.285725712942;5876.882462350814;5878.706064696663;5961.761529538943;5966.105084237225;5983.850403739942;5744.253247077853;5747.109198074305;5748.281464816898;5749.798757043651;5763.913541296968;5660.632058916157;5664.405237450009;5714.714264286686;5726.570507211893;5750.281214848144;5487.780488780404;5552.472515111058;5557.221988921635;5559.944400555943;5611.074172761612;5725.141228815544;5840.328362238397;5842.678652674143;5847.239858818326;5896.587238893237;5453.072977593739;5571.582131340085;5573.3869274380595;5715.628484148517;5731.426857314235 07:09:54 INFO - 2015-11-26 07:09:54,645 DEBUG : BROWSER_OUTPUT: |1;ext.html;573.9196512488253;599.2120361724329;606.1998162425599;625.0655270370795;628.783069840905;31791.682083179163;32401;32418.837905810466;40069;40537.79731101348;43241.459646737036;43829;43996.120077598505;43996.56003439965;44080.77959610197;7685.462017658766;8813.427127236726;8979.95510022449;8986;8988.056254093324;7774.922250777505;10552.577896884115;10804.945975270113;10817.134629229682;10828.40443775592;10520.894791052106;10633.46832658368;10633.680989570325;10639.308444951092;10640.467976601178;7847.882281765721;7997.920020799776;10542.314749541294;10657.680269591885;10672.30630009047;10357.171426285879;10504.737381565446;10521.05310522049;10536.841947370796;10540.525676344583;40051;40196.39705404421;40449.79775101106;40531.7973410134;40543.7972810137;3305.140663427502;3330.8667653293837;3337.6996070353543;3375;3426.1434641339665;29303.2674183145;29715.257118571993;29949.401011979855;30119.548206776915;30871;3954.1498577805623;4066.959330406717;4110.712250142491;4115.238680844023;4149.771762553059;274384;275664;276350;276822;277024;54031.459685402646;55787.44212557904;61539.384606154264;61863.38136618666;62184.68907655523;72530.63734681293;73374.63312683509;73744.63127684327;73948.26051739522;74056;14884.925575372054;14946.850531494545;15064.322105505278;15065.246737663074;15076.39694412233;11544.365059921785;11656.475458604384;11658.533658653729;11670.124740644485;11670.883291167149;20111.59776804485;20270.493237669176;20281.594368112852;20294;20365.268952139235;7889.132195458495;8239.217274358927;8309.252167304972;8377.874331885027;8453.66185352579;941.7174847545846;987.9407235565889;994.3685759542598;996.6113215845826;1056.6935588679196;28089.578656320173;28107.43785124327;28434.85782571115;28449.288767780556;28469;1026.4662375564665;1073.7315671082229;1092.7705181911729;1156.8091264941359;1156.8482622322474;14541.491047813275;14589.124652520883;14665.413383464755;14946.402143914122;14983.550493485212;312744;316219;316458;316536;316726;50817.237741433906;50838.23742643863;51387.22919156215;51432.22851657228;51442.74278628658;1291.7158225190442;1295.7084655952524;1340.9932950335185;1366.6241783509415;1370.2463644995212;26858.73141268562;27709.722902771522;28041.859790700917;28091.578626320214;28151.71848281491;41500.58499414967;42445.36331955085;42530.36204456998;45579.54420455753;45902;406846;416556;419399;420759;421438;32027.83986080055;32469.18827029343;32479;32590.34819303648;32630.347393051532;42206;43011;43074.78462607667;43537;43816;36375.81812090923;36500.45249321315;36668.26663466769;36777.448338274415;37747.245055099294;36210.84493299095;36262.4560631596;36620.63379366172;37215.441768372955;37269;35335.64664353323;36062.4590631146;36078;36379.27241455103;36395.63604363923;31287.714789947637;31464.426778660516;33420.498692520116;33452.832735836164;33479.83260083781;24209.757902421454;24617.261482155565;24653.50692986166;24918.875405622857;25021.12426065079 07:09:54 INFO - 2015-11-26 07:09:54,647 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.2918932944781;352.6050823078153;356.8447725239521;357.874743839656;359.29040145712236;14398.280085995711;14438.711225775505;16770.83229167708;17461.388851390206;18419.815801841978;15455.30451129699;16194.919025404886;16237.431689890856;16249.512514624581;16302.755458668129;5306.283651707018;5403.054465468547;5426.050441172799;5445.727713614323;5456.836294911159;3990.9600903991022;4133.297339452301;5372.113601255788;5372.677639341652;5792.565557583177;5852.092925596518;5889.705514724246;5918.704064796743;5922.466977971982;5929.0513517836935;5486.177073438997;5486.61593688442;5490.588205884535;5494.2582751328455;5849.707514624273;5160.354955630546;5270.736463176826;5275.235090911835;5279.102552566073;5279.604029697788;20156.29452969139;20745.58508829815;20746.688799667867;20936.47658808527;21429.14283428661;2156.6657168138963;2266.05958527211;2438.5244877248942;2620.069875194317;2696.191142657195;13181.538646147435;13207.66980825487;13393.129446585941;13472.865271347357;13821.170729756246;1768.4252617899235;1856.9071546422624;1864.888106713588;1896.0709252466331;1898.1173754204224;57595.71202143963;60082.69958650179;60145.39854601398;60639.393606063815;61271.387286127014;9636.325457218069;9793.706188814347;9969.900300997042;9999.50002499872;10047.145992590566;13015.479380824661;13030.218186908816;13040.152390094614;13047;13048.869511304765;7507.21174276704;7543.886841697379;7546.811329716801;7658.157602663702;7862.174471680506;7159.96420017907;7178.138623365229;7220.061392019109;7221.42228621709;7229.566226026455;5973.731182096816;6067.817965461043;6088.543359248074;6096.634201947897;6108.786192483241;1646.761219623148;1699.9660006799795;1744.215103203538;1769.8141695121826;1801.4775715042754;426.91888541177076;432.3190974215623;913.3195769151891;1023.2019025160238;1043.1900652368136;10145.797084058277;10425.478726063666;10739.624113156158;10912.290701104403;11169.38568378747;446.1656701967342;902.5397047505688;994.3487016004384;1015.243643485608;1028.876534815812;9465.716028519155;9750.171235444925;9776.462294573725;9788.902110978941;9966.35218710796;540292;551497;558659;571157;572326;80207.19792802114;81570;82308.58845705733;83698;83851.5807420959;1144.181909934401;1161.6805378520974;1164.2141554450711;1167.0430247197387;1191.606769765975;15674.451394201149;15734.76397854056;15833.366665333719;15909.363625454853;16024.839751602334;34511.4823277656;35665.82167089252;35865.641343587275;35901.82049089738;35946.46080308745;46621.766891166684;46688;47325.763371182926;49880;50175.74912125416;9586.233101352014;9633.421994680342;9944.701658949954;9953.153981911619;9966.900330996887;17466.21402036886;17571.209295581473;17890.731639025165;18034.549136271697;18090.638187236444;13751.656208594864;14329.498467553585;14635.560933172022;14778.334974926369;14784.186869722269;14040.508582199574;14124.78812817788;14321.212333321351;14611.123332600078;14734.705305894036;12012.339321337411;12140.878591214328;13343.599692009255;14673.413063477341;14825.25873706332;9783.461909594756;9851.556679949563;9864.112229899343;10007.39955602637;10009.799804003733;10318.587256509956;12223.572174973833;14938.626534336729;15052.096874187584;15268.694626107193 07:09:54 INFO - 2015-11-26 07:09:54,650 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1283.0890068051694;1441.0921119694585;1455.7015811758583;1641.6470458851345;1711.2128420926374;6100;7300.561966282027;7478.364339031182;7499.962500187491;7513.887291690629;7357;7477.5887326197035;7534.849303013936;7535.547867127976;7544.132424771153;1881.8870867747978;1916.5017095555186;2189.343197040889;2214.7674494178123;2221.9666704999436;2206.6248737714627;2219.1899956515836;2226.3321003698907;2232.955340893181;2241.4396400899777;2210.933671989843;2260.3332017054927;2263;2263.8981245843893;2267.1044937249776;1885.161103309028;1909.9140538675792;2109.546447513784;2154.256781410411;2155.1918030738475;2114.1860383752214;2132.3709505695856;2143.2605751015876;2143.3677065265783;2148.9785102148935;7407.259274072603;7465.962670186615;7466.887996680054;7470.103587569472;7493.213212612652;4562.4753153387455;4638.489766125724;4648.651351148644;4657.04530571232;4657.836975705834;2958.837263950482;2991.237234505209;3039.149038269288;3048.6951304869335;3098.612673415823;1020.5764607687801;1035.2494441529907;1049.3389164826187;1064.4677661169414;1084.4523515624637;10199.337043092175;10204.183665306758;10217.540210690537;10236.948815255875;10237.795244095076;4179.665626749853;4252.638525725286;4299.634531064832;4308.784560772012;4334.046509767846;8712.346574006975;8724.56377181151;8758.343124265706;8760.56197190138;8775.297976161892;4698.130845793539;4701.694389864648;4701.764911754399;4703.270992996091;4747.335373047776;4216.51510076339;4222.1766755483;4230.069384735353;4231.936520952188;4234.026173980002;3459.927422498983;3499.492573576868;3516.5780106387397;3552.8223588820974;3563.3585954527916;1191.4936152135308;1199.2564609941892;1207.3842340406457;1211.073528750489;1214.3745970825032;1303.0813276639947;1310.8361454818148;1319.4128612767418;1336.111485861891;1347.6091933339417;6847.863042739117;6978.441724662015;6984.266652001568;6986.650667466606;7016.859662806715;434.450420218424;443.05629010208696;443.51656694203473;446.0209839402545;447.3267732063224;5104.3109180260935;5146.8970620588125;5168.250603662448;5178;5178.456262092502;8758.167974042455;8761.211490965843;8783.385163038654;8854.690085846965;8950.68672596456;8662.653493860302;8736.519491427905;8753.606087726068;8774.95612521946;8784.033756286803;6790.932090679129;6939.826504337331;6997.370236678622;7060.92939070613;7088.893666595005;7064.611446370293;7097.041899343522;7113.82215444618;7126.893096603451;7129.893051604126;7716.2669546393;7982.361411087215;7985.560794156145;7999.120096789465;8038.115807261313;8017.236208034223;8183.099859015622;8246.38152138604;8345.082040975609;8361.707340243061;5673.8865222694485;5840.503557197686;6674.666266686743;6711.46308295345;6720.563163394364;7204.819879503054;7224.349808517259;7234.74678386254;7235.565866048054;7257.927420725937;5790.594658373873;6598;6791.660416979033;6840.555363901331;6895.172579290517;6294.213223347082;6793.558418702769;6800.387965083166;6898.517103802686;6946.16646002483;6891.069705589681;6949.548279361826;6971.198312194163;6987.406070484066;6989.33601307875;6298.370162983665;6343.175387199819;6347.619142851444;6358.650274234961;6361.268454127649;6142.846428839315;6372.394622510854;6416.7754128605275;6424.967875160594;6499.3175716549085 07:09:54 INFO - 2015-11-26 07:09:54,650 DEBUG : BROWSER_OUTPUT: |4;prototype.html;313.91367373972156;317.91098492422117;322.4437844717861;338.5733975191258;340.0716045196615;6019.217501724781;6034.275886893573;6037.547183961198;6056.8485787855325;6064.9090263646085;5684.403137670547;5781.190633311329;5844.736986835592;5976.163337132805;5994;4578.931316030245;4587.541245875419;4602.447706275251;4609.539046095397;4611.769411529419;4435.822567097328;4623.791929363187;4624.421947256593;4625.7687115644085;4628.60656844167;4467;4507.954920450787;4590.931136032962;4603.10239503297;4604.884877878047;4572.588467037983;4581.244094724383;4584.701994370389;4585.5185205553435;4599.977000115012;4046.9392959105635;4047.797610119512;4052.898677533056;4058.269511487931;4068.6745060395097;5581.972090139523;5698.059820129673;5705.2012718219485;5715.171300161495;5717.942820571782;5294.020606187868;5295.920561191585;5305.522502974751;5305.681659100466;5306.575473962073;6355.8411039723915;6361.3638636136475;6380.968095159541;6395.712192951329;6396.680165991728;4345.174416860787;4354.629856462205;4354.695171338008;4355.1725172217175;4355.651547876194;6491.318411566765;6558.311377305362;6600.86798264032;6627.072209890619;6640.435562977153;4360.171567402183;4401.449818772653;4415.315626077963;4426.203283409017;4426.645868330525;4446.799894004777;4457.442819647544;4457.732536047783;4460.799264033127;4466.6203372713035;5223.347081614798;5225.869353266199;5228.7908483660985;5239.44985776488;5240.0567897778;6199.380061993855;6298.527610429236;6336.366363363627;6380.202474690664;6406.263279722798;1579.202502736111;1587.9364825407085;1589.3721979817908;1590.769338445919;1592.1322879030956;1021.8467229915572;1041.4272150317447;1058.957641694339;1060.5121644043827;1094.5512339940585;6163.8150855474405;6166.290876549165;6175.660338681326;6196.690165491707;6204.441600255998;6355.650439225887;6569.967150164219;6573.704183311763;6577.14497115372;6592.340765923465;6074.271087469532;6130.080487926846;6166.290876549165;6226.097215903759;6237.282712488031;3538.2392785550715;3583.784972901582;3588.174719814457;3592.856285748541;3593.6945359644724;6636.270010298863;6764.72941082361;6772.458203343721;6778.661066946732;6798.626075565891;6800.217974932847;6805.353491418307;6810.523263371517;6817.90913453845;6826.488013399015;6899.793006209822;6900.827479313058;6906.896396554056;6914.412274956685;6922.7923162305215;6533.934660653333;6596.406323430914;6620.536562440583;6632.635205063768;6638.966805165944;6570.113034740249;6573.408393244631;6573.769918052845;6575.671216439255;6579.276279609335;6847.48643851723;6882.724691012303;6887;6889.138857642794;6892.689828957809;4508.571685689854;4512.638988880816;4512.9774351129345;4515.187266292099;4517.412736344254;6442.581232219891;6587.440067594116;6608.041833934149;6647.800565983028;6693.799186024427;6479.8056058318325;6482.740690372332;6495.707693153914;6497.707603157774;6510.609363438209;6315.273743519554;6463.676816159267;6469.191351081115;6479.5788273762055;6487.0593763903025;6348.809535713936;6357.8728425432155;6358.904616430665;6363.490920726424;6370.044493326038;6465.935340646533;6470.547061705635;6472.320406357265;6474.546781725422;6476.6114033158165;6210.192674952227;6338.429541341301;6354.23749150105;6360.522960778053;6364.87270254583 07:09:54 INFO - 2015-11-26 07:09:54,654 DEBUG : BROWSER_OUTPUT: |5;yui.html;706.6325510734415;762.8207371267752;764.121260550367;859.415597393772;902.5442151713386;13354.332283385816;13361.331933403328;13710.862891371084;13718.108322959013;13753.106048106878;13068.934655326733;13135.540256091039;13228;13231.536896208634;13243.337833108355;686.0498209979165;820.8153165537751;841.6380956188837;841.8863453433769;842.4103127810557;689.1661090081008;824.381713714714;841.3605659698612;841.6759547574197;841.7180244618061;864.9221570058694;880.8458519759049;882.2765332427412;882.5190271302124;882.9293656507464;714.8606021825746;721.6103304215769;853.5689476814231;867.5185272173941;868.522312727997;640.7308930249307;641.413107007088;642.0946465483646;642.3801032004138;644.8291202831207;13560.728785424237;13772.173669579857;13846.169229846242;13882.93058534711;13927.442902283896;11443.542258309657;11601.767964640745;11807.763844723144;11813.704657383549;11815.763684726257;10290.588376464932;10321.380717156919;10459.790804183875;10485.79028419435;10505.212109091772;3496.248306614065;3513.8067406292644;3539.0975301298004;3545.166885781839;3629.8185090745355;45664;45820.312695309265;46258;46532;47096;10352.689419317432;10525.157987360994;10550.788984220273;10583.735406614896;11017.504212310465;18945.147468363957;18945.715814262796;18960.52598685044;19023.33418330352;19034.143463544173;7467.141278752904;7526.09686837583;7655.425843061793;7664.156942736295;7796;4378.605925466723;4381.474223093249;4389.736615803062;4421.5578442156175;4496.527864574238;2949.5428208627695;2991.5512673098774;2997.730204281625;3003.5344521599186;3004.9399012019635;525.9368875734937;529.2405398253519;532.1645017322843;534.5082524077858;545.9208414779835;638.7860066877555;664.8005598320484;671.701093013614;684.934931181537;722.3895808042196;7814.765557033298;7865.134835168127;8001.919980800234;8017.959910200411;8168.877466838002;550.5072959701046;560.778492495462;561.6349372907642;624.1168746224042;651.563452486835;3793.943090853639;3921.215756848642;3930.371140617545;4075.857344992911;4143.4199212110325;54871.72564137234;56088.15867761987;56881.14678279829;57207.42792572021;57393;50436.747816260686;51059.489405106215;51858.22212666813;52007.73996129995;53287.20069198965;45757.77121114373;46314;46805.531944680115;47369.5263047372;47723;8180.8363832721825;8360.45657032291;8485.109063548485;8495.277901378453;8736.301095912439;33882.83058584691;34722.305553888276;34789.08660023723;35389.64610353864;35652.64347356493;42301.36547951722;43325;46633;46663.90095417076;46742.298865516364;10877.836832447361;11100.722481938015;11212.103031757602;11223.102151827998;11479.196456248317;11875.465604048011;11988.700282493008;12014.038876889654;12649.810252846399;12688.111832171659;10775.407352595683;10926;10984.231103822975;11006.174536909604;11279.436028198394;11535.250208736405;11724.120690948042;11827.763444731228;12194.329311887932;12207.145499814927;10199;10471.633492827714;10494.722824034494;10814.513346899252;11071.833922491009;9750.60997560118;10038.899611003797;10061.295709300279;10209.591616335561;10322.587096516356;9059.501727404793;9080.182783549511;9102.028386426802;9125.75395921428;9349.252059835333 07:09:54 INFO - 2015-11-26 07:09:54,654 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:09:54 INFO - 2015-11-26 07:09:54,654 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:09:54 INFO - 2015-11-26 07:09:54,654 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,862 07:09:54 INFO - 2015-11-26 07:09:54,654 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:09:54 INFO - 2015-11-26 07:09:54,654 DEBUG : BROWSER_OUTPUT: __startTimestamp1448550594642__endTimestamp 07:09:54 INFO - 2015-11-26 07:09:54,654 DEBUG : BROWSER_OUTPUT: 07:09:54 INFO - 2015-11-26 07:09:54,655 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:09:54 INFO - 2015-11-26 07:09:54,655 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:09:54 INFO - 2015-11-26 07:09:54,655 DEBUG : BROWSER_OUTPUT: 07:09:54 INFO - 2015-11-26 07:09:54,655 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5461.29 Median:5611.07 stddev:621.10 (11.1%) stddev-sans-first:596.77 07:09:54 INFO - 2015-11-26 07:09:54,655 DEBUG : BROWSER_OUTPUT: Values: 3184.6 3208.8 3272.2 3273.5 3297.5 5248.1 5393.8 5420.5 5437.2 5466.0 5362.0 5382.7 5425.4 5428.1 5521.9 4935.1 4977.8 4982.4 5002.4 5028.1 4857.1 5065.0 5073.2 5101.3 5112.5 4898.9 4948.6 4991.9 5014.5 5030.7 4955.4 4964.8 4968.2 4970.7 5015.6 4742.8 4971.3 4975.2 4986.4 5039.5 5184.9 5200.9 5265.0 5287.3 5316.0 5929.8 5930.3 5932.5 5937.1 5975.7 5706.8 5819.9 5954.3 5962.8 5963.8 5438.2 5441.7 5554.7 5558.0 5575.2 6031.5 6038.1 6042.1 6060.5 6088.3 5735.3 5815.5 5818.9 5823.0 5827.2 5656.3 5751.1 5764.2 5765.1 5910.7 5857.2 5922.1 5934.4 5943.6 5944.1 5937.9 5940.4 5944.3 5947.1 5948.8 4381.2 4457.1 4516.8 4555.9 4561.5 4019.3 4051.6 4056.4 4068.6 4094.4 5506.3 5515.3 5516.4 5567.1 5606.5 5772.5 5806.7 5928.1 5965.9 5971.0 5567.5 5574.6 5593.3 5602.2 5604.9 5109.5 5128.3 5128.9 5139.2 5184.9 5902.6 5984.7 6015.2 6017.4 6143.6 5956.9 5980.7 6050.0 6056.8 6056.9 6127.7 6176.3 6184.3 6192.1 6194.5 5693.5 5776.1 5939.9 5943.0 5952.3 5876.9 5878.7 5961.8 5966.1 5983.9 5744.3 5747.1 5748.3 5749.8 5763.9 5660.6 5664.4 5714.7 5726.6 5750.3 5487.8 5552.5 5557.2 5559.9 5611.1 5725.1 5840.3 5842.7 5847.2 5896.6 5453.1 5571.6 5573.4 5715.6 5731.4 07:09:54 INFO - 2015-11-26 07:09:54,655 DEBUG : BROWSER_OUTPUT: 07:09:54 INFO - 2015-11-26 07:09:54,655 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50422.29 Median:18379.10 stddev:89877.26 (489.0%) stddev-sans-first:90051.46 07:09:54 INFO - 2015-11-26 07:09:54,655 DEBUG : BROWSER_OUTPUT: Values: 573.9 599.2 606.2 625.1 628.8 31791.7 32401.0 32418.8 40069.0 40537.8 43241.5 43829.0 43996.1 43996.6 44080.8 7685.5 8813.4 8980.0 8986.0 8988.1 7774.9 10552.6 10804.9 10817.1 10828.4 10520.9 10633.5 10633.7 10639.3 10640.5 7847.9 7997.9 10542.3 10657.7 10672.3 10357.2 10504.7 10521.1 10536.8 10540.5 40051.0 40196.4 40449.8 40531.8 40543.8 3305.1 3330.9 3337.7 3375.0 3426.1 29303.3 29715.3 29949.4 30119.5 30871.0 3954.1 4067.0 4110.7 4115.2 4149.8 274384.0 275664.0 276350.0 276822.0 277024.0 54031.5 55787.4 61539.4 61863.4 62184.7 72530.6 73374.6 73744.6 73948.3 74056.0 14884.9 14946.9 15064.3 15065.2 15076.4 11544.4 11656.5 11658.5 11670.1 11670.9 20111.6 20270.5 20281.6 20294.0 20365.3 7889.1 8239.2 8309.3 8377.9 8453.7 941.7 987.9 994.4 996.6 1056.7 28089.6 28107.4 28434.9 28449.3 28469.0 1026.5 1073.7 1092.8 1156.8 1156.8 14541.5 14589.1 14665.4 14946.4 14983.6 312744.0 316219.0 316458.0 316536.0 316726.0 50817.2 50838.2 51387.2 51432.2 51442.7 1291.7 1295.7 1341.0 1366.6 1370.2 26858.7 27709.7 28041.9 28091.6 28151.7 41500.6 42445.4 42530.4 45579.5 45902.0 406846.0 416556.0 419399.0 420759.0 421438.0 32027.8 32469.2 32479.0 32590.3 32630.3 42206.0 43011.0 43074.8 43537.0 43816.0 36375.8 36500.5 36668.3 36777.4 37747.2 36210.8 36262.5 36620.6 37215.4 37269.0 35335.6 36062.5 36078.0 36379.3 36395.6 31287.7 31464.4 33420.5 33452.8 33479.8 24209.8 24617.3 24653.5 24918.9 25021.1 07:09:54 INFO - 2015-11-26 07:09:54,656 DEBUG : BROWSER_OUTPUT: 07:09:54 INFO - 2015-11-26 07:09:54,656 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29472.87 Median:18011.33 stddev:91320.43 (507.0%) stddev-sans-first:91550.43 07:09:54 INFO - 2015-11-26 07:09:54,656 DEBUG : BROWSER_OUTPUT: Values: 352.3 352.6 356.8 357.9 359.3 14398.3 14438.7 16770.8 17461.4 18419.8 15455.3 16194.9 16237.4 16249.5 16302.8 5306.3 5403.1 5426.1 5445.7 5456.8 3991.0 4133.3 5372.1 5372.7 5792.6 5852.1 5889.7 5918.7 5922.5 5929.1 5486.2 5486.6 5490.6 5494.3 5849.7 5160.4 5270.7 5275.2 5279.1 5279.6 20156.3 20745.6 20746.7 20936.5 21429.1 2156.7 2266.1 2438.5 2620.1 2696.2 13181.5 13207.7 13393.1 13472.9 13821.2 1768.4 1856.9 1864.9 1896.1 1898.1 57595.7 60082.7 60145.4 60639.4 61271.4 9636.3 9793.7 9969.9 9999.5 10047.1 13015.5 13030.2 13040.2 13047.0 13048.9 7507.2 7543.9 7546.8 7658.2 7862.2 7160.0 7178.1 7220.1 7221.4 7229.6 5973.7 6067.8 6088.5 6096.6 6108.8 1646.8 1700.0 1744.2 1769.8 1801.5 426.9 432.3 913.3 1023.2 1043.2 10145.8 10425.5 10739.6 10912.3 11169.4 446.2 902.5 994.3 1015.2 1028.9 9465.7 9750.2 9776.5 9788.9 9966.4 540292.0 551497.0 558659.0 571157.0 572326.0 80207.2 81570.0 82308.6 83698.0 83851.6 1144.2 1161.7 1164.2 1167.0 1191.6 15674.5 15734.8 15833.4 15909.4 16024.8 34511.5 35665.8 35865.6 35901.8 35946.5 46621.8 46688.0 47325.8 49880.0 50175.7 9586.2 9633.4 9944.7 9953.2 9966.9 17466.2 17571.2 17890.7 18034.5 18090.6 13751.7 14329.5 14635.6 14778.3 14784.2 14040.5 14124.8 14321.2 14611.1 14734.7 12012.3 12140.9 13343.6 14673.4 14825.3 9783.5 9851.6 9864.1 10007.4 10009.8 10318.6 12223.6 14938.6 15052.1 15268.7 07:09:54 INFO - 2015-11-26 07:09:54,656 DEBUG : BROWSER_OUTPUT: 07:09:54 INFO - 2015-11-26 07:09:54,656 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5229.21 Median:5732.24 stddev:2703.23 (47.2%) stddev-sans-first:2694.54 07:09:54 INFO - 2015-11-26 07:09:54,656 DEBUG : BROWSER_OUTPUT: Values: 1283.1 1441.1 1455.7 1641.6 1711.2 6100.0 7300.6 7478.4 7500.0 7513.9 7357.0 7477.6 7534.8 7535.5 7544.1 1881.9 1916.5 2189.3 2214.8 2222.0 2206.6 2219.2 2226.3 2233.0 2241.4 2210.9 2260.3 2263.0 2263.9 2267.1 1885.2 1909.9 2109.5 2154.3 2155.2 2114.2 2132.4 2143.3 2143.4 2149.0 7407.3 7466.0 7466.9 7470.1 7493.2 4562.5 4638.5 4648.7 4657.0 4657.8 2958.8 2991.2 3039.1 3048.7 3098.6 1020.6 1035.2 1049.3 1064.5 1084.5 10199.3 10204.2 10217.5 10236.9 10237.8 4179.7 4252.6 4299.6 4308.8 4334.0 8712.3 8724.6 8758.3 8760.6 8775.3 4698.1 4701.7 4701.8 4703.3 4747.3 4216.5 4222.2 4230.1 4231.9 4234.0 3459.9 3499.5 3516.6 3552.8 3563.4 1191.5 1199.3 1207.4 1211.1 1214.4 1303.1 1310.8 1319.4 1336.1 1347.6 6847.9 6978.4 6984.3 6986.7 7016.9 434.5 443.1 443.5 446.0 447.3 5104.3 5146.9 5168.3 5178.0 5178.5 8758.2 8761.2 8783.4 8854.7 8950.7 8662.7 8736.5 8753.6 8775.0 8784.0 6790.9 6939.8 6997.4 7060.9 7088.9 7064.6 7097.0 7113.8 7126.9 7129.9 7716.3 7982.4 7985.6 7999.1 8038.1 8017.2 8183.1 8246.4 8345.1 8361.7 5673.9 5840.5 6674.7 6711.5 6720.6 7204.8 7224.3 7234.7 7235.6 7257.9 5790.6 6598.0 6791.7 6840.6 6895.2 6294.2 6793.6 6800.4 6898.5 6946.2 6891.1 6949.5 6971.2 6987.4 6989.3 6298.4 6343.2 6347.6 6358.7 6361.3 6142.8 6372.4 6416.8 6425.0 6499.3 07:09:54 INFO - 2015-11-26 07:09:54,656 DEBUG : BROWSER_OUTPUT: 07:09:54 INFO - 2015-11-26 07:09:54,657 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5337.85 Median:6102.18 stddev:1627.54 (26.7%) stddev-sans-first:1587.82 07:09:54 INFO - 2015-11-26 07:09:54,658 DEBUG : BROWSER_OUTPUT: Values: 313.9 317.9 322.4 338.6 340.1 6019.2 6034.3 6037.5 6056.8 6064.9 5684.4 5781.2 5844.7 5976.2 5994.0 4578.9 4587.5 4602.4 4609.5 4611.8 4435.8 4623.8 4624.4 4625.8 4628.6 4467.0 4508.0 4590.9 4603.1 4604.9 4572.6 4581.2 4584.7 4585.5 4600.0 4046.9 4047.8 4052.9 4058.3 4068.7 5582.0 5698.1 5705.2 5715.2 5717.9 5294.0 5295.9 5305.5 5305.7 5306.6 6355.8 6361.4 6381.0 6395.7 6396.7 4345.2 4354.6 4354.7 4355.2 4355.7 6491.3 6558.3 6600.9 6627.1 6640.4 4360.2 4401.4 4415.3 4426.2 4426.6 4446.8 4457.4 4457.7 4460.8 4466.6 5223.3 5225.9 5228.8 5239.4 5240.1 6199.4 6298.5 6336.4 6380.2 6406.3 1579.2 1587.9 1589.4 1590.8 1592.1 1021.8 1041.4 1059.0 1060.5 1094.6 6163.8 6166.3 6175.7 6196.7 6204.4 6355.7 6570.0 6573.7 6577.1 6592.3 6074.3 6130.1 6166.3 6226.1 6237.3 3538.2 3583.8 3588.2 3592.9 3593.7 6636.3 6764.7 6772.5 6778.7 6798.6 6800.2 6805.4 6810.5 6817.9 6826.5 6899.8 6900.8 6906.9 6914.4 6922.8 6533.9 6596.4 6620.5 6632.6 6639.0 6570.1 6573.4 6573.8 6575.7 6579.3 6847.5 6882.7 6887.0 6889.1 6892.7 4508.6 4512.6 4513.0 4515.2 4517.4 6442.6 6587.4 6608.0 6647.8 6693.8 6479.8 6482.7 6495.7 6497.7 6510.6 6315.3 6463.7 6469.2 6479.6 6487.1 6348.8 6357.9 6358.9 6363.5 6370.0 6465.9 6470.5 6472.3 6474.5 6476.6 6210.2 6338.4 6354.2 6360.5 6364.9 07:09:54 INFO - 2015-11-26 07:09:54,658 DEBUG : BROWSER_OUTPUT: 07:09:54 INFO - 2015-11-26 07:09:54,658 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13755.93 Median:25080.26 stddev:15858.50 (63.2%) stddev-sans-first:15872.71 07:09:54 INFO - 2015-11-26 07:09:54,658 DEBUG : BROWSER_OUTPUT: Values: 706.6 762.8 764.1 859.4 902.5 13354.3 13361.3 13710.9 13718.1 13753.1 13068.9 13135.5 13228.0 13231.5 13243.3 686.0 820.8 841.6 841.9 842.4 689.2 824.4 841.4 841.7 841.7 864.9 880.8 882.3 882.5 882.9 714.9 721.6 853.6 867.5 868.5 640.7 641.4 642.1 642.4 644.8 13560.7 13772.2 13846.2 13882.9 13927.4 11443.5 11601.8 11807.8 11813.7 11815.8 10290.6 10321.4 10459.8 10485.8 10505.2 3496.2 3513.8 3539.1 3545.2 3629.8 45664.0 45820.3 46258.0 46532.0 47096.0 10352.7 10525.2 10550.8 10583.7 11017.5 18945.1 18945.7 18960.5 19023.3 19034.1 7467.1 7526.1 7655.4 7664.2 7796.0 4378.6 4381.5 4389.7 4421.6 4496.5 2949.5 2991.6 2997.7 3003.5 3004.9 525.9 529.2 532.2 534.5 545.9 638.8 664.8 671.7 684.9 722.4 7814.8 7865.1 8001.9 8018.0 8168.9 550.5 560.8 561.6 624.1 651.6 3793.9 3921.2 3930.4 4075.9 4143.4 54871.7 56088.2 56881.1 57207.4 57393.0 50436.7 51059.5 51858.2 52007.7 53287.2 45757.8 46314.0 46805.5 47369.5 47723.0 8180.8 8360.5 8485.1 8495.3 8736.3 33882.8 34722.3 34789.1 35389.6 35652.6 42301.4 43325.0 46633.0 46663.9 46742.3 10877.8 11100.7 11212.1 11223.1 11479.2 11875.5 11988.7 12014.0 12649.8 12688.1 10775.4 10926.0 10984.2 11006.2 11279.4 11535.3 11724.1 11827.8 12194.3 12207.1 10199.0 10471.6 10494.7 10814.5 11071.8 9750.6 10038.9 10061.3 10209.6 10322.6 9059.5 9080.2 9102.0 9125.8 9349.3 07:09:54 INFO - 2015-11-26 07:09:54,658 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:09:54 INFO - 2015-11-26 07:09:54,658 DEBUG : BROWSER_OUTPUT: 07:09:55 INFO - 2015-11-26 07:09:55,393 INFO : Browser exited with error code: 0 07:09:55 INFO - 2015-11-26 07:09:55,414 INFO : Completed test dromaeo_css (00:18:33) 07:09:55 INFO - 2015-11-26 07:09:55,414 INFO : Starting test kraken 07:09:55 INFO - 2015-11-26 07:09:55,414 DEBUG : operating with platform_type : linux_ 07:09:55 INFO - 2015-11-26 07:09:55,414 INFO : Initialising browser for kraken test... 07:09:55 INFO - 2015-11-26 07:09:55,420 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCxdu3p/profile http://localhost:43842/getInfo.html 07:09:59 INFO - 2015-11-26 07:09:59,335 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:09:59 INFO - 2015-11-26 07:09:59,336 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:09:59 INFO - 2015-11-26 07:09:59,336 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:09:59 INFO - 2015-11-26 07:09:59,336 DEBUG : BROWSER_OUTPUT: __metrics 07:09:59 INFO - 2015-11-26 07:09:59,432 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:10:00 INFO - 2015-11-26 07:10:00,840 INFO : Browser initialized. 07:10:00 INFO - 2015-11-26 07:10:00,841 INFO : Running cycle 1/1 for kraken test... 07:10:00 INFO - 2015-11-26 07:10:00,841 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCxdu3p/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:10:12 INFO - 2015-11-26 07:10:12,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 139419648 07:10:12 INFO - 2015-11-26 07:10:12,553 DEBUG : BROWSER_OUTPUT: 07:10:15 INFO - 2015-11-26 07:10:15,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43842/tests/kraken/driver.html?testName=audio-beat-detection) 07:10:15 INFO - 2015-11-26 07:10:15,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 175185920 07:10:15 INFO - 2015-11-26 07:10:15,583 DEBUG : BROWSER_OUTPUT: 07:10:18 INFO - 2015-11-26 07:10:18,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43842/tests/kraken/driver.html?testName=audio-dft) 07:10:18 INFO - 2015-11-26 07:10:18,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 165834752 07:10:18 INFO - 2015-11-26 07:10:18,758 DEBUG : BROWSER_OUTPUT: 07:10:21 INFO - 2015-11-26 07:10:21,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43842/tests/kraken/driver.html?testName=audio-fft) 07:10:22 INFO - 2015-11-26 07:10:22,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 150056960 07:10:22 INFO - 2015-11-26 07:10:22,204 DEBUG : BROWSER_OUTPUT: 07:10:24 INFO - 2015-11-26 07:10:24,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43842/tests/kraken/driver.html?testName=audio-oscillator) 07:10:24 INFO - 2015-11-26 07:10:24,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 152035328 07:10:24 INFO - 2015-11-26 07:10:24,725 DEBUG : BROWSER_OUTPUT: 07:10:26 INFO - 2015-11-26 07:10:26,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43842/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:10:27 INFO - 2015-11-26 07:10:27,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 153894912 07:10:27 INFO - 2015-11-26 07:10:27,480 DEBUG : BROWSER_OUTPUT: 07:10:30 INFO - 2015-11-26 07:10:30,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43842/tests/kraken/driver.html?testName=imaging-darkroom) 07:10:31 INFO - 2015-11-26 07:10:31,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 154169344 07:10:31 INFO - 2015-11-26 07:10:31,000 DEBUG : BROWSER_OUTPUT: 07:10:34 INFO - 2015-11-26 07:10:34,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43842/tests/kraken/driver.html?testName=imaging-desaturate) 07:10:34 INFO - 2015-11-26 07:10:34,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 157114368 07:10:35 INFO - 2015-11-26 07:10:34,999 DEBUG : BROWSER_OUTPUT: 07:10:37 INFO - 2015-11-26 07:10:37,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43842/tests/kraken/driver.html?testName=json-parse-financial) 07:10:38 INFO - 2015-11-26 07:10:38,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 156925952 07:10:38 INFO - 2015-11-26 07:10:38,298 DEBUG : BROWSER_OUTPUT: 07:10:39 INFO - 2015-11-26 07:10:39,867 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43842/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:10:40 INFO - 2015-11-26 07:10:40,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 167555072 07:10:40 INFO - 2015-11-26 07:10:40,427 DEBUG : BROWSER_OUTPUT: 07:10:42 INFO - 2015-11-26 07:10:42,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43842/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:10:42 INFO - 2015-11-26 07:10:42,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 165908480 07:10:42 INFO - 2015-11-26 07:10:42,832 DEBUG : BROWSER_OUTPUT: 07:10:44 INFO - 2015-11-26 07:10:44,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43842/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:10:45 INFO - 2015-11-26 07:10:45,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 172400640 07:10:45 INFO - 2015-11-26 07:10:45,454 DEBUG : BROWSER_OUTPUT: 07:10:47 INFO - 2015-11-26 07:10:47,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:10:48 INFO - 2015-11-26 07:10:48,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 182624256 07:10:48 INFO - 2015-11-26 07:10:48,461 DEBUG : BROWSER_OUTPUT: 07:10:51 INFO - 2015-11-26 07:10:51,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:51 INFO - 2015-11-26 07:10:51,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 180232192 07:10:51 INFO - 2015-11-26 07:10:51,602 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43842/tests/kraken/driver.html?testName=ai-astar) 07:10:53 INFO - 2015-11-26 07:10:53,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 238473216 07:10:53 INFO - 2015-11-26 07:10:53,506 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,507 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:10:53 INFO - 2015-11-26 07:10:53,508 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:10:53 INFO - 2015-11-26 07:10:53,508 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:10:53 INFO - 2015-11-26 07:10:53,508 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:10:53 INFO - 2015-11-26 07:10:53,508 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;111;104;109;110;109;100;110;109;102 07:10:53 INFO - 2015-11-26 07:10:53,508 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;123;150;163;131;156;147;134;179;132 07:10:53 INFO - 2015-11-26 07:10:53,509 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;161;159;161;160;160;161;162;162 07:10:53 INFO - 2015-11-26 07:10:53,509 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;86;92;72;72;72;106;92;73 07:10:53 INFO - 2015-11-26 07:10:53,509 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;134;93;94;92;133;93;93;141 07:10:53 INFO - 2015-11-26 07:10:53,509 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;110;109;109;109 07:10:53 INFO - 2015-11-26 07:10:53,509 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;147;147;144;145;146;145;145 07:10:53 INFO - 2015-11-26 07:10:53,510 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;97;97;96;95;96;96 07:10:53 INFO - 2015-11-26 07:10:53,510 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;57;56;58;57;63;58;58;56 07:10:53 INFO - 2015-11-26 07:10:53,510 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;70;70;70;70;70;70;70;70 07:10:53 INFO - 2015-11-26 07:10:53,510 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;85;86;85;85;87;84;83;85;85 07:10:53 INFO - 2015-11-26 07:10:53,510 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;129;121;114;122;127;124;132;116;123 07:10:53 INFO - 2015-11-26 07:10:53,510 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;147;150;150;149;137;149;161;150;141 07:10:53 INFO - 2015-11-26 07:10:53,510 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;65;66;67;66;64;67;67;67;67 07:10:53 INFO - 2015-11-26 07:10:53,510 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:10:53 INFO - 2015-11-26 07:10:53,511 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:10:53 INFO - 2015-11-26 07:10:53,511 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,900 07:10:53 INFO - 2015-11-26 07:10:53,511 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:10:53 INFO - 2015-11-26 07:10:53,511 DEBUG : BROWSER_OUTPUT: __startTimestamp1448550653506__endTimestamp 07:10:53 INFO - 2015-11-26 07:10:53,511 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,514 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.10 Median:109.00 stddev:3.78 (3.5%) stddev-sans-first:4.01 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: Values: 107.0 111.0 104.0 109.0 110.0 109.0 100.0 110.0 109.0 102.0 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.10 Median:148.50 stddev:16.96 (11.4%) stddev-sans-first:17.99 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: Values: 146.0 123.0 150.0 163.0 131.0 156.0 147.0 134.0 179.0 132.0 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.20 (0.7%) stddev-sans-first:1.05 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 161.0 159.0 161.0 160.0 160.0 161.0 162.0 162.0 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:72.50 stddev:12.38 (17.1%) stddev-sans-first:12.61 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 86.0 92.0 72.0 72.0 72.0 106.0 92.0 73.0 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,515 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:93.00 stddev:20.81 (22.4%) stddev-sans-first:21.62 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 134.0 93.0 94.0 92.0 133.0 93.0 93.0 141.0 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 147.0 147.0 144.0 145.0 146.0 145.0 145.0 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 97.0 97.0 96.0 95.0 96.0 96.0 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:2.00 (3.4%) stddev-sans-first:2.09 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 57.0 56.0 58.0 57.0 63.0 58.0 58.0 56.0 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.32 (0.5%) stddev-sans-first:0.00 07:10:53 INFO - 2015-11-26 07:10:53,516 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 70.0 70.0 70.0 70.0 70.0 70.0 70.0 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:1.90 (2.2%) stddev-sans-first:1.12 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: Values: 90.0 85.0 86.0 85.0 85.0 87.0 84.0 83.0 85.0 85.0 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:123.50 stddev:5.70 (4.6%) stddev-sans-first:5.80 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: Values: 118.0 129.0 121.0 114.0 122.0 127.0 124.0 132.0 116.0 123.0 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:149.50 stddev:6.79 (4.5%) stddev-sans-first:6.65 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: Values: 140.0 147.0 150.0 150.0 149.0 137.0 149.0 161.0 150.0 141.0 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:1.09 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: Values: 67.0 65.0 66.0 67.0 66.0 64.0 67.0 67.0 67.0 67.0 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:10:53 INFO - 2015-11-26 07:10:53,517 DEBUG : BROWSER_OUTPUT: 07:10:54 INFO - 2015-11-26 07:10:54,313 INFO : Browser exited with error code: 0 07:10:54 INFO - 2015-11-26 07:10:54,366 INFO : Completed test kraken (00:00:58) 07:10:54 INFO - 2015-11-26 07:10:54,366 INFO : Starting test v8_7 07:10:54 INFO - 2015-11-26 07:10:54,366 DEBUG : operating with platform_type : linux_ 07:10:54 INFO - 2015-11-26 07:10:54,366 INFO : Initialising browser for v8_7 test... 07:10:54 INFO - 2015-11-26 07:10:54,372 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphGTCbJ/profile http://localhost:43842/getInfo.html 07:10:58 INFO - 2015-11-26 07:10:58,393 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:10:58 INFO - 2015-11-26 07:10:58,393 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:10:58 INFO - 2015-11-26 07:10:58,393 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:10:58 INFO - 2015-11-26 07:10:58,393 DEBUG : BROWSER_OUTPUT: __metrics 07:10:58 INFO - 2015-11-26 07:10:58,494 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:10:59 INFO - 2015-11-26 07:10:59,993 INFO : Browser initialized. 07:10:59 INFO - 2015-11-26 07:10:59,993 INFO : Running cycle 1/1 for v8_7 test... 07:10:59 INFO - 2015-11-26 07:10:59,993 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphGTCbJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:11:11 INFO - 2015-11-26 07:11:11,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 139329536 07:11:11 INFO - 2015-11-26 07:11:11,709 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43842/tests/v8_7/run.html (next: http://localhost:43842/tests/v8_7/run.html) 07:11:33 INFO - 2015-11-26 07:11:33,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 609677312 07:11:33 INFO - 2015-11-26 07:11:33,441 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,442 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:11:33 INFO - 2015-11-26 07:11:33,442 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:11:33 INFO - 2015-11-26 07:11:33,442 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:11:33 INFO - 2015-11-26 07:11:33,442 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:11:33 INFO - 2015-11-26 07:11:33,442 DEBUG : BROWSER_OUTPUT: |0;Richards;165.26194017517767 07:11:33 INFO - 2015-11-26 07:11:33,442 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.81784531463083 07:11:33 INFO - 2015-11-26 07:11:33,442 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.56569652444193 07:11:33 INFO - 2015-11-26 07:11:33,443 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 07:11:33 INFO - 2015-11-26 07:11:33,443 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1077.5862068965516 07:11:33 INFO - 2015-11-26 07:11:33,443 DEBUG : BROWSER_OUTPUT: |5;Earley;771.604938271605 07:11:33 INFO - 2015-11-26 07:11:33,443 DEBUG : BROWSER_OUTPUT: |6;Boyer;11894.117647058823 07:11:33 INFO - 2015-11-26 07:11:33,443 DEBUG : BROWSER_OUTPUT: |7;RegExp;25897.4358974359 07:11:33 INFO - 2015-11-26 07:11:33,443 DEBUG : BROWSER_OUTPUT: |8;Splay;657.5342465753424 07:11:33 INFO - 2015-11-26 07:11:33,444 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 07:11:33 INFO - 2015-11-26 07:11:33,444 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:11:33 INFO - 2015-11-26 07:11:33,444 DEBUG : BROWSER_OUTPUT: __startTimestamp1448550693439__endTimestamp 07:11:33 INFO - 2015-11-26 07:11:33,444 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,444 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:11:33 INFO - 2015-11-26 07:11:33,444 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:11:33 INFO - 2015-11-26 07:11:33,445 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,445 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.26 Median:165.26 stddev:0.00 (0.0%) 07:11:33 INFO - 2015-11-26 07:11:33,445 DEBUG : BROWSER_OUTPUT: Values: 165.3 07:11:33 INFO - 2015-11-26 07:11:33,445 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,445 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.82 Median:194.82 stddev:0.00 (0.0%) 07:11:33 INFO - 2015-11-26 07:11:33,445 DEBUG : BROWSER_OUTPUT: Values: 194.8 07:11:33 INFO - 2015-11-26 07:11:33,446 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,446 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.57 Median:282.57 stddev:0.00 (0.0%) 07:11:33 INFO - 2015-11-26 07:11:33,446 DEBUG : BROWSER_OUTPUT: Values: 282.6 07:11:33 INFO - 2015-11-26 07:11:33,446 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,446 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 07:11:33 INFO - 2015-11-26 07:11:33,447 DEBUG : BROWSER_OUTPUT: Values: 5191.7 07:11:33 INFO - 2015-11-26 07:11:33,447 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,447 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1077.59 Median:1077.59 stddev:0.00 (0.0%) 07:11:33 INFO - 2015-11-26 07:11:33,448 DEBUG : BROWSER_OUTPUT: Values: 1077.6 07:11:33 INFO - 2015-11-26 07:11:33,448 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,449 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:771.60 Median:771.60 stddev:0.00 (0.0%) 07:11:33 INFO - 2015-11-26 07:11:33,449 DEBUG : BROWSER_OUTPUT: Values: 771.6 07:11:33 INFO - 2015-11-26 07:11:33,449 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,449 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11894.12 Median:11894.12 stddev:0.00 (0.0%) 07:11:33 INFO - 2015-11-26 07:11:33,450 DEBUG : BROWSER_OUTPUT: Values: 11894.1 07:11:33 INFO - 2015-11-26 07:11:33,450 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,450 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25897.44 Median:25897.44 stddev:0.00 (0.0%) 07:11:33 INFO - 2015-11-26 07:11:33,450 DEBUG : BROWSER_OUTPUT: Values: 25897.4 07:11:33 INFO - 2015-11-26 07:11:33,450 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,450 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:657.53 Median:657.53 stddev:0.00 (0.0%) 07:11:33 INFO - 2015-11-26 07:11:33,450 DEBUG : BROWSER_OUTPUT: Values: 657.5 07:11:33 INFO - 2015-11-26 07:11:33,450 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-26 07:11:33,450 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:11:33 INFO - 2015-11-26 07:11:33,450 DEBUG : BROWSER_OUTPUT: Values: 4830.9 07:11:33 INFO - 2015-11-26 07:11:33,450 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:11:33 INFO - 2015-11-26 07:11:33,450 DEBUG : BROWSER_OUTPUT: 07:11:34 INFO - 2015-11-26 07:11:34,257 INFO : Browser exited with error code: 0 07:11:34 INFO - 2015-11-26 07:11:34,269 INFO : Completed test v8_7 (00:00:39) 07:11:34 INFO - 2015-11-26 07:11:34,384 INFO : Completed test suite (00:20:12) 07:11:34 INFO - 2015-11-26 07:11:34,385 DEBUG : Working with test: dromaeo_css 07:11:34 INFO - 2015-11-26 07:11:34,385 DEBUG : Generating results file: dromaeo_css 07:11:34 INFO - 2015-11-26 07:11:34,386 DEBUG : Working with test: kraken 07:11:34 INFO - 2015-11-26 07:11:34,386 DEBUG : Generating results file: kraken 07:11:34 INFO - 2015-11-26 07:11:34,386 INFO : javascript benchmark 07:11:34 INFO - 2015-11-26 07:11:34,387 DEBUG : Working with test: v8_7 07:11:34 INFO - 2015-11-26 07:11:34,387 DEBUG : Generating results file: v8_7 07:11:34 INFO - 2015-11-26 07:11:34,387 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:34 INFO - 2015-11-26 07:11:34,454 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 07:11:34 INFO - 2015-11-26 07:11:34,454 DEBUG : process_Request line: dromaeo_css 7006.07 graph.html#tests=[[72,64,35]] 07:11:34 INFO - 2015-11-26 07:11:34,454 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:34 INFO - 2015-11-26 07:11:34,585 DEBUG : process_Request line: kraken 1501.40 graph.html#tests=[[232,64,35]] 07:11:34 INFO - 2015-11-26 07:11:34,585 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:34 INFO - 2015-11-26 07:11:34,713 DEBUG : process_Request line: v8_7 20941.36 graph.html#tests=[[230,64,35]] 07:11:34 INFO - 2015-11-26 07:11:34,715 INFO : javascript benchmark 07:11:34 INFO - 2015-11-26 07:11:34,718 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3184.554162417261, 3208.7753857230005, 3272.2146684795644, 3273.4762438009925, 3297.5383446317514, 5248.134057880445, 5393.81121660742, 5420.457954204582, 5437.211604317376, 5466.0, 5362.0, 5382.703951282678, 5425.3760817506, 5428.077226871432, 5521.889562208764, 4935.111679897626, 4977.751112444382, 4982.377202849644, 5002.374703162105, 5028.120078986181, 4857.149998750222, 5065.0, 5073.162928116856, 5101.311322971388, 5112.539871411572, 4898.853034408973, 4948.604111671058, 4991.925121123186, 5014.473480284554, 5030.748462576893, 4955.405351357824, 4964.751762411865, 4968.1554135797005, 4970.701757894538, 5015.623828212899, 4742.810287588527, 4971.304017437562, 4975.203967365204, 4986.401631804207, 5039.496050394931, 5184.948150518522, 5200.947990520122, 5265.0259701955265, 5287.259783630295, 5316.0165369406395, 5929.762809487615, 5930.347661757203, 5932.495737862287, 5937.079752638348, 5975.671338076404, 5706.828795136153, 5819.912701309484, 5954.315253745832, 5962.791302304442, 5963.821085367446, 5438.184272359138, 5441.673499590037, 5554.694491802949, 5557.972210139004, 5575.219469274305, 6031.517478601701, 6038.064100064497, 6042.123892035718, 6060.454559089703, 6088.330283668793, 5735.340435849847, 5815.505682016991, 5818.854528636818, 5822.970885145632, 5827.155062515912, 5656.264685590929, 5751.079827227623, 5764.221830052973, 5765.077587585966, 5910.674912879746, 5857.238558987305, 5922.111683247547, 5934.37689042653, 5943.58394912352, 5944.078667806497, 5937.851553711192, 5940.435658612425, 5944.256967879015, 5947.107933809876, 5948.762049517971, 4381.2332841753205, 4457.086297309044, 4516.8193272268745, 4555.908881822411, 4561.543845615478, 4019.33680942647, 4051.6353528182603, 4056.411820286042, 4068.633822955889, 4094.447249621263, 5506.256655351476, 5515.310586176728, 5516.448355164532, 5567.081431563746, 5606.495415412633, 5772.538196944234, 5806.709664516758, 5928.140419639214, 5965.940340596625, 5971.044632858809, 5567.498925096761, 5574.554035677136, 5593.300837395325, 5602.243697100839, 5604.859878502988, 5109.463506331856, 5128.3333166688835, 5128.8717782055, 5139.152039913372, 5184.922226166611, 5902.586818922634, 5984.670843103671, 6015.187949626832, 6017.428344307284, 6143.600665956698, 5956.880862382642, 5980.700964951822, 6050.031994880974, 6056.757729690763, 6056.939430605814, 6127.724252408741, 6176.289726681489, 6184.319724830355, 6192.071189321638, 6194.5044396449075, 5693.459121383462, 5776.104703770922, 5939.881202376015, 5942.970285148546, 5952.285725712942, 5876.882462350814, 5878.706064696663, 5961.761529538943, 5966.105084237225, 5983.850403739942, 5744.253247077853, 5747.109198074305, 5748.281464816898, 5749.798757043651, 5763.913541296968, 5660.632058916157, 5664.405237450009, 5714.714264286686, 5726.570507211893, 5750.281214848144, 5487.780488780404, 5552.472515111058, 5557.221988921635, 5559.944400555943, 5611.074172761612, 5725.141228815544, 5840.328362238397, 5842.678652674143, 5847.239858818326, 5896.587238893237, 5453.072977593739, 5571.582131340085, 5573.3869274380595, 5715.628484148517, 5731.426857314235], "unit": "ms", "name": "dojo.html", "value": 5420.136004664565}, {"lowerIsBetter": false, "replicates": [573.9196512488253, 599.2120361724329, 606.1998162425599, 625.0655270370795, 628.783069840905, 31791.682083179163, 32401.0, 32418.837905810466, 40069.0, 40537.79731101348, 43241.459646737036, 43829.0, 43996.120077598505, 43996.56003439965, 44080.77959610197, 7685.462017658766, 8813.427127236726, 8979.95510022449, 8986.0, 8988.056254093324, 7774.922250777505, 10552.577896884115, 10804.945975270113, 10817.134629229682, 10828.40443775592, 10520.894791052106, 10633.46832658368, 10633.680989570325, 10639.308444951092, 10640.467976601178, 7847.882281765721, 7997.920020799776, 10542.314749541294, 10657.680269591885, 10672.30630009047, 10357.171426285879, 10504.737381565446, 10521.05310522049, 10536.841947370796, 10540.525676344583, 40051.0, 40196.39705404421, 40449.79775101106, 40531.7973410134, 40543.7972810137, 3305.140663427502, 3330.8667653293837, 3337.6996070353543, 3375.0, 3426.1434641339665, 29303.2674183145, 29715.257118571993, 29949.401011979855, 30119.548206776915, 30871.0, 3954.1498577805623, 4066.959330406717, 4110.712250142491, 4115.238680844023, 4149.771762553059, 274384.0, 275664.0, 276350.0, 276822.0, 277024.0, 54031.459685402646, 55787.44212557904, 61539.384606154264, 61863.38136618666, 62184.68907655523, 72530.63734681293, 73374.63312683509, 73744.63127684327, 73948.26051739522, 74056.0, 14884.925575372054, 14946.850531494545, 15064.322105505278, 15065.246737663074, 15076.39694412233, 11544.365059921785, 11656.475458604384, 11658.533658653729, 11670.124740644485, 11670.883291167149, 20111.59776804485, 20270.493237669176, 20281.594368112852, 20294.0, 20365.268952139235, 7889.132195458495, 8239.217274358927, 8309.252167304972, 8377.874331885027, 8453.66185352579, 941.7174847545846, 987.9407235565889, 994.3685759542598, 996.6113215845826, 1056.6935588679196, 28089.578656320173, 28107.43785124327, 28434.85782571115, 28449.288767780556, 28469.0, 1026.4662375564665, 1073.7315671082229, 1092.7705181911729, 1156.8091264941359, 1156.8482622322474, 14541.491047813275, 14589.124652520883, 14665.413383464755, 14946.402143914122, 14983.550493485212, 312744.0, 316219.0, 316458.0, 316536.0, 316726.0, 50817.237741433906, 50838.23742643863, 51387.22919156215, 51432.22851657228, 51442.74278628658, 1291.7158225190442, 1295.7084655952524, 1340.9932950335185, 1366.6241783509415, 1370.2463644995212, 26858.73141268562, 27709.722902771522, 28041.859790700917, 28091.578626320214, 28151.71848281491, 41500.58499414967, 42445.36331955085, 42530.36204456998, 45579.54420455753, 45902.0, 406846.0, 416556.0, 419399.0, 420759.0, 421438.0, 32027.83986080055, 32469.18827029343, 32479.0, 32590.34819303648, 32630.347393051532, 42206.0, 43011.0, 43074.78462607667, 43537.0, 43816.0, 36375.81812090923, 36500.45249321315, 36668.26663466769, 36777.448338274415, 37747.245055099294, 36210.84493299095, 36262.4560631596, 36620.63379366172, 37215.441768372955, 37269.0, 35335.64664353323, 36062.4590631146, 36078.0, 36379.27241455103, 36395.63604363923, 31287.714789947637, 31464.426778660516, 33420.498692520116, 33452.832735836164, 33479.83260083781, 24209.757902421454, 24617.261482155565, 24653.50692986166, 24918.875405622857, 25021.12426065079], "unit": "ms", "name": "ext.html", "value": 19138.309747967407}, {"lowerIsBetter": false, "replicates": [352.2918932944781, 352.6050823078153, 356.8447725239521, 357.874743839656, 359.29040145712236, 14398.280085995711, 14438.711225775505, 16770.83229167708, 17461.388851390206, 18419.815801841978, 15455.30451129699, 16194.919025404886, 16237.431689890856, 16249.512514624581, 16302.755458668129, 5306.283651707018, 5403.054465468547, 5426.050441172799, 5445.727713614323, 5456.836294911159, 3990.9600903991022, 4133.297339452301, 5372.113601255788, 5372.677639341652, 5792.565557583177, 5852.092925596518, 5889.705514724246, 5918.704064796743, 5922.466977971982, 5929.0513517836935, 5486.177073438997, 5486.61593688442, 5490.588205884535, 5494.2582751328455, 5849.707514624273, 5160.354955630546, 5270.736463176826, 5275.235090911835, 5279.102552566073, 5279.604029697788, 20156.29452969139, 20745.58508829815, 20746.688799667867, 20936.47658808527, 21429.14283428661, 2156.6657168138963, 2266.05958527211, 2438.5244877248942, 2620.069875194317, 2696.191142657195, 13181.538646147435, 13207.66980825487, 13393.129446585941, 13472.865271347357, 13821.170729756246, 1768.4252617899235, 1856.9071546422624, 1864.888106713588, 1896.0709252466331, 1898.1173754204224, 57595.71202143963, 60082.69958650179, 60145.39854601398, 60639.393606063815, 61271.387286127014, 9636.325457218069, 9793.706188814347, 9969.900300997042, 9999.50002499872, 10047.145992590566, 13015.479380824661, 13030.218186908816, 13040.152390094614, 13047.0, 13048.869511304765, 7507.21174276704, 7543.886841697379, 7546.811329716801, 7658.157602663702, 7862.174471680506, 7159.96420017907, 7178.138623365229, 7220.061392019109, 7221.42228621709, 7229.566226026455, 5973.731182096816, 6067.817965461043, 6088.543359248074, 6096.634201947897, 6108.786192483241, 1646.761219623148, 1699.9660006799795, 1744.215103203538, 1769.8141695121826, 1801.4775715042754, 426.91888541177076, 432.3190974215623, 913.3195769151891, 1023.2019025160238, 1043.1900652368136, 10145.797084058277, 10425.478726063666, 10739.624113156158, 10912.290701104403, 11169.38568378747, 446.1656701967342, 902.5397047505688, 994.3487016004384, 1015.243643485608, 1028.876534815812, 9465.716028519155, 9750.171235444925, 9776.462294573725, 9788.902110978941, 9966.35218710796, 540292.0, 551497.0, 558659.0, 571157.0, 572326.0, 80207.19792802114, 81570.0, 82308.58845705733, 83698.0, 83851.5807420959, 1144.181909934401, 1161.6805378520974, 1164.2141554450711, 1167.0430247197387, 1191.606769765975, 15674.451394201149, 15734.76397854056, 15833.366665333719, 15909.363625454853, 16024.839751602334, 34511.4823277656, 35665.82167089252, 35865.641343587275, 35901.82049089738, 35946.46080308745, 46621.766891166684, 46688.0, 47325.763371182926, 49880.0, 50175.74912125416, 9586.233101352014, 9633.421994680342, 9944.701658949954, 9953.153981911619, 9966.900330996887, 17466.21402036886, 17571.209295581473, 17890.731639025165, 18034.549136271697, 18090.638187236444, 13751.656208594864, 14329.498467553585, 14635.560933172022, 14778.334974926369, 14784.186869722269, 14040.508582199574, 14124.78812817788, 14321.212333321351, 14611.123332600078, 14734.705305894036, 12012.339321337411, 12140.878591214328, 13343.599692009255, 14673.413063477341, 14825.25873706332, 9783.461909594756, 9851.556679949563, 9864.112229899343, 10007.39955602637, 10009.799804003733, 10318.587256509956, 12223.572174973833, 14938.626534336729, 15052.096874187584, 15268.694626107193], "unit": "ms", "name": "jquery.html", "value": 8917.90642465542}, {"lowerIsBetter": false, "replicates": [1283.0890068051694, 1441.0921119694585, 1455.7015811758583, 1641.6470458851345, 1711.2128420926374, 6100.0, 7300.561966282027, 7478.364339031182, 7499.962500187491, 7513.887291690629, 7357.0, 7477.5887326197035, 7534.849303013936, 7535.547867127976, 7544.132424771153, 1881.8870867747978, 1916.5017095555186, 2189.343197040889, 2214.7674494178123, 2221.9666704999436, 2206.6248737714627, 2219.1899956515836, 2226.3321003698907, 2232.955340893181, 2241.4396400899777, 2210.933671989843, 2260.3332017054927, 2263.0, 2263.8981245843893, 2267.1044937249776, 1885.161103309028, 1909.9140538675792, 2109.546447513784, 2154.256781410411, 2155.1918030738475, 2114.1860383752214, 2132.3709505695856, 2143.2605751015876, 2143.3677065265783, 2148.9785102148935, 7407.259274072603, 7465.962670186615, 7466.887996680054, 7470.103587569472, 7493.213212612652, 4562.4753153387455, 4638.489766125724, 4648.651351148644, 4657.04530571232, 4657.836975705834, 2958.837263950482, 2991.237234505209, 3039.149038269288, 3048.6951304869335, 3098.612673415823, 1020.5764607687801, 1035.2494441529907, 1049.3389164826187, 1064.4677661169414, 1084.4523515624637, 10199.337043092175, 10204.183665306758, 10217.540210690537, 10236.948815255875, 10237.795244095076, 4179.665626749853, 4252.638525725286, 4299.634531064832, 4308.784560772012, 4334.046509767846, 8712.346574006975, 8724.56377181151, 8758.343124265706, 8760.56197190138, 8775.297976161892, 4698.130845793539, 4701.694389864648, 4701.764911754399, 4703.270992996091, 4747.335373047776, 4216.51510076339, 4222.1766755483, 4230.069384735353, 4231.936520952188, 4234.026173980002, 3459.927422498983, 3499.492573576868, 3516.5780106387397, 3552.8223588820974, 3563.3585954527916, 1191.4936152135308, 1199.2564609941892, 1207.3842340406457, 1211.073528750489, 1214.3745970825032, 1303.0813276639947, 1310.8361454818148, 1319.4128612767418, 1336.111485861891, 1347.6091933339417, 6847.863042739117, 6978.441724662015, 6984.266652001568, 6986.650667466606, 7016.859662806715, 434.450420218424, 443.05629010208696, 443.51656694203473, 446.0209839402545, 447.3267732063224, 5104.3109180260935, 5146.8970620588125, 5168.250603662448, 5178.0, 5178.456262092502, 8758.167974042455, 8761.211490965843, 8783.385163038654, 8854.690085846965, 8950.68672596456, 8662.653493860302, 8736.519491427905, 8753.606087726068, 8774.95612521946, 8784.033756286803, 6790.932090679129, 6939.826504337331, 6997.370236678622, 7060.92939070613, 7088.893666595005, 7064.611446370293, 7097.041899343522, 7113.82215444618, 7126.893096603451, 7129.893051604126, 7716.2669546393, 7982.361411087215, 7985.560794156145, 7999.120096789465, 8038.115807261313, 8017.236208034223, 8183.099859015622, 8246.38152138604, 8345.082040975609, 8361.707340243061, 5673.8865222694485, 5840.503557197686, 6674.666266686743, 6711.46308295345, 6720.563163394364, 7204.819879503054, 7224.349808517259, 7234.74678386254, 7235.565866048054, 7257.927420725937, 5790.594658373873, 6598.0, 6791.660416979033, 6840.555363901331, 6895.172579290517, 6294.213223347082, 6793.558418702769, 6800.387965083166, 6898.517103802686, 6946.16646002483, 6891.069705589681, 6949.548279361826, 6971.198312194163, 6987.406070484066, 6989.33601307875, 6298.370162983665, 6343.175387199819, 6347.619142851444, 6358.650274234961, 6361.268454127649, 6142.846428839315, 6372.394622510854, 6416.7754128605275, 6424.967875160594, 6499.3175716549085], "unit": "ms", "name": "mootools.html", "value": 4243.06889405004}, {"lowerIsBetter": false, "replicates": [313.91367373972156, 317.91098492422117, 322.4437844717861, 338.5733975191258, 340.0716045196615, 6019.217501724781, 6034.275886893573, 6037.547183961198, 6056.8485787855325, 6064.9090263646085, 5684.403137670547, 5781.190633311329, 5844.736986835592, 5976.163337132805, 5994.0, 4578.931316030245, 4587.541245875419, 4602.447706275251, 4609.539046095397, 4611.769411529419, 4435.822567097328, 4623.791929363187, 4624.421947256593, 4625.7687115644085, 4628.60656844167, 4467.0, 4507.954920450787, 4590.931136032962, 4603.10239503297, 4604.884877878047, 4572.588467037983, 4581.244094724383, 4584.701994370389, 4585.5185205553435, 4599.977000115012, 4046.9392959105635, 4047.797610119512, 4052.898677533056, 4058.269511487931, 4068.6745060395097, 5581.972090139523, 5698.059820129673, 5705.2012718219485, 5715.171300161495, 5717.942820571782, 5294.020606187868, 5295.920561191585, 5305.522502974751, 5305.681659100466, 5306.575473962073, 6355.8411039723915, 6361.3638636136475, 6380.968095159541, 6395.712192951329, 6396.680165991728, 4345.174416860787, 4354.629856462205, 4354.695171338008, 4355.1725172217175, 4355.651547876194, 6491.318411566765, 6558.311377305362, 6600.86798264032, 6627.072209890619, 6640.435562977153, 4360.171567402183, 4401.449818772653, 4415.315626077963, 4426.203283409017, 4426.645868330525, 4446.799894004777, 4457.442819647544, 4457.732536047783, 4460.799264033127, 4466.6203372713035, 5223.347081614798, 5225.869353266199, 5228.7908483660985, 5239.44985776488, 5240.0567897778, 6199.380061993855, 6298.527610429236, 6336.366363363627, 6380.202474690664, 6406.263279722798, 1579.202502736111, 1587.9364825407085, 1589.3721979817908, 1590.769338445919, 1592.1322879030956, 1021.8467229915572, 1041.4272150317447, 1058.957641694339, 1060.5121644043827, 1094.5512339940585, 6163.8150855474405, 6166.290876549165, 6175.660338681326, 6196.690165491707, 6204.441600255998, 6355.650439225887, 6569.967150164219, 6573.704183311763, 6577.14497115372, 6592.340765923465, 6074.271087469532, 6130.080487926846, 6166.290876549165, 6226.097215903759, 6237.282712488031, 3538.2392785550715, 3583.784972901582, 3588.174719814457, 3592.856285748541, 3593.6945359644724, 6636.270010298863, 6764.72941082361, 6772.458203343721, 6778.661066946732, 6798.626075565891, 6800.217974932847, 6805.353491418307, 6810.523263371517, 6817.90913453845, 6826.488013399015, 6899.793006209822, 6900.827479313058, 6906.896396554056, 6914.412274956685, 6922.7923162305215, 6533.934660653333, 6596.406323430914, 6620.536562440583, 6632.635205063768, 6638.966805165944, 6570.113034740249, 6573.408393244631, 6573.769918052845, 6575.671216439255, 6579.276279609335, 6847.48643851723, 6882.724691012303, 6887.0, 6889.138857642794, 6892.689828957809, 4508.571685689854, 4512.638988880816, 4512.9774351129345, 4515.187266292099, 4517.412736344254, 6442.581232219891, 6587.440067594116, 6608.041833934149, 6647.800565983028, 6693.799186024427, 6479.8056058318325, 6482.740690372332, 6495.707693153914, 6497.707603157774, 6510.609363438209, 6315.273743519554, 6463.676816159267, 6469.191351081115, 6479.5788273762055, 6487.0593763903025, 6348.809535713936, 6357.8728425432155, 6358.904616430665, 6363.490920726424, 6370.044493326038, 6465.935340646533, 6470.547061705635, 6472.320406357265, 6474.546781725422, 6476.6114033158165, 6210.192674952227, 6338.429541341301, 6354.23749150105, 6360.522960778053, 6364.87270254583], "unit": "ms", "name": "prototype.html", "value": 4802.385211925206}, {"lowerIsBetter": false, "replicates": [706.6325510734415, 762.8207371267752, 764.121260550367, 859.415597393772, 902.5442151713386, 13354.332283385816, 13361.331933403328, 13710.862891371084, 13718.108322959013, 13753.106048106878, 13068.934655326733, 13135.540256091039, 13228.0, 13231.536896208634, 13243.337833108355, 686.0498209979165, 820.8153165537751, 841.6380956188837, 841.8863453433769, 842.4103127810557, 689.1661090081008, 824.381713714714, 841.3605659698612, 841.6759547574197, 841.7180244618061, 864.9221570058694, 880.8458519759049, 882.2765332427412, 882.5190271302124, 882.9293656507464, 714.8606021825746, 721.6103304215769, 853.5689476814231, 867.5185272173941, 868.522312727997, 640.7308930249307, 641.413107007088, 642.0946465483646, 642.3801032004138, 644.8291202831207, 13560.728785424237, 13772.173669579857, 13846.169229846242, 13882.93058534711, 13927.442902283896, 11443.542258309657, 11601.767964640745, 11807.763844723144, 11813.704657383549, 11815.763684726257, 10290.588376464932, 10321.380717156919, 10459.790804183875, 10485.79028419435, 10505.212109091772, 3496.248306614065, 3513.8067406292644, 3539.0975301298004, 3545.166885781839, 3629.8185090745355, 45664.0, 45820.312695309265, 46258.0, 46532.0, 47096.0, 10352.689419317432, 10525.157987360994, 10550.788984220273, 10583.735406614896, 11017.504212310465, 18945.147468363957, 18945.715814262796, 18960.52598685044, 19023.33418330352, 19034.143463544173, 7467.141278752904, 7526.09686837583, 7655.425843061793, 7664.156942736295, 7796.0, 4378.605925466723, 4381.474223093249, 4389.736615803062, 4421.5578442156175, 4496.527864574238, 2949.5428208627695, 2991.5512673098774, 2997.730204281625, 3003.5344521599186, 3004.9399012019635, 525.9368875734937, 529.2405398253519, 532.1645017322843, 534.5082524077858, 545.9208414779835, 638.7860066877555, 664.8005598320484, 671.701093013614, 684.934931181537, 722.3895808042196, 7814.765557033298, 7865.134835168127, 8001.919980800234, 8017.959910200411, 8168.877466838002, 550.5072959701046, 560.778492495462, 561.6349372907642, 624.1168746224042, 651.563452486835, 3793.943090853639, 3921.215756848642, 3930.371140617545, 4075.857344992911, 4143.4199212110325, 54871.72564137234, 56088.15867761987, 56881.14678279829, 57207.42792572021, 57393.0, 50436.747816260686, 51059.489405106215, 51858.22212666813, 52007.73996129995, 53287.20069198965, 45757.77121114373, 46314.0, 46805.531944680115, 47369.5263047372, 47723.0, 8180.8363832721825, 8360.45657032291, 8485.109063548485, 8495.277901378453, 8736.301095912439, 33882.83058584691, 34722.305553888276, 34789.08660023723, 35389.64610353864, 35652.64347356493, 42301.36547951722, 43325.0, 46633.0, 46663.90095417076, 46742.298865516364, 10877.836832447361, 11100.722481938015, 11212.103031757602, 11223.102151827998, 11479.196456248317, 11875.465604048011, 11988.700282493008, 12014.038876889654, 12649.810252846399, 12688.111832171659, 10775.407352595683, 10926.0, 10984.231103822975, 11006.174536909604, 11279.436028198394, 11535.250208736405, 11724.120690948042, 11827.763444731228, 12194.329311887932, 12207.145499814927, 10199.0, 10471.633492827714, 10494.722824034494, 10814.513346899252, 11071.833922491009, 9750.60997560118, 10038.899611003797, 10061.295709300279, 10209.591616335561, 10322.587096516356, 9059.501727404793, 9080.182783549511, 9102.028386426802, 9125.75395921428, 9349.252059835333], "unit": "ms", "name": "yui.html", "value": 6273.222345376825}], "name": "dromaeo_css", "value": 7006.067827095994}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 111.0, 104.0, 109.0, 110.0, 109.0, 100.0, 110.0, 109.0, 102.0], "unit": "ms", "name": "ai-astar", "value": 107.1}, {"lowerIsBetter": true, "replicates": [146.0, 123.0, 150.0, 163.0, 131.0, 156.0, 147.0, 134.0, 179.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 159.0, 161.0, 160.0, 160.0, 161.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 86.0, 92.0, 72.0, 72.0, 72.0, 106.0, 92.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 134.0, 93.0, 94.0, 92.0, 133.0, 93.0, 93.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 147.0, 147.0, 144.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 57.0, 56.0, 58.0, 57.0, 63.0, 58.0, 58.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [90.0, 85.0, 86.0, 85.0, 85.0, 87.0, 84.0, 83.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [118.0, 129.0, 121.0, 114.0, 122.0, 127.0, 124.0, 132.0, 116.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [140.0, 147.0, 150.0, 150.0, 149.0, 137.0, 149.0, 161.0, 150.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 66.0, 67.0, 66.0, 64.0, 67.0, 67.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1501.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.26194017517767], "unit": "score", "name": "Richards", "value": 213.61240199999997}, {"lowerIsBetter": false, "replicates": [194.81784531463083], "unit": "score", "name": "DeltaBlue", "value": 339.383694}, {"lowerIsBetter": false, "replicates": [282.56569652444193], "unit": "score", "name": "Encrypt", "value": 942.0145590000004}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1077.5862068965516], "unit": "score", "name": "RayTrace", "value": 686.7097920000001}, {"lowerIsBetter": false, "replicates": [771.604938271605], "unit": "score", "name": "Earley", "value": 863.7360479999996}, {"lowerIsBetter": false, "replicates": [11894.117647058823], "unit": "score", "name": "Boyer", "value": 56.0329920870425}, {"lowerIsBetter": false, "replicates": [25897.4358974359], "unit": "score", "name": "RegExp", "value": 35.17664851485149}, {"lowerIsBetter": false, "replicates": [657.5342465753424], "unit": "score", "name": "Splay", "value": 123.93422916666663}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20941.36036441822}]} 07:11:34 INFO - RETURN: dromaeo_css: 7006.07 07:11:34 INFO - RETURN: kraken: 1501.40 07:11:34 INFO - RETURN: v8_7: 20941.36 07:11:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20941.36"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1501.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "7006.07"}}} 07:11:34 INFO - Return code: 0 07:11:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:11:34 INFO - # TBPL SUCCESS # 07:11:34 INFO - Running post-action listener: _resource_record_post_action 07:11:34 INFO - Running post-run listener: _resource_record_post_run 07:11:35 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505012224; Read time: 20; Write time: 399224 07:11:35 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 246583296; Read time: 0; Write time: 266804 07:11:35 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258428928; Read time: 20; Write time: 132420 07:11:35 INFO - Running post-run listener: _upload_blobber_files 07:11:35 INFO - Blob upload gear active. 07:11:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:11:35 INFO - Copying logs to upload dir... 07:11:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.964208 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-26 07:11:35.819219) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 07:11:35.822815) ========= 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=20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010043 build_url: 'https://queue.taskcluster.net/v1/task/fo405TztRwqL3GG1FRyM4g/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-26 07:11:35.875123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 07:11:35.875512) ========= 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=20aa3857bbc5a756c598c738000001bb-1448549413.23744-351759574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004700 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 07:11:35.925944) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 07:11:35.926341) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 07:11:35.926644) ========= ========= Total master_lag: 0.21 =========