builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1447524095.24 results: success (0) buildid: 20151114083154 builduid: 64073ca943a64838ab9177a6f2a208c7 revision: ea060d62594e0cb3522b7fcc9fcfc7ca635007ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.238098) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.238514) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.238796) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006508 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.275785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.276294) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.345032) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.345511) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.431129) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.431391) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.431728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.432012) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-14 10:01:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-11-14 10:01:36 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139329 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.602547) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.602819) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014252 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.664566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:35.664907) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea060d62594e0cb3522b7fcc9fcfc7ca635007ad --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 ea060d62594e0cb3522b7fcc9fcfc7ca635007ad --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=b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-14 10:01:36,166 truncating revision to first 12 chars 2015-11-14 10:01:36,166 Setting DEBUG logging. 2015-11-14 10:01:36,166 attempt 1/10 2015-11-14 10:01:36,166 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea060d62594e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 10:01:36,510 unpacking tar archive at: fx-team-ea060d62594e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.605620 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:36.283186) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:36.283513) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:36.291040) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:36.291306) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 10:01:36.291715) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-14 10:01:36.292024) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:01:36 INFO - MultiFileLogger online at 20151114 10:01:36 in /builds/slave/test-pgo 10:01:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:01:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:01:36 INFO - {'append_to_log': False, 10:01:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:01:36 INFO - 'blob_upload_branch': 'Fx-Team', 10:01:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:01:36 INFO - 'branch': 'Fx-Team', 10:01:36 INFO - 'buildbot_json_path': 'buildprops.json', 10:01:36 INFO - 'config_files': ('talos/linux_config.py',), 10:01:36 INFO - 'default_actions': ('clobber', 10:01:36 INFO - 'read-buildbot-config', 10:01:36 INFO - 'download-and-extract', 10:01:36 INFO - 'populate-webroot', 10:01:36 INFO - 'create-virtualenv', 10:01:36 INFO - 'install', 10:01:36 INFO - 'run-tests'), 10:01:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:01:36 INFO - 'download_minidump_stackwalk': True, 10:01:36 INFO - 'download_symbols': 'ondemand', 10:01:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:01:36 INFO - 'tooltool.py': '/tools/tooltool.py', 10:01:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:01:36 INFO - '/tools/misc-python/virtualenv.py')}, 10:01:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:01:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:01:36 INFO - 'installer_path': 'installer.exe', 10:01:36 INFO - 'log_level': 'info', 10:01:36 INFO - 'log_name': 'talos', 10:01:36 INFO - 'log_to_console': True, 10:01:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:01:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:01:36 INFO - 'opt_config_files': (), 10:01:36 INFO - 'pip_index': False, 10:01:36 INFO - 'sps_profile': False, 10:01:36 INFO - 'sps_profile_interval': 0, 10:01:36 INFO - 'suite': 'dromaeojs-e10s', 10:01:36 INFO - 'system_bits': '64', 10:01:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:01:36 INFO - 'title': 'talos-linux64-ix-001', 10:01:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:01:36 INFO - 'use_talos_json': True, 10:01:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:01:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:01:36 INFO - 'work_dir': 'build'} 10:01:36 INFO - ##### 10:01:36 INFO - ##### Running clobber step. 10:01:36 INFO - ##### 10:01:36 INFO - Running pre-action listener: _resource_record_pre_action 10:01:36 INFO - Running main action method: clobber 10:01:36 INFO - rmtree: /builds/slave/test-pgo/build 10:01:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:01:37 INFO - Running post-action listener: _resource_record_post_action 10:01:37 INFO - ##### 10:01:37 INFO - ##### Running read-buildbot-config step. 10:01:37 INFO - ##### 10:01:37 INFO - Running pre-action listener: _resource_record_pre_action 10:01:37 INFO - Running main action method: read_buildbot_config 10:01:37 INFO - Using buildbot properties: 10:01:37 INFO - { 10:01:37 INFO - "properties": { 10:01:37 INFO - "buildnumber": 331, 10:01:37 INFO - "product": "firefox", 10:01:37 INFO - "script_repo_revision": "production", 10:01:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:01:37 INFO - "repository": "", 10:01:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:01:37 INFO - "buildid": "20151114083154", 10:01:37 INFO - "slavename": "talos-linux64-ix-001", 10:01:37 INFO - "pgo_build": "True", 10:01:37 INFO - "basedir": "/builds/slave/test-pgo", 10:01:37 INFO - "project": "", 10:01:37 INFO - "platform": "ubuntu64_hw", 10:01:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:01:37 INFO - "slavebuilddir": "test", 10:01:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:01:37 INFO - "branch": "fx-team", 10:01:37 INFO - "repo_path": "integration/fx-team", 10:01:37 INFO - "stage_platform": "linux64-pgo", 10:01:37 INFO - "builduid": "64073ca943a64838ab9177a6f2a208c7", 10:01:37 INFO - "revision": "ea060d62594e0cb3522b7fcc9fcfc7ca635007ad" 10:01:37 INFO - }, 10:01:37 INFO - "sourcestamp": { 10:01:37 INFO - "repository": "", 10:01:37 INFO - "hasPatch": false, 10:01:37 INFO - "project": "", 10:01:37 INFO - "branch": "fx-team-linux64-pgo-talos", 10:01:37 INFO - "changes": [ 10:01:37 INFO - { 10:01:37 INFO - "category": null, 10:01:37 INFO - "files": [ 10:01:37 INFO - { 10:01:37 INFO - "url": null, 10:01:37 INFO - "name": "https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:01:37 INFO - } 10:01:37 INFO - ], 10:01:37 INFO - "repository": "", 10:01:37 INFO - "rev": "ea060d62594e0cb3522b7fcc9fcfc7ca635007ad", 10:01:37 INFO - "who": "sendchange", 10:01:37 INFO - "when": 1447524072, 10:01:37 INFO - "number": 6662353, 10:01:37 INFO - "comments": "", 10:01:37 INFO - "project": "", 10:01:37 INFO - "at": "Sat 14 Nov 2015 10:01:12", 10:01:37 INFO - "branch": "fx-team-linux64-pgo-talos", 10:01:37 INFO - "revlink": "", 10:01:37 INFO - "properties": [ 10:01:37 INFO - [ 10:01:37 INFO - "buildid", 10:01:37 INFO - "20151114083154", 10:01:37 INFO - "Change" 10:01:37 INFO - ], 10:01:37 INFO - [ 10:01:37 INFO - "builduid", 10:01:37 INFO - "64073ca943a64838ab9177a6f2a208c7", 10:01:37 INFO - "Change" 10:01:37 INFO - ], 10:01:37 INFO - [ 10:01:37 INFO - "pgo_build", 10:01:37 INFO - "True", 10:01:37 INFO - "Change" 10:01:37 INFO - ] 10:01:37 INFO - ], 10:01:37 INFO - "revision": "ea060d62594e0cb3522b7fcc9fcfc7ca635007ad" 10:01:37 INFO - } 10:01:37 INFO - ], 10:01:37 INFO - "revision": "ea060d62594e0cb3522b7fcc9fcfc7ca635007ad" 10:01:37 INFO - } 10:01:37 INFO - } 10:01:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:01:37 INFO - Running post-action listener: _resource_record_post_action 10:01:37 INFO - ##### 10:01:37 INFO - ##### Running download-and-extract step. 10:01:37 INFO - ##### 10:01:37 INFO - Running pre-action listener: _resource_record_pre_action 10:01:37 INFO - Running main action method: download_and_extract 10:01:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:37 INFO - https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/test_packages.json 10:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/test_packages.json 10:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:01:38 INFO - Downloaded 1302 bytes. 10:01:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:01:38 INFO - Using the following test package requirements: 10:01:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:01:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:38 INFO - u'jsshell-linux-x86_64.zip'], 10:01:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:01:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:01:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:01:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:01:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:01:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:38 INFO - https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:01:40 INFO - Downloaded 22444833 bytes. 10:01:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:01:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:01:41 INFO - Return code: 0 10:01:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:41 INFO - https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:01:53 INFO - Downloaded 22444833 bytes. 10:01:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:01:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:01:54 INFO - Return code: 0 10:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:54 INFO - https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:01:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:01:55 INFO - Downloaded 11131693 bytes. 10:01:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 10:01:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:01:55 INFO - Return code: 0 10:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:55 INFO - https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:01:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:01:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:01:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:01:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:01:57 INFO - Downloaded 57134305 bytes. 10:01:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:01:57 INFO - mkdir: /builds/slave/test-pgo/properties 10:01:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:01:57 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:01:57 INFO - Contents: 10:01:57 INFO - build_url:https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:01:57 INFO - Running post-action listener: _resource_record_post_action 10:01:57 INFO - Running post-action listener: set_extra_try_arguments 10:01:57 INFO - ##### 10:01:57 INFO - ##### Running populate-webroot step. 10:01:57 INFO - ##### 10:01:57 INFO - Running pre-action listener: _resource_record_pre_action 10:01:57 INFO - Running main action method: populate_webroot 10:01:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:01:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:01:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:01:57 INFO - '../fennec_ids.txt'], 10:01:57 INFO - 'tests': ['tcheck2']}, 10:01:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:01:57 INFO - '--tppagecycles', 10:01:57 INFO - '7'], 10:01:57 INFO - 'tests': ['tsvgm']}}, 10:01:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:01:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:01:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:01:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:01:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:01:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:01:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:57 INFO - 'talos_options': ['--e10s'], 10:01:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:57 INFO - 'tests': ['damp', 'tps']}, 10:01:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:57 INFO - 'talos_options': ['--e10s'], 10:01:57 INFO - 'tests': ['damp', 'tps']}, 10:01:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:01:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:01:57 INFO - 'other': {'tests': ['a11yr', 10:01:57 INFO - 'ts_paint', 10:01:57 INFO - 'tpaint', 10:01:57 INFO - 'sessionrestore', 10:01:57 INFO - 'sessionrestore_no_auto_restore']}, 10:01:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:01:57 INFO - 'tests': ['a11yr', 10:01:57 INFO - 'ts_paint', 10:01:57 INFO - 'tpaint', 10:01:57 INFO - 'sessionrestore', 10:01:57 INFO - 'sessionrestore_no_auto_restore']}, 10:01:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:01:57 INFO - 'tests': ['a11yr', 10:01:57 INFO - 'ts_paint', 10:01:57 INFO - 'tpaint', 10:01:57 INFO - 'sessionrestore', 10:01:57 INFO - 'sessionrestore_no_auto_restore']}, 10:01:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:01:57 INFO - 'tests': ['a11yr', 10:01:57 INFO - 'ts_paint', 10:01:57 INFO - 'tpaint', 10:01:57 INFO - 'sessionrestore', 10:01:57 INFO - 'sessionrestore_no_auto_restore']}, 10:01:57 INFO - 'other_l64': {'tests': ['a11yr', 10:01:57 INFO - 'ts_paint', 10:01:57 INFO - 'tpaint', 10:01:57 INFO - 'sessionrestore', 10:01:57 INFO - 'sessionrestore_no_auto_restore']}, 10:01:57 INFO - 'other_nol64': {'tests': ['a11yr', 10:01:57 INFO - 'ts_paint', 10:01:57 INFO - 'tpaint', 10:01:57 INFO - 'sessionrestore', 10:01:57 INFO - 'sessionrestore_no_auto_restore']}, 10:01:57 INFO - 'svgr': {'tests': ['tsvgx', 10:01:57 INFO - 'tsvgr_opacity', 10:01:57 INFO - 'tart', 10:01:57 INFO - 'tscrollx', 10:01:57 INFO - 'cart']}, 10:01:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:01:57 INFO - 'tests': ['tsvgx', 10:01:57 INFO - 'tsvgr_opacity', 10:01:57 INFO - 'tart', 10:01:57 INFO - 'tscrollx', 10:01:57 INFO - 'cart']}, 10:01:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:57 INFO - 'tests': ['tp5o']}, 10:01:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:57 INFO - 'talos_options': ['--e10s'], 10:01:57 INFO - 'tests': ['tp5o']}, 10:01:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:57 INFO - 'talos_options': ['--xperf_path', 10:01:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:57 INFO - 'tests': ['tp5n']}, 10:01:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:57 INFO - 'talos_options': ['--e10s', 10:01:57 INFO - '--xperf_path', 10:01:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:57 INFO - 'tests': ['tp5n']}}, 10:01:57 INFO - 'talos.zip': {'path': '', 10:01:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:01:57 INFO - Running post-action listener: _resource_record_post_action 10:01:57 INFO - ##### 10:01:57 INFO - ##### Running create-virtualenv step. 10:01:57 INFO - ##### 10:01:57 INFO - Running pre-action listener: _resource_record_pre_action 10:01:57 INFO - Running main action method: create_virtualenv 10:01:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:01:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:01:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:01:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:01:57 INFO - Using real prefix '/usr' 10:01:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:01:57 INFO - Installing distribute.............................................................................................................................................................................................done. 10:01:59 INFO - Installing pip.................done. 10:01:59 INFO - Return code: 0 10:01:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:59 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 0x7fe7f51eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba03d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c298c0>, '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 0x2bd6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:01:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:01:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:01:59 INFO - Using env: {'DISPLAY': ':0', 10:01:59 INFO - 'HOME': '/home/cltbld', 10:01:59 INFO - 'LANG': 'en_US.UTF-8', 10:01:59 INFO - 'LANGUAGE': 'en_US:en', 10:01:59 INFO - 'LOGNAME': 'cltbld', 10:01:59 INFO - 'MAIL': '/var/mail/cltbld', 10:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:59 INFO - 'MOZ_NO_REMOTE': '1', 10:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:59 INFO - 'NO_EM_RESTART': '1', 10:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:59 INFO - 'SHELL': '/bin/bash', 10:01:59 INFO - 'SHLVL': '1', 10:01:59 INFO - 'TERM': 'linux', 10:01:59 INFO - 'TMOUT': '86400', 10:01:59 INFO - 'USER': 'cltbld', 10:01:59 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 10:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:59 INFO - '_': '/tools/buildbot/bin/python'} 10:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:01:59 INFO - Cleaning up... 10:01:59 INFO - Return code: 0 10:01:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:59 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 0x7fe7f51eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba03d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c298c0>, '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 0x2bd6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:01:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:01:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:01:59 INFO - Using env: {'DISPLAY': ':0', 10:01:59 INFO - 'HOME': '/home/cltbld', 10:01:59 INFO - 'LANG': 'en_US.UTF-8', 10:01:59 INFO - 'LANGUAGE': 'en_US:en', 10:01:59 INFO - 'LOGNAME': 'cltbld', 10:01:59 INFO - 'MAIL': '/var/mail/cltbld', 10:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:59 INFO - 'MOZ_NO_REMOTE': '1', 10:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:59 INFO - 'NO_EM_RESTART': '1', 10:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:59 INFO - 'SHELL': '/bin/bash', 10:01:59 INFO - 'SHLVL': '1', 10:01:59 INFO - 'TERM': 'linux', 10:01:59 INFO - 'TMOUT': '86400', 10:01:59 INFO - 'USER': 'cltbld', 10:01:59 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 10:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:59 INFO - '_': '/tools/buildbot/bin/python'} 10:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:00 INFO - Downloading/unpacking psutil>=0.7.1 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:01 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:02:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:01 INFO - Installing collected packages: psutil 10:02:01 INFO - Running setup.py install for psutil 10:02:01 INFO - building 'psutil._psutil_linux' extension 10:02:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:02:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:02:02 INFO - building 'psutil._psutil_posix' extension 10:02:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:02:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:02:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:02 INFO - Successfully installed psutil 10:02:02 INFO - Cleaning up... 10:02:02 INFO - Return code: 0 10:02:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:02 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 0x7fe7f51eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba03d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c298c0>, '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 0x2bd6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:02:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:02:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:02:02 INFO - Using env: {'DISPLAY': ':0', 10:02:02 INFO - 'HOME': '/home/cltbld', 10:02:02 INFO - 'LANG': 'en_US.UTF-8', 10:02:02 INFO - 'LANGUAGE': 'en_US:en', 10:02:02 INFO - 'LOGNAME': 'cltbld', 10:02:02 INFO - 'MAIL': '/var/mail/cltbld', 10:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:02 INFO - 'MOZ_NO_REMOTE': '1', 10:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:02 INFO - 'NO_EM_RESTART': '1', 10:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:02 INFO - 'SHELL': '/bin/bash', 10:02:02 INFO - 'SHLVL': '1', 10:02:02 INFO - 'TERM': 'linux', 10:02:02 INFO - 'TMOUT': '86400', 10:02:02 INFO - 'USER': 'cltbld', 10:02:02 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 10:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:02 INFO - '_': '/tools/buildbot/bin/python'} 10:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:02:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:02:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:02:04 INFO - Installing collected packages: mozsystemmonitor 10:02:04 INFO - Running setup.py install for mozsystemmonitor 10:02:04 INFO - Successfully installed mozsystemmonitor 10:02:04 INFO - Cleaning up... 10:02:04 INFO - Return code: 0 10:02:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:02: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')]} 10:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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', '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 0x7fe7f51eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba03d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c298c0>, '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 0x2bd6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:02: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:02: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 blobuploader==1.2.4 10:02:04 INFO - Using env: {'DISPLAY': ':0', 10:02:04 INFO - 'HOME': '/home/cltbld', 10:02:04 INFO - 'LANG': 'en_US.UTF-8', 10:02:04 INFO - 'LANGUAGE': 'en_US:en', 10:02:04 INFO - 'LOGNAME': 'cltbld', 10:02:04 INFO - 'MAIL': '/var/mail/cltbld', 10:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:04 INFO - 'MOZ_NO_REMOTE': '1', 10:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:04 INFO - 'NO_EM_RESTART': '1', 10:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:04 INFO - 'SHELL': '/bin/bash', 10:02:04 INFO - 'SHLVL': '1', 10:02:04 INFO - 'TERM': 'linux', 10:02:04 INFO - 'TMOUT': '86400', 10:02:04 INFO - 'USER': 'cltbld', 10:02:04 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 10:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:04 INFO - '_': '/tools/buildbot/bin/python'} 10:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:04 INFO - Downloading/unpacking blobuploader==1.2.4 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02:06 INFO - Downloading blobuploader-1.2.4.tar.gz 10:02:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:02:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:02:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:02:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:02:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:07 INFO - Downloading docopt-0.6.1.tar.gz 10:02:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:02:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:07 INFO - Running setup.py install for blobuploader 10:02:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:02:07 INFO - Running setup.py install for requests 10:02:07 INFO - Running setup.py install for docopt 10:02:07 INFO - Successfully installed blobuploader requests docopt 10:02:07 INFO - Cleaning up... 10:02:07 INFO - Return code: 0 10:02:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:07 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 0x7fe7f51eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba03d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c298c0>, '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 0x2bd6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:02:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:02:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:02:07 INFO - Using env: {'DISPLAY': ':0', 10:02:07 INFO - 'HOME': '/home/cltbld', 10:02:07 INFO - 'LANG': 'en_US.UTF-8', 10:02:07 INFO - 'LANGUAGE': 'en_US:en', 10:02:07 INFO - 'LOGNAME': 'cltbld', 10:02:07 INFO - 'MAIL': '/var/mail/cltbld', 10:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:07 INFO - 'MOZ_NO_REMOTE': '1', 10:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:07 INFO - 'NO_EM_RESTART': '1', 10:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:07 INFO - 'SHELL': '/bin/bash', 10:02:07 INFO - 'SHLVL': '1', 10:02:07 INFO - 'TERM': 'linux', 10:02:07 INFO - 'TMOUT': '86400', 10:02:07 INFO - 'USER': 'cltbld', 10:02:07 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 10:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:07 INFO - '_': '/tools/buildbot/bin/python'} 10:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:02:07 INFO - Running setup.py (path:/tmp/pip-xmthyy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:02:07 INFO - Running setup.py (path:/tmp/pip-bU3e6G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:02:08 INFO - Running setup.py (path:/tmp/pip-SRjoxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:02:08 INFO - Running setup.py (path:/tmp/pip-qBlOho-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:02:08 INFO - Running setup.py (path:/tmp/pip-VDSfnX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:02:08 INFO - Running setup.py (path:/tmp/pip-dXRf4_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:02:08 INFO - Running setup.py (path:/tmp/pip-fUFvHF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:02:08 INFO - Running setup.py (path:/tmp/pip-kz5hM5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:02:08 INFO - Running setup.py (path:/tmp/pip-QtFEKo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:02:08 INFO - Running setup.py (path:/tmp/pip-2yhOSO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:02:08 INFO - Running setup.py (path:/tmp/pip-HuGIlj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:02:08 INFO - Running setup.py (path:/tmp/pip-tHC4TT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:02:08 INFO - Running setup.py (path:/tmp/pip-UQR26j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:02:08 INFO - Running setup.py (path:/tmp/pip-3D_0PI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:02:08 INFO - Running setup.py (path:/tmp/pip-E5mdlK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:02:08 INFO - Running setup.py (path:/tmp/pip-SRNKzn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:02:09 INFO - Running setup.py (path:/tmp/pip-teQXQl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:02:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:09 INFO - Running setup.py install for manifestparser 10:02:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:02:09 INFO - Running setup.py install for mozcrash 10:02:09 INFO - Running setup.py install for mozdebug 10:02:09 INFO - Running setup.py install for mozdevice 10:02:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:02:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:02:09 INFO - Running setup.py install for mozfile 10:02:09 INFO - Running setup.py install for mozhttpd 10:02:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:02:09 INFO - Running setup.py install for mozinfo 10:02:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:02:09 INFO - Running setup.py install for mozInstall 10:02:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:02:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:02:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:02:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:02:09 INFO - Running setup.py install for mozleak 10:02:10 INFO - Running setup.py install for mozlog 10:02:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:02:10 INFO - Running setup.py install for moznetwork 10:02:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:02:10 INFO - Running setup.py install for mozprocess 10:02:10 INFO - Running setup.py install for mozprofile 10:02:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:02:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:02:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:02:10 INFO - Running setup.py install for mozrunner 10:02:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:02:10 INFO - Running setup.py install for mozscreenshot 10:02:10 INFO - Running setup.py install for moztest 10:02:10 INFO - Running setup.py install for mozversion 10:02:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:02:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:10 INFO - Cleaning up... 10:02:10 INFO - Return code: 0 10:02:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:10 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 0x7fe7f51eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba03d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c298c0>, '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 0x2bd6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:02:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:02:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:02:10 INFO - Using env: {'DISPLAY': ':0', 10:02:10 INFO - 'HOME': '/home/cltbld', 10:02:10 INFO - 'LANG': 'en_US.UTF-8', 10:02:10 INFO - 'LANGUAGE': 'en_US:en', 10:02:10 INFO - 'LOGNAME': 'cltbld', 10:02:10 INFO - 'MAIL': '/var/mail/cltbld', 10:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:10 INFO - 'MOZ_NO_REMOTE': '1', 10:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:10 INFO - 'NO_EM_RESTART': '1', 10:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:10 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:10 INFO - 'SHELL': '/bin/bash', 10:02:10 INFO - 'SHLVL': '1', 10:02:10 INFO - 'TERM': 'linux', 10:02:10 INFO - 'TMOUT': '86400', 10:02:10 INFO - 'USER': 'cltbld', 10:02:10 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 10:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:10 INFO - '_': '/tools/buildbot/bin/python'} 10:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:02:11 INFO - Running setup.py (path:/tmp/pip-KHGqW8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:02:11 INFO - Running setup.py (path:/tmp/pip-gjIPZP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:02:11 INFO - Running setup.py (path:/tmp/pip-oyNIXc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:02:11 INFO - Running setup.py (path:/tmp/pip-vkls2Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:02:11 INFO - Running setup.py (path:/tmp/pip-nxZV3h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:02:11 INFO - Running setup.py (path:/tmp/pip-R9MtvV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:02:11 INFO - Running setup.py (path:/tmp/pip-wa8rzY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:02:11 INFO - Running setup.py (path:/tmp/pip-YTwLcF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:02:11 INFO - Running setup.py (path:/tmp/pip-6C8ncg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:02:11 INFO - Running setup.py (path:/tmp/pip-kKPi_n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:02:11 INFO - Running setup.py (path:/tmp/pip-_rBddh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:02:11 INFO - Running setup.py (path:/tmp/pip-07Owe_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:02:12 INFO - Running setup.py (path:/tmp/pip-e9j7y6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:02:12 INFO - Running setup.py (path:/tmp/pip-q2qPcA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:02:12 INFO - Running setup.py (path:/tmp/pip-YyFrjA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:02:12 INFO - Running setup.py (path:/tmp/pip-ixQ6kB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:02:12 INFO - Running setup.py (path:/tmp/pip-kfWAfl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:02:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:14 INFO - Downloading blessings-1.5.1.tar.gz 10:02:14 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 10:02:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:14 INFO - Installing collected packages: blessings 10:02:14 INFO - Running setup.py install for blessings 10:02:14 INFO - Successfully installed blessings 10:02:14 INFO - Cleaning up... 10:02:14 INFO - Return code: 0 10:02:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:02:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:02:14 INFO - Reading from file tmpfile_stdout 10:02:14 INFO - Current package versions: 10:02:14 INFO - argparse == 1.2.1 10:02:14 INFO - blessings == 1.5.1 10:02:14 INFO - blobuploader == 1.2.4 10:02:14 INFO - docopt == 0.6.1 10:02:14 INFO - manifestparser == 1.1 10:02:14 INFO - mozInstall == 1.12 10:02:14 INFO - mozcrash == 0.16 10:02:14 INFO - mozdebug == 0.1 10:02:14 INFO - mozdevice == 0.47 10:02:14 INFO - mozfile == 1.2 10:02:14 INFO - mozhttpd == 0.7 10:02:14 INFO - mozinfo == 0.9 10:02:14 INFO - mozleak == 0.1 10:02:14 INFO - mozlog == 3.0 10:02:14 INFO - moznetwork == 0.27 10:02:14 INFO - mozprocess == 0.22 10:02:14 INFO - mozprofile == 0.27 10:02:14 INFO - mozrunner == 6.11 10:02:14 INFO - mozscreenshot == 0.1 10:02:14 INFO - mozsystemmonitor == 0.0 10:02:14 INFO - moztest == 0.7 10:02:14 INFO - mozversion == 1.4 10:02:14 INFO - psutil == 3.1.1 10:02:14 INFO - requests == 1.2.3 10:02:14 INFO - wsgiref == 0.1.2 10:02:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fe7f51eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba03d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c298c0>, '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 0x2bd6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:02:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 10:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:02:14 INFO - Using env: {'DISPLAY': ':0', 10:02:14 INFO - 'HOME': '/home/cltbld', 10:02:14 INFO - 'LANG': 'en_US.UTF-8', 10:02:14 INFO - 'LANGUAGE': 'en_US:en', 10:02:14 INFO - 'LOGNAME': 'cltbld', 10:02:14 INFO - 'MAIL': '/var/mail/cltbld', 10:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:14 INFO - 'MOZ_NO_REMOTE': '1', 10:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:14 INFO - 'NO_EM_RESTART': '1', 10:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:14 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:14 INFO - 'SHELL': '/bin/bash', 10:02:14 INFO - 'SHLVL': '1', 10:02:14 INFO - 'TERM': 'linux', 10:02:14 INFO - 'TMOUT': '86400', 10:02:14 INFO - 'USER': 'cltbld', 10:02:14 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 10:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:14 INFO - '_': '/tools/buildbot/bin/python'} 10:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:02:14 INFO - Cleaning up... 10:02:14 INFO - Return code: 0 10:02:14 INFO - Running post-action listener: _resource_record_post_action 10:02:14 INFO - Running post-action listener: _start_resource_monitoring 10:02:14 INFO - Starting resource monitoring. 10:02:14 INFO - ##### 10:02:14 INFO - ##### Running install step. 10:02:14 INFO - ##### 10:02:14 INFO - Running pre-action listener: _resource_record_pre_action 10:02:14 INFO - Running main action method: install 10:02:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:02:14 INFO - Reading from file tmpfile_stdout 10:02:14 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:02:15 INFO - Reading from file tmpfile_stdout 10:02:15 INFO - Output received: 10:02:15 INFO - Usage: mozinstall [options] installer 10:02:15 INFO - Options: 10:02:15 INFO - -h, --help show this help message and exit 10:02:15 INFO - -d DEST, --destination=DEST 10:02:15 INFO - Directory to install application into. [default: 10:02:15 INFO - "/builds/slave/test-pgo"] 10:02:15 INFO - --app=APP Application being installed. [default: firefox] 10:02:15 INFO - mkdir: /builds/slave/test-pgo/build/application 10:02:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:02:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:02:29 INFO - Reading from file tmpfile_stdout 10:02:29 INFO - Output received: 10:02:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:02:29 INFO - Running post-action listener: _resource_record_post_action 10:02:29 INFO - ##### 10:02:29 INFO - ##### Running run-tests step. 10:02:29 INFO - ##### 10:02:29 INFO - Running pre-action listener: _resource_record_pre_action 10:02:29 INFO - Running main action method: run_tests 10:02:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:02:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:02:29 INFO - Python 2.7.3 10:02:29 INFO - Return code: 0 10:02:29 INFO - grabbing minidump binary from tooltool 10:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:29 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 0x2c298c0>, '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 0x2bd6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:02:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:02:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:02:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:02:29 INFO - Return code: 0 10:02:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:02:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:02:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:02:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:02:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:02:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:02:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 10:02:29 INFO - Using env: {'DISPLAY': ':0', 10:02:29 INFO - 'HOME': '/home/cltbld', 10:02:29 INFO - 'LANG': 'en_US.UTF-8', 10:02:29 INFO - 'LANGUAGE': 'en_US:en', 10:02:29 INFO - 'LOGNAME': 'cltbld', 10:02:29 INFO - 'MAIL': '/var/mail/cltbld', 10:02:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:02:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:29 INFO - 'MOZ_NO_REMOTE': '1', 10:02:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:29 INFO - 'NO_EM_RESTART': '1', 10:02:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:29 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:02:29 INFO - 'SHELL': '/bin/bash', 10:02:29 INFO - 'SHLVL': '1', 10:02:29 INFO - 'TERM': 'linux', 10:02:29 INFO - 'TMOUT': '86400', 10:02:29 INFO - 'USER': 'cltbld', 10:02:29 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494', 10:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:29 INFO - '_': '/tools/buildbot/bin/python'} 10:02:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 10:02:29 INFO - mozversion INFO | application_buildid: 20151114083154 10:02:29 INFO - mozversion INFO | application_changeset: ea060d62594e0cb3522b7fcc9fcfc7ca635007ad 10:02:29 INFO - mozversion INFO | application_display_name: Nightly 10:02:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:02:29 INFO - mozversion INFO | application_name: Firefox 10:02:29 INFO - mozversion INFO | application_remotingname: firefox 10:02:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:02:29 INFO - mozversion INFO | application_vendor: Mozilla 10:02:29 INFO - mozversion INFO | application_version: 45.0a1 10:02:29 INFO - mozversion INFO | platform_buildid: 20151114083154 10:02:29 INFO - mozversion INFO | platform_changeset: ea060d62594e0cb3522b7fcc9fcfc7ca635007ad 10:02:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:02:29 INFO - mozversion INFO | platform_version: 45.0a1 10:02:29 INFO - 2015-11-14 10:02:29,710 DEBUG : using testdate: 1447524149 10:02:29 INFO - 2015-11-14 10:02:29,710 DEBUG : actual date: 1447524149 10:02:29 INFO - 2015-11-14 10:02:29,719 INFO : starting webserver on 'localhost:52437' 10:02:29 INFO - 2015-11-14 10:02:29,720 INFO : Starting test suite talos-linux64-ix-001.e 10:02:29 INFO - 2015-11-14 10:02:29,720 INFO : Starting test dromaeo_css 10:02:29 INFO - 2015-11-14 10:02:29,720 DEBUG : operating with platform_type : linux_ 10:02:29 INFO - 2015-11-14 10:02:29,721 INFO : Initialising browser for dromaeo_css test... 10:02:29 INFO - 2015-11-14 10:02:29,735 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo13vHu/profile http://localhost:52437/getInfo.html 10:02:34 INFO - 2015-11-14 10:02:34,678 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:02:34 INFO - 2015-11-14 10:02:34,679 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:02:34 INFO - 2015-11-14 10:02:34,679 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:02:34 INFO - 2015-11-14 10:02:34,679 DEBUG : BROWSER_OUTPUT: __metrics 10:02:35 INFO - 2015-11-14 10:02:35,729 INFO : Browser initialized. 10:02:35 INFO - 2015-11-14 10:02:35,730 INFO : Running cycle 1/1 for dromaeo_css test... 10:02:35 INFO - 2015-11-14 10:02:35,730 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo13vHu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:02:47 INFO - 2015-11-14 10:02:47,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 140550144 10:02:47 INFO - 2015-11-14 10:02:47,504 DEBUG : BROWSER_OUTPUT: 10:03:37 INFO - 2015-11-14 10:03:37,127 DEBUG : BROWSER_OUTPUT: 1447524217125 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:05:45 INFO - 2015-11-14 10:05:45,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52437/tests/dromaeo/cssquery-ext.html) 10:05:47 INFO - 2015-11-14 10:05:47,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 146612224 10:05:47 INFO - 2015-11-14 10:05:47,073 DEBUG : BROWSER_OUTPUT: 10:08:48 INFO - 2015-11-14 10:08:48,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/dromaeo/cssquery-ext.html (next: http://localhost:52437/tests/dromaeo/cssquery-jquery.html) 10:08:49 INFO - 2015-11-14 10:08:49,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 139980800 10:08:49 INFO - 2015-11-14 10:08:49,548 DEBUG : BROWSER_OUTPUT: 10:11:51 INFO - 2015-11-14 10:11:51,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52437/tests/dromaeo/cssquery-mootools.html) 10:11:51 INFO - 2015-11-14 10:11:51,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 140894208 10:11:51 INFO - 2015-11-14 10:11:51,846 DEBUG : BROWSER_OUTPUT: 10:14:53 INFO - 2015-11-14 10:14:53,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52437/tests/dromaeo/cssquery-prototype.html) 10:14:54 INFO - 2015-11-14 10:14:54,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 140328960 10:14:54 INFO - 2015-11-14 10:14:54,037 DEBUG : BROWSER_OUTPUT: 10:17:56 INFO - 2015-11-14 10:17:56,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52437/tests/dromaeo/cssquery-yui.html) 10:17:56 INFO - 2015-11-14 10:17:56,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 140615680 10:17:56 INFO - 2015-11-14 10:17:56,876 DEBUG : BROWSER_OUTPUT: 10:20:59 INFO - 2015-11-14 10:20:59,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/dromaeo/cssquery-yui.html (next: http://localhost:52437/tests/dromaeo/cssquery-dojo.html) 10:20:59 INFO - 2015-11-14 10:20:59,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 142966784 10:20:59 INFO - 2015-11-14 10:20:59,510 DEBUG : BROWSER_OUTPUT: 10:20:59 INFO - 2015-11-14 10:20:59,510 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:20:59 INFO - 2015-11-14 10:20:59,510 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:20:59 INFO - 2015-11-14 10:20:59,511 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:20:59 INFO - 2015-11-14 10:20:59,511 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:20:59 INFO - 2015-11-14 10:20:59,511 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3216.356728654269;3230.85461154248;3249.10649571368;3271.280318329968;3283.9983804939498;5384.057789886769;5400.729963501829;5438.184272359148;5451.999999999995;5466.098093814521;5318.335208098988;5403.83788486346;5492.972535137319;5526.640768350055;5528.087865502187;4976.228684553891;5025.271335656327;5102.938237057772;5104.719240441774;5111.6166287528395;4877.975610121945;4945.480724523927;4990.900181996358;4998.6750861193905;5016.47327030662;4878.219484882419;4978.128827455181;4995.55040046394;4997.525235102659;5000.199968005102;4905.583025442842;4980.178270585386;5041.949580504184;5050.292958985745;5053.671511351788;4937.777799998973;4969.950300497021;4978.6514943953935;4979.427365852937;5013.674111182761;5073.289739436482;5185.092608793446;5226.8693282667855;5353.812616558402;5355.794946137127;5961.344252132262;5984.581079324449;5988.131720900445;6000.369961154103;6001.2498437695285;5974.462298393122;6015.699215039274;6017.187679663233;6017.398260173992;6035.517158627299;5352.437994010612;5447.5641948644015;5455.563554915597;5458.317710286215;5613.691246981414;5951.434613711691;6037.909431358533;6054.303755068224;6060;6101.908471372933;5761.164631128463;5771.9711401443565;5781.797637082682;5832.1834943108;5885.087811389241;5739.799107031234;5796.507296879812;5801.042827933344;5803;5873.794417195378;5824.475797178275;5828.562857785599;5841.970790146022;5872.500837428781;5925.140854576062;5774.740136693859;5787.942120578825;5811.593188476766;5814.418558144152;5830.795922142789;4403.471583409947;4449.822007119679;4478.731276123443;4501.122281155209;4505.887352816206;4020.0954785173103;4043.433919251307;4050.4936882889638;4056.350983842571;4076.979615101965;5563.36021357541;5570.582206334541;5582;5617.550595952314;5622.240997465372;5784.1902133701315;5866.032104702762;5907.734151963172;5933.910991335133;6046.244219472566;5518.834434966958;5542;5552.639078459887;5556.611037227355;5601.719914004283;5045.217991211368;5069.695818250917;5089.541941225233;5097.439281679012;5120.078385890501;5804.506616937608;5933.3769954154195;6123.050927106306;6199.907001394983;6207.844803879939;5891.204687367151;5906.497947674496;5927.288725352985;5945.672987985702;5958.255218097738;5952.494038006645;6101.145839582551;6120.755169793337;6167.722452489738;6188.597741146811;5775.191473193672;5775.306963164448;5875.706214689334;5890.852728681817;5940.405959404025;5837.824865254049;5844.766209351578;5873.500752436091;5877.882442351214;5889.293284805679;5582.385937546947;5662.462066103713;5692.459216374438;5698.487136157766;5734;5694.1458781183155;5755.597108202385;5766.798162064308;5794.420557944172;5846.795362162304;5708.942910571007;5744.224529688606;5750.482456578928;5755.65466072037;5759.65442073477;5759.625624334405;5778.537716982715;5835.124731290341;5857.502112320501;5905.734241959036;5666.858328541819;5675.205471233948;5678.148277758204;5685.459881311269;5737.08206686928 10:20:59 INFO - 2015-11-14 10:20:59,512 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.5194756535598;599.7121381736767;606.551152147411;609.8810731907278;610.5054905526526;39259.80370098152;39274.80362598187;40187.79906100469;40238.396424053586;40316.19367612646;42077.36883946736;43011.784941075326;43079.78460107703;43218.783906080425;43255;8759.167879051496;8899.555022248895;8910.955445222764;8913.331500137483;8919.063498332678;8666.220040196382;8730.083341249172;8763.255123314526;8802.559872006374;8845.380823342368;8802.339824513156;8856.867146992769;8896.688615898445;8907.153820387053;8923.73228803137;8760.737177884674;8806.779830504225;8842.381033327669;8869.822603547926;8875.511846848422;8559.614817333235;8754.518501482416;8772.912270877274;8778.868316975251;8804.691835785718;40308.39537406941;40506.594934050576;40609.39085913714;40792.59207407918;40939.1812163758;3110.9533356999664;3205.1218422750603;3236.8543415546355;3250.2686895448337;3303.157694787838;29189.27026824325;29279.70720292791;29485.70514294851;29509.85245073761;29693.851530742424;3363;3402.387570237356;3409.7613167078316;3469.6877281044576;3531.940417874627;273199;274664;274670.999999998;275231;275925;41763.37354939678;42462.57537424586;42598.78700606477;55726;56074.71962640161;42006.78996605059;42057.94855128646;42096.15807683829;42205;42262.36606450906;12541.93729031349;12739.681507962376;12786.360681965865;12794.552190673281;12806.935965320301;10256.43589602579;10320.277580569438;10341.896581034094;10368.118709909591;10398.532066057045;14610.123392596266;14626.561203163923;14639.341229644691;14760;14790.8167346612;5859.121131830174;5922.851928701731;5998.700064996733;6006.429389208019;6035.107355755513;859.0378775771052;969.6121551379364;1002.9197664186847;1082.6048492300254;1122.93262404256;28639.856800715865;28745.85627071893;28947.7105228945;29061.85469072641;29244.268893277836;992.6029588164791;995.0646392391129;1000.7598176437602;1021.897810218987;1087.2280680716622;15162;15191.392344306325;15218.488949323239;15326.770098448533;15515.767263491056;329829;334433;334436;335022;336445;51001.744991274805;51260;51461.2280815788;51632.22551661728;51657.48342516602;1266.3415024187555;1274.8788865057804;1276.0939732789823;1310.1156719214491;1320.8679132086716;27868.442631147667;28799.5680064795;28838.42323153483;28846.278843029093;29044.7095529042;46399.3040104392;46633;46734.298985515925;46798;46960;306813;307018;308556;308621.2844678901;309000;46307.53692463032;46493.302600460345;46636.53363466458;46937.76531117323;47507;43413.565864340955;43491.17307375137;43988.7800561008;44610.10779784451;44738.77630611826;36348.27303453969;36779.26441471102;37115.44326835153;37420.251594967405;38399.616003839605;37189.62810371862;37582.8120859394;38200.2359952805;38247;38702.41946370863;36207.63792362148;36932.81533592315;36977;37170.8141459291;37247.81376093102;33613;36390.454143187344;37819.62180378161;37962.43056354212;38707.6129238704;25374.873125634254;25477.872610636827;26197.4760504785;26323.4735305289;26645.200643980712 10:20:59 INFO - 2015-11-14 10:20:59,516 DEBUG : BROWSER_OUTPUT: |2;jquery.html;326.9803811771294;332.5842696629214;334.61017914130036;336.2988169666246;337.9324135172966;12004.45979930903;12387;16558.254878530464;16733.163341832904;17822.198001089935;10854.023137917586;11067.225294229407;11094.112471002321;11241;11263.098952083834;4475.776211189435;4599.747013914233;4611;4613.723176609397;4623.722576645395;4477.507474177838;4541.65937554683;4554.111948170108;4554.385158003677;4573.7713114344315;4543.8182472701055;4552.749598772066;4576.97711511442;4657.347971284023;4688.953110468903;4599.931001034987;4687.9531204687855;4687.976560117212;4699.506551812062;4702.24764037754;4222.345536441856;4233.51314598822;4246.108317253381;4250.723702959298;4254.298040823261;13572.660683482893;13640.454381824815;13899.722005559934;13940;13960.511382101678;1843.75109360236;1937.903104844752;1959.6276707425543;2003.6601514648069;2011;10172.287939844215;10193.745156371077;10199.694009179662;10279.691609251735;10314.535845886952;1652.8099268584147;1707.598714302138;1723.9482815515555;1727.1795896948975;1746.6244757377224;55114;60174.39825601732;63173.68413157951;63752.681236593984;63756.043659345145;6734.6632668367365;6830.965845170742;6969.05917701114;6996.635656047022;7022.719091236293;8259.876101858477;8266.793330166794;8280.58597070144;8299.460535065202;8325.916740832636;5347.491988261109;5347.572194224453;5376.542993845489;5421.05131601976;5428.240046393508;5351.678899266057;5377.085895397791;5422.186671999231;5432.103702889058;5483.095289277225;3242.1084201844683;3242.416365054313;3269.3297873935785;3290.2596915693775;3303.669633036677;1092.5575142067476;1110.6334909479851;1119.5242022140558;1121.4504892602565;1150.551284998851;375.0548617483925;381.32505465326216;381.88161669882425;393.7873548283895;414.14892396125646;10091.344062635904;10399.220058495643;10445.895541044645;10671.626493072861;10692.411917344465;402.7965877231979;403.24794258707885;410.14484799194014;420.81063521415484;436.0211325574043;5550.972245138829;5827.562932780059;6104.38956104386;6460.063290822804;6462.644554549451;491191;493818;499186;511529;512440;75939.62030189813;76351;77318;77498;79189;516.5789881246772;518.0467938992197;518.5022378516591;518.5048278893723;518.8261932252738;10792.406417647106;11062.391568463812;11140.275882067639;11171.162162837658;11202.88797112051;31318.843405782824;31508.369832602762;32183.195420114684;32894.1776455581;33125.66874331226;40868.386974194815;41046.1790764189;41745.16509669729;42328.57671423246;42536.57463425326;6537.084808126771;6803.829904252433;6807.523473356818;6820.420264277592;6839.692213850488;11780.293182409083;11896.881031189923;12113.454894529592;12174.147809653594;12245.89786919146;10062.195024397884;10447;10477.633282835064;10497.2127090467;10554.736131596772;9968.202543796624;10249.897501025192;10364.689059328231;10442.947785261329;10519.053285204369;10516.631917882838;10572.259941803999;10579.788404231718;10650.254482186172;10702.250842440955;6624.370684784938;6671.432928201158;6800.727970881109;6832.931670683429;6838.658067096526;10450.529726162189;10735.94632026835;10798.082163015917;10835.241533092609;10874.619388321371 10:20:59 INFO - 2015-11-14 10:20:59,519 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1511.8714909232715;1681.7309230523115;1727.9654406911861;1732.5668582854291;1740.24299429748;6149.815505534841;6200.224971878515;7500.624968751561;7698.384129269666;7745.573993430359;7328.487005909588;7423.257674232587;7486.251374862524;7514.96242518788;7559.546427214371;2189.627763280246;2222.744384395791;2228.8774117423536;2235.7540670526228;2236.6756820261053;2224.944376390587;2231.0964059555904;2304.2741536415974;2313.4794671199015;2318.6290193569034;2081.2299449203815;2115.7566879808865;2129.7018417421573;2130.424785307966;2168.067730875731;2237.1722462688745;2240.316703405461;2255.76314486979;2276.658501224813;2277.703898493202;2075.5122546201633;2112.0812446585783;2119.9258025969016;2126.3514628038442;2126.3620913725977;7342.853142937111;7373.373263272628;7389.039424874785;7402;7402.777916662509;4512.932306015412;4543.363929049936;4568.88577785558;4590.724556526619;4600;2906.1426879070723;2936.3686807336526;2936.7063293670676;2950.867210975511;2968.584398184256;921.8064206516573;929.4609126706493;938.1134827587932;966.5747071288611;977.1157102821886;10132.746681333025;10195.541200645988;10202.285839991204;10290.897091029143;10296.948515257376;4011.5988401159652;4058.5332686740812;4075.0627355708352;4118.9588104119175;4121.876343709693;8436.156384361515;8439.578021099043;8443.788905277293;8447.23974842255;8450.746477605682;4544.500104988449;4574.83988060423;4593.724376537419;4594.793234304398;4612.192866248461;4200.894977625584;4217.219814334297;4254.532001479834;4260.318349064135;4271;3280.7867488613642;3310.337932413527;3323.651016643266;3340;3354.4297469429766;1027.7584767579613;1032.5972870580479;1036.9688909332733;1038.5326603028668;1049.4280617063719;1015.0762805846645;1023.8464230365356;1046.0742243114746;1163.953441862333;1327.8605746396684;7096.290370962863;7214.422846172293;7216.278372162847;7245.529040612343;7245.89131163033;492.5911493460419;492.97781599828096;498.8902441462872;499.1464595541592;503.7456084677288;5531.9723401382735;5541.085720856095;5549.112142057252;5562.666240025612;5593.188987596775;8471.618777155043;8718.128187181357;8740.125987401208;8794.208521232991;8802.427842190365;8747.16901894319;8751.343649226334;8841.69054083104;8864.822703545893;8879.023307436177;6731.360520750521;6859.965700171567;6883.3116688330765;6960.095187625576;6969.9303006969285;6906.930930690629;6962.025316455802;6981.965090174516;7011.6494175292055;7021.508494405342;7737.342325902361;7929.762107136795;7937.642806073625;8061.234182752629;8082.110967793656;8006.679732810622;8193.426460147732;8217.465864718773;8219.794505137419;8262.42163048581;6667.19993600771;6738.797836064926;6923.688434020582;6928.861422771415;6936.167659880846;7425.108986921604;7438.925610743823;7444.962775186306;7445.441591880739;7453.776386708408;6830;6963.7562685305775;6985.406240469617;7028.753993610199;7039.859202816017;6669.633170175687;6698.464122870061;6699.095622090956;6736.259011508632;6840.760573379908;6650.301718319701;6785.117934668659;6797.28628494001;6800.863982720219;6880.346367095118;6400.103985442135;6442.677866106769;6483.994980777987;6508.8047358579315;6530.379613936669;6410.551261411656;6449.3873082057125;6538.771143009972;6539.6076235424125;6552.082708420729 10:20:59 INFO - 2015-11-14 10:20:59,519 DEBUG : BROWSER_OUTPUT: |4;prototype.html;287.06989354491446;287.9021132814843;294.86288875672795;295.11906957731156;301.27092436304144;6279.591826531272;6296.307406185316;6330.620162790236;6388.233411990562;6508.576942498734;6251.312355640887;6324.525660575464;6358.777442789503;6363.968180159104;6374.139491168691;4692.460367057781;4700.55344742249;4705.270683044134;4710.128626204146;4710.90578188436;4706.976465117669;4711.717296962176;4713.43438787346;4720.150372932871;4726.0547890421885;4586.243269860469;4658.534146585348;4663.3937588113495;4679.578837904588;4680.836170734025;4647.581717645428;4647.837325693618;4653.697509661861;4657.51096134906;4667.766611669437;3954.228925359556;3955.7626542407547;3959.8812035638975;3963.0290578808376;3966.226585815767;6006.489448396892;6039.547033972426;6056.666883321415;6062.42406971337;6068.57519973602;5246.554042906358;5401.918971215435;5405.405405405402;5408.296921400193;5426.375966763833;6710.865782684368;6718.764843230512;6730.562513436611;6761.830954226134;6770.559913605649;4346.174226896911;4385.364122202294;4393.780310984438;4394.362817391492;4408.030233348658;6771.255161932184;6888.724451021953;6921.792346229571;6936.410405115571;7038.859222815515;4379.167958087953;4390.824367025347;4395.494518130456;4405.911881762411;4406.62543683784;4455.888602784957;4457.8439754608435;4462.419885414875;4463.933041004388;4473.373727678128;5340.412554618989;5340.49265319794;5341.973290133602;5348.598855085884;5359.062164121341;6681.164854393201;6747.257801641816;6771.762988295386;6794.626295553693;6815.386615204656;1535.4702627593463;1561.6017915431719;1569.897956632838;1570.0658108425696;1570.583795294248;1001.2790790630734;1007.3804610164696;1008.4403156248206;1009.1271050541229;1016.9796604067877;6389.552731308764;6407.839804004937;6424.229092508929;6425.903611445832;6442.387973142544;6830.453563714891;6899.448044156456;6930;6933.68798404073;6942.757003504853;6250.15622890913;6352.936470635234;6356.713947872357;6395.52033597482;6396.712147953353;3752.380857158593;3755.2677227940835;3764.265968136187;3782.7541209821275;3806.2197249563774;7163.31948464895;7179.246179151114;7209.855802883913;7217.566945983152;7218.422526197892;7048.612326321999;7073.398761105261;7101.183363913113;7112.786616401516;7132.857342853217;7271.818204544823;7334.706611735471;7350.08123984502;7357.963210184022;7396.963015184997;7037.859242815218;7073.115860517435;7082;7084.539504932163;7121.6439178039855;6826.112605361272;6946.583205007716;6946.8610627788175;6954.3393377629045;6956.37392634645;7263.34629883313;7319.451041171827;7353.338199562065;7355.190928997913;7356.154042285206;4458.461830668414;4473.5526447355005;4483.372327874035;4483.484399294123;4516.187086324493;6942.2363540011565;6997.230304666585;7027;7047.224805271519;7057.294270572902;6830.214525329452;6836.589804611739;6861.313868613099;6861.348171923659;6869.450443964371;6844.726210951506;6850.486213533905;6852.040714300102;6856.177258728984;6862.210845752802;6437.903431448625;6636.402723754885;6707.463402927851;6720.462363011045;6723.495737819585;6844.28135045813;6865.450763938973;6866.896996544956;6907.758228461979;6911.3779759821855;6572.7042283098335;6640.734370625121;6677.399034086956;6677.499187560855;6679.432248258952 10:20:59 INFO - 2015-11-14 10:20:59,519 DEBUG : BROWSER_OUTPUT: |5;yui.html;702.0872865275147;724.967376468059;824.1826771967811;846.8137009857829;873.0352959979223;13066.150700204493;13268.270245136513;13373.799393009089;13417.06080574359;13471.73056538871;12550.560730374438;12883.806742898863;13241.536546220885;13428.127171733831;13431.462741490353;785.2893131715792;798.480987358219;801.1707882341777;801.2748462641318;801.310872649521;788.7081779741503;796.9242921922408;797.5493845977034;798.8881556582083;801.6032064128265;816.2979837339913;828.8756686497044;829.6598394658191;830.4560512864053;831.6756464978663;803.9839203215932;815.955122468264;816.3183741575791;817.5421763812254;821.7657967479299;602.6203491800181;603.2369053147771;604.2597817673314;604.4559896093507;605.893968555501;12251.387430628432;12313.630591082281;12380.938095309466;12391.93804030974;12399.814002789966;10945.179111566586;10945.398003109825;10947.178961577834;11314.943425282903;11329.943350283278;8905.421147625448;9102.362834601581;9112.134347237068;9177.587008584629;9197.310201734897;3288.2272665923488;3396.252824378633;3396.3037577296595;3430.6397828227928;3508.28080243552;41105.383419248436;41424;47376.5262347379;47531;47914.281285780744;10100.242481813893;10167;10173.389596624078;10377.896221037843;10474.895251047545;18494.81505184958;18588.349407770933;18599.53501162482;18600.255989760528;18624;6808.6255255960405;6881.621510816954;6933.445324374038;6998.930010699828;7091.1490621125795;4417.425734654475;4450.310201918708;4578.107269082497;4619.076184763061;4660.161170989254;3000.924976875596;3005.4590173768934;3015.7135072168107;3015.8190508569555;3044.375902939892;457.2797843396664;460.59927862758946;466.8226074091891;470.7457972694775;471.24130150457734;540.5756481162348;615.0808342589164;633.9270983836825;658.9308122647149;704.4927652090487;8457.830843383097;8580.871286930702;8688.348373871984;8703.521306328086;9047.954760226157;533.3812777178455;543.7661805423627;571.3058633760002;698.6122701900495;704.6371118873784;3795.791231482295;3893.2213557288655;3927.113571524927;3972.8609498667406;4056.20903923732;59475.405245947855;60118.69940650269;60161.39838601645;60184.777826661084;61352.69323653353;54122.72938635282;54274;55146.44853551413;55238.447615524135;55314.446855531736;47146.5285347149;49144.50855491471;50121.24818127731;50538.241926371134;55195.72402138044;8287.12985136552;8339.874901876598;8344.749657510285;8360.247577718035;8505.617247224014;34183.4872476918;34498.137546561535;34849.65150348464;35023.29953400969;35795.284094318486;40912.79543602263;45211;45359;45812.770936145105;46025;10655.210736943729;10803.189760767817;10911.618093366695;11226.55093796239;11280.717982050515;11282.605108821152;11634.825477617673;11836.644900652995;12105;13003.869961300645;11317.207795454238;11577.363245021268;11719.121065919919;11934.522619095485;12004.519819207135;10719.946400267949;11332.6033588824;11689.590864319707;11693.941530292293;12246.081543884065;11334.716632084264;11566.768664626492;11682.24065435744;11881.881181188422;11906.642800715992;9515.619375225191;9595;9808.068233517804;10065.69802905914;10128.797424051625;8358.791030224293;9113.954430227806;9375.156235938799;9379.437233765995;9455.479948602893 10:20:59 INFO - 2015-11-14 10:20:59,520 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:20:59 INFO - 2015-11-14 10:20:59,520 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:20:59 INFO - 2015-11-14 10:20:59,520 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,268 10:20:59 INFO - 2015-11-14 10:20:59,520 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:20:59 INFO - 2015-11-14 10:20:59,520 DEBUG : BROWSER_OUTPUT: __startTimestamp1447525259508__endTimestamp 10:20:59 INFO - 2015-11-14 10:20:59,520 DEBUG : BROWSER_OUTPUT: 10:20:59 INFO - 2015-11-14 10:20:59,521 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:20:59 INFO - 2015-11-14 10:20:59,521 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:20:59 INFO - 2015-11-14 10:20:59,521 DEBUG : BROWSER_OUTPUT: 10:20:59 INFO - 2015-11-14 10:20:59,521 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5463.42 Median:5694.15 stddev:620.02 (10.9%) stddev-sans-first:596.33 10:20:59 INFO - 2015-11-14 10:20:59,521 DEBUG : BROWSER_OUTPUT: Values: 3216.4 3230.9 3249.1 3271.3 3284.0 5384.1 5400.7 5438.2 5452.0 5466.1 5318.3 5403.8 5493.0 5526.6 5528.1 4976.2 5025.3 5102.9 5104.7 5111.6 4878.0 4945.5 4990.9 4998.7 5016.5 4878.2 4978.1 4995.6 4997.5 5000.2 4905.6 4980.2 5041.9 5050.3 5053.7 4937.8 4970.0 4978.7 4979.4 5013.7 5073.3 5185.1 5226.9 5353.8 5355.8 5961.3 5984.6 5988.1 6000.4 6001.2 5974.5 6015.7 6017.2 6017.4 6035.5 5352.4 5447.6 5455.6 5458.3 5613.7 5951.4 6037.9 6054.3 6060.0 6101.9 5761.2 5772.0 5781.8 5832.2 5885.1 5739.8 5796.5 5801.0 5803.0 5873.8 5824.5 5828.6 5842.0 5872.5 5925.1 5774.7 5787.9 5811.6 5814.4 5830.8 4403.5 4449.8 4478.7 4501.1 4505.9 4020.1 4043.4 4050.5 4056.4 4077.0 5563.4 5570.6 5582.0 5617.6 5622.2 5784.2 5866.0 5907.7 5933.9 6046.2 5518.8 5542.0 5552.6 5556.6 5601.7 5045.2 5069.7 5089.5 5097.4 5120.1 5804.5 5933.4 6123.1 6199.9 6207.8 5891.2 5906.5 5927.3 5945.7 5958.3 5952.5 6101.1 6120.8 6167.7 6188.6 5775.2 5775.3 5875.7 5890.9 5940.4 5837.8 5844.8 5873.5 5877.9 5889.3 5582.4 5662.5 5692.5 5698.5 5734.0 5694.1 5755.6 5766.8 5794.4 5846.8 5708.9 5744.2 5750.5 5755.7 5759.7 5759.6 5778.5 5835.1 5857.5 5905.7 5666.9 5675.2 5678.1 5685.5 5737.1 10:20:59 INFO - 2015-11-14 10:20:59,521 DEBUG : BROWSER_OUTPUT: 10:20:59 INFO - 2015-11-14 10:20:59,521 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47074.29 Median:38081.33 stddev:80190.69 (210.6%) stddev-sans-first:80339.58 10:20:59 INFO - 2015-11-14 10:20:59,522 DEBUG : BROWSER_OUTPUT: Values: 555.5 599.7 606.6 609.9 610.5 39259.8 39274.8 40187.8 40238.4 40316.2 42077.4 43011.8 43079.8 43218.8 43255.0 8759.2 8899.6 8911.0 8913.3 8919.1 8666.2 8730.1 8763.3 8802.6 8845.4 8802.3 8856.9 8896.7 8907.2 8923.7 8760.7 8806.8 8842.4 8869.8 8875.5 8559.6 8754.5 8772.9 8778.9 8804.7 40308.4 40506.6 40609.4 40792.6 40939.2 3111.0 3205.1 3236.9 3250.3 3303.2 29189.3 29279.7 29485.7 29509.9 29693.9 3363.0 3402.4 3409.8 3469.7 3531.9 273199.0 274664.0 274671.0 275231.0 275925.0 41763.4 42462.6 42598.8 55726.0 56074.7 42006.8 42057.9 42096.2 42205.0 42262.4 12541.9 12739.7 12786.4 12794.6 12806.9 10256.4 10320.3 10341.9 10368.1 10398.5 14610.1 14626.6 14639.3 14760.0 14790.8 5859.1 5922.9 5998.7 6006.4 6035.1 859.0 969.6 1002.9 1082.6 1122.9 28639.9 28745.9 28947.7 29061.9 29244.3 992.6 995.1 1000.8 1021.9 1087.2 15162.0 15191.4 15218.5 15326.8 15515.8 329829.0 334433.0 334436.0 335022.0 336445.0 51001.7 51260.0 51461.2 51632.2 51657.5 1266.3 1274.9 1276.1 1310.1 1320.9 27868.4 28799.6 28838.4 28846.3 29044.7 46399.3 46633.0 46734.3 46798.0 46960.0 306813.0 307018.0 308556.0 308621.3 309000.0 46307.5 46493.3 46636.5 46937.8 47507.0 43413.6 43491.2 43988.8 44610.1 44738.8 36348.3 36779.3 37115.4 37420.3 38399.6 37189.6 37582.8 38200.2 38247.0 38702.4 36207.6 36932.8 36977.0 37170.8 37247.8 33613.0 36390.5 37819.6 37962.4 38707.6 25374.9 25477.9 26197.5 26323.5 26645.2 10:20:59 INFO - 2015-11-14 10:20:59,523 DEBUG : BROWSER_OUTPUT: 10:20:59 INFO - 2015-11-14 10:20:59,523 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25494.91 Median:20639.27 stddev:82339.19 (398.9%) stddev-sans-first:82548.48 10:20:59 INFO - 2015-11-14 10:20:59,524 DEBUG : BROWSER_OUTPUT: Values: 327.0 332.6 334.6 336.3 337.9 12004.5 12387.0 16558.3 16733.2 17822.2 10854.0 11067.2 11094.1 11241.0 11263.1 4475.8 4599.7 4611.0 4613.7 4623.7 4477.5 4541.7 4554.1 4554.4 4573.8 4543.8 4552.7 4577.0 4657.3 4689.0 4599.9 4688.0 4688.0 4699.5 4702.2 4222.3 4233.5 4246.1 4250.7 4254.3 13572.7 13640.5 13899.7 13940.0 13960.5 1843.8 1937.9 1959.6 2003.7 2011.0 10172.3 10193.7 10199.7 10279.7 10314.5 1652.8 1707.6 1723.9 1727.2 1746.6 55114.0 60174.4 63173.7 63752.7 63756.0 6734.7 6831.0 6969.1 6996.6 7022.7 8259.9 8266.8 8280.6 8299.5 8325.9 5347.5 5347.6 5376.5 5421.1 5428.2 5351.7 5377.1 5422.2 5432.1 5483.1 3242.1 3242.4 3269.3 3290.3 3303.7 1092.6 1110.6 1119.5 1121.5 1150.6 375.1 381.3 381.9 393.8 414.1 10091.3 10399.2 10445.9 10671.6 10692.4 402.8 403.2 410.1 420.8 436.0 5551.0 5827.6 6104.4 6460.1 6462.6 491191.0 493818.0 499186.0 511529.0 512440.0 75939.6 76351.0 77318.0 77498.0 79189.0 516.6 518.0 518.5 518.5 518.8 10792.4 11062.4 11140.3 11171.2 11202.9 31318.8 31508.4 32183.2 32894.2 33125.7 40868.4 41046.2 41745.2 42328.6 42536.6 6537.1 6803.8 6807.5 6820.4 6839.7 11780.3 11896.9 12113.5 12174.1 12245.9 10062.2 10447.0 10477.6 10497.2 10554.7 9968.2 10249.9 10364.7 10442.9 10519.1 10516.6 10572.3 10579.8 10650.3 10702.3 6624.4 6671.4 6800.7 6832.9 6838.7 10450.5 10735.9 10798.1 10835.2 10874.6 10:20:59 INFO - 2015-11-14 10:20:59,525 DEBUG : BROWSER_OUTPUT: 10:20:59 INFO - 2015-11-14 10:20:59,525 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5238.07 Median:6466.69 stddev:2715.00 (42.0%) stddev-sans-first:2708.17 10:20:59 INFO - 2015-11-14 10:20:59,527 DEBUG : BROWSER_OUTPUT: Values: 1511.9 1681.7 1728.0 1732.6 1740.2 6149.8 6200.2 7500.6 7698.4 7745.6 7328.5 7423.3 7486.3 7515.0 7559.5 2189.6 2222.7 2228.9 2235.8 2236.7 2224.9 2231.1 2304.3 2313.5 2318.6 2081.2 2115.8 2129.7 2130.4 2168.1 2237.2 2240.3 2255.8 2276.7 2277.7 2075.5 2112.1 2119.9 2126.4 2126.4 7342.9 7373.4 7389.0 7402.0 7402.8 4512.9 4543.4 4568.9 4590.7 4600.0 2906.1 2936.4 2936.7 2950.9 2968.6 921.8 929.5 938.1 966.6 977.1 10132.7 10195.5 10202.3 10290.9 10296.9 4011.6 4058.5 4075.1 4119.0 4121.9 8436.2 8439.6 8443.8 8447.2 8450.7 4544.5 4574.8 4593.7 4594.8 4612.2 4200.9 4217.2 4254.5 4260.3 4271.0 3280.8 3310.3 3323.7 3340.0 3354.4 1027.8 1032.6 1037.0 1038.5 1049.4 1015.1 1023.8 1046.1 1164.0 1327.9 7096.3 7214.4 7216.3 7245.5 7245.9 492.6 493.0 498.9 499.1 503.7 5532.0 5541.1 5549.1 5562.7 5593.2 8471.6 8718.1 8740.1 8794.2 8802.4 8747.2 8751.3 8841.7 8864.8 8879.0 6731.4 6860.0 6883.3 6960.1 6969.9 6906.9 6962.0 6982.0 7011.6 7021.5 7737.3 7929.8 7937.6 8061.2 8082.1 8006.7 8193.4 8217.5 8219.8 8262.4 6667.2 6738.8 6923.7 6928.9 6936.2 7425.1 7438.9 7445.0 7445.4 7453.8 6830.0 6963.8 6985.4 7028.8 7039.9 6669.6 6698.5 6699.1 6736.3 6840.8 6650.3 6785.1 6797.3 6800.9 6880.3 6400.1 6442.7 6484.0 6508.8 6530.4 6410.6 6449.4 6538.8 6539.6 6552.1 10:20:59 INFO - 2015-11-14 10:20:59,527 DEBUG : BROWSER_OUTPUT: 10:20:59 INFO - 2015-11-14 10:20:59,528 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5568.50 Median:6381.19 stddev:1775.91 (27.8%) stddev-sans-first:1736.09 10:20:59 INFO - 2015-11-14 10:20:59,529 DEBUG : BROWSER_OUTPUT: Values: 287.1 287.9 294.9 295.1 301.3 6279.6 6296.3 6330.6 6388.2 6508.6 6251.3 6324.5 6358.8 6364.0 6374.1 4692.5 4700.6 4705.3 4710.1 4710.9 4707.0 4711.7 4713.4 4720.2 4726.1 4586.2 4658.5 4663.4 4679.6 4680.8 4647.6 4647.8 4653.7 4657.5 4667.8 3954.2 3955.8 3959.9 3963.0 3966.2 6006.5 6039.5 6056.7 6062.4 6068.6 5246.6 5401.9 5405.4 5408.3 5426.4 6710.9 6718.8 6730.6 6761.8 6770.6 4346.2 4385.4 4393.8 4394.4 4408.0 6771.3 6888.7 6921.8 6936.4 7038.9 4379.2 4390.8 4395.5 4405.9 4406.6 4455.9 4457.8 4462.4 4463.9 4473.4 5340.4 5340.5 5342.0 5348.6 5359.1 6681.2 6747.3 6771.8 6794.6 6815.4 1535.5 1561.6 1569.9 1570.1 1570.6 1001.3 1007.4 1008.4 1009.1 1017.0 6389.6 6407.8 6424.2 6425.9 6442.4 6830.5 6899.4 6930.0 6933.7 6942.8 6250.2 6352.9 6356.7 6395.5 6396.7 3752.4 3755.3 3764.3 3782.8 3806.2 7163.3 7179.2 7209.9 7217.6 7218.4 7048.6 7073.4 7101.2 7112.8 7132.9 7271.8 7334.7 7350.1 7358.0 7397.0 7037.9 7073.1 7082.0 7084.5 7121.6 6826.1 6946.6 6946.9 6954.3 6956.4 7263.3 7319.5 7353.3 7355.2 7356.2 4458.5 4473.6 4483.4 4483.5 4516.2 6942.2 6997.2 7027.0 7047.2 7057.3 6830.2 6836.6 6861.3 6861.3 6869.5 6844.7 6850.5 6852.0 6856.2 6862.2 6437.9 6636.4 6707.5 6720.5 6723.5 6844.3 6865.5 6866.9 6907.8 6911.4 6572.7 6640.7 6677.4 6677.5 6679.4 10:20:59 INFO - 2015-11-14 10:20:59,529 DEBUG : BROWSER_OUTPUT: 10:20:59 INFO - 2015-11-14 10:20:59,530 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13888.65 Median:2563.49 stddev:16514.28 (644.2%) stddev-sans-first:16530.91 10:20:59 INFO - 2015-11-14 10:20:59,530 DEBUG : BROWSER_OUTPUT: Values: 702.1 725.0 824.2 846.8 873.0 13066.2 13268.3 13373.8 13417.1 13471.7 12550.6 12883.8 13241.5 13428.1 13431.5 785.3 798.5 801.2 801.3 801.3 788.7 796.9 797.5 798.9 801.6 816.3 828.9 829.7 830.5 831.7 804.0 816.0 816.3 817.5 821.8 602.6 603.2 604.3 604.5 605.9 12251.4 12313.6 12380.9 12391.9 12399.8 10945.2 10945.4 10947.2 11314.9 11329.9 8905.4 9102.4 9112.1 9177.6 9197.3 3288.2 3396.3 3396.3 3430.6 3508.3 41105.4 41424.0 47376.5 47531.0 47914.3 10100.2 10167.0 10173.4 10377.9 10474.9 18494.8 18588.3 18599.5 18600.3 18624.0 6808.6 6881.6 6933.4 6998.9 7091.1 4417.4 4450.3 4578.1 4619.1 4660.2 3000.9 3005.5 3015.7 3015.8 3044.4 457.3 460.6 466.8 470.7 471.2 540.6 615.1 633.9 658.9 704.5 8457.8 8580.9 8688.3 8703.5 9048.0 533.4 543.8 571.3 698.6 704.6 3795.8 3893.2 3927.1 3972.9 4056.2 59475.4 60118.7 60161.4 60184.8 61352.7 54122.7 54274.0 55146.4 55238.4 55314.4 47146.5 49144.5 50121.2 50538.2 55195.7 8287.1 8339.9 8344.7 8360.2 8505.6 34183.5 34498.1 34849.7 35023.3 35795.3 40912.8 45211.0 45359.0 45812.8 46025.0 10655.2 10803.2 10911.6 11226.6 11280.7 11282.6 11634.8 11836.6 12105.0 13003.9 11317.2 11577.4 11719.1 11934.5 12004.5 10719.9 11332.6 11689.6 11693.9 12246.1 11334.7 11566.8 11682.2 11881.9 11906.6 9515.6 9595.0 9808.1 10065.7 10128.8 8358.8 9114.0 9375.2 9379.4 9455.5 10:20:59 INFO - 2015-11-14 10:20:59,530 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:20:59 INFO - 2015-11-14 10:20:59,531 DEBUG : BROWSER_OUTPUT: 10:21:00 INFO - 2015-11-14 10:21:00,185 INFO : Browser exited with error code: 0 10:21:00 INFO - 2015-11-14 10:21:00,207 INFO : Completed test dromaeo_css (00:18:30) 10:21:00 INFO - 2015-11-14 10:21:00,207 INFO : Starting test kraken 10:21:00 INFO - 2015-11-14 10:21:00,207 DEBUG : operating with platform_type : linux_ 10:21:00 INFO - 2015-11-14 10:21:00,207 INFO : Initialising browser for kraken test... 10:21:00 INFO - 2015-11-14 10:21:00,213 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMO8aKD/profile http://localhost:52437/getInfo.html 10:21:04 INFO - 2015-11-14 10:21:04,901 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:21:04 INFO - 2015-11-14 10:21:04,902 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:21:04 INFO - 2015-11-14 10:21:04,902 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:21:04 INFO - 2015-11-14 10:21:04,902 DEBUG : BROWSER_OUTPUT: __metrics 10:21:05 INFO - 2015-11-14 10:21:05,909 INFO : Browser initialized. 10:21:05 INFO - 2015-11-14 10:21:05,910 INFO : Running cycle 1/1 for kraken test... 10:21:05 INFO - 2015-11-14 10:21:05,910 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMO8aKD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:21:17 INFO - 2015-11-14 10:21:17,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 140898304 10:21:17 INFO - 2015-11-14 10:21:17,674 DEBUG : BROWSER_OUTPUT: 10:21:20 INFO - 2015-11-14 10:21:20,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52437/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:20 INFO - 2015-11-14 10:21:20,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 141443072 10:21:20 INFO - 2015-11-14 10:21:20,746 DEBUG : BROWSER_OUTPUT: 10:21:23 INFO - 2015-11-14 10:21:23,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52437/tests/kraken/driver.html?testName=audio-dft) 10:21:23 INFO - 2015-11-14 10:21:23,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 141692928 10:21:23 INFO - 2015-11-14 10:21:23,978 DEBUG : BROWSER_OUTPUT: 10:21:26 INFO - 2015-11-14 10:21:26,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52437/tests/kraken/driver.html?testName=audio-fft) 10:21:27 INFO - 2015-11-14 10:21:27,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 136810496 10:21:27 INFO - 2015-11-14 10:21:27,397 DEBUG : BROWSER_OUTPUT: 10:21:29 INFO - 2015-11-14 10:21:29,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52437/tests/kraken/driver.html?testName=audio-oscillator) 10:21:29 INFO - 2015-11-14 10:21:29,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 136749056 10:21:29 INFO - 2015-11-14 10:21:29,984 DEBUG : BROWSER_OUTPUT: 10:21:32 INFO - 2015-11-14 10:21:32,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:21:32 INFO - 2015-11-14 10:21:32,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 137498624 10:21:32 INFO - 2015-11-14 10:21:32,743 DEBUG : BROWSER_OUTPUT: 10:21:35 INFO - 2015-11-14 10:21:35,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52437/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:36 INFO - 2015-11-14 10:21:36,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 137822208 10:21:36 INFO - 2015-11-14 10:21:36,361 DEBUG : BROWSER_OUTPUT: 10:21:39 INFO - 2015-11-14 10:21:39,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52437/tests/kraken/driver.html?testName=imaging-desaturate) 10:21:40 INFO - 2015-11-14 10:21:40,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 139104256 10:21:40 INFO - 2015-11-14 10:21:40,357 DEBUG : BROWSER_OUTPUT: 10:21:43 INFO - 2015-11-14 10:21:43,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52437/tests/kraken/driver.html?testName=json-parse-financial) 10:21:43 INFO - 2015-11-14 10:21:43,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 139296768 10:21:43 INFO - 2015-11-14 10:21:43,769 DEBUG : BROWSER_OUTPUT: 10:21:45 INFO - 2015-11-14 10:21:45,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:21:45 INFO - 2015-11-14 10:21:45,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 138158080 10:21:45 INFO - 2015-11-14 10:21:45,932 DEBUG : BROWSER_OUTPUT: 10:21:47 INFO - 2015-11-14 10:21:47,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52437/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:21:48 INFO - 2015-11-14 10:21:48,349 DEBUG : BROWSER_OUTPUT: RSS: Main: 139374592 10:21:48 INFO - 2015-11-14 10:21:48,350 DEBUG : BROWSER_OUTPUT: 10:21:50 INFO - 2015-11-14 10:21:50,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:51 INFO - 2015-11-14 10:21:51,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 138510336 10:21:51 INFO - 2015-11-14 10:21:51,036 DEBUG : BROWSER_OUTPUT: 10:21:53 INFO - 2015-11-14 10:21:53,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:54 INFO - 2015-11-14 10:21:54,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 138334208 10:21:54 INFO - 2015-11-14 10:21:54,051 DEBUG : BROWSER_OUTPUT: 10:21:56 INFO - 2015-11-14 10:21:56,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:57 INFO - 2015-11-14 10:21:57,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 138936320 10:21:57 INFO - 2015-11-14 10:21:57,198 DEBUG : BROWSER_OUTPUT: 10:21:58 INFO - 2015-11-14 10:21:58,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52437/tests/kraken/driver.html?testName=ai-astar) 10:21:59 INFO - 2015-11-14 10:21:59,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 138354688 10:21:59 INFO - 2015-11-14 10:21:59,122 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,126 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:21:59 INFO - 2015-11-14 10:21:59,126 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:21:59 INFO - 2015-11-14 10:21:59,126 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:21:59 INFO - 2015-11-14 10:21:59,126 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:21:59 INFO - 2015-11-14 10:21:59,126 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;111;112;114;122;111;112;111;112 10:21:59 INFO - 2015-11-14 10:21:59,126 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;129;152;166;127;147;157;136;167;127 10:21:59 INFO - 2015-11-14 10:21:59,126 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;160;162;161;162;164;172;162 10:21:59 INFO - 2015-11-14 10:21:59,126 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;74;73;72;144;73;72;72 10:21:59 INFO - 2015-11-14 10:21:59,126 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;130;90;91;91;139;90;90;137 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;109;111;110;110;110 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;152;146;146;146;146;148;146;146;146;147 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;97;96;96;98;96;96;96;96 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;62;62;63;61;62;61;60;65;59 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;70;67;68;68;67;68;67 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;87;84;87;84;86;87;85;86 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;117;135;120;121;119;124;121;129;115 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;148;158;147;156;149;143;148;147;147 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;69;69;68;66;72;67;66;67;65 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,707 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: __startTimestamp1447525319124__endTimestamp 10:21:59 INFO - 2015-11-14 10:21:59,127 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,131 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:21:59 INFO - 2015-11-14 10:21:59,131 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:21:59 INFO - 2015-11-14 10:21:59,131 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,132 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:3.97 (3.5%) stddev-sans-first:4.21 10:21:59 INFO - 2015-11-14 10:21:59,132 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 111.0 112.0 114.0 122.0 111.0 112.0 111.0 112.0 10:21:59 INFO - 2015-11-14 10:21:59,132 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,132 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.10 Median:152.50 stddev:15.49 (10.2%) stddev-sans-first:16.22 10:21:59 INFO - 2015-11-14 10:21:59,132 DEBUG : BROWSER_OUTPUT: Values: 153.0 129.0 152.0 166.0 127.0 147.0 157.0 136.0 167.0 127.0 10:21:59 INFO - 2015-11-14 10:21:59,132 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,132 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:3.43 (2.1%) stddev-sans-first:3.59 10:21:59 INFO - 2015-11-14 10:21:59,132 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 160.0 162.0 161.0 162.0 164.0 172.0 162.0 10:21:59 INFO - 2015-11-14 10:21:59,133 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,133 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.70 Median:72.50 stddev:22.60 (31.2%) stddev-sans-first:23.80 10:21:59 INFO - 2015-11-14 10:21:59,133 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 74.0 73.0 72.0 144.0 73.0 72.0 72.0 10:21:59 INFO - 2015-11-14 10:21:59,133 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,133 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.90 Median:90.00 stddev:21.81 (24.2%) stddev-sans-first:22.63 10:21:59 INFO - 2015-11-14 10:21:59,133 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 130.0 90.0 91.0 91.0 139.0 90.0 90.0 137.0 10:21:59 INFO - 2015-11-14 10:21:59,133 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,134 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 10:21:59 INFO - 2015-11-14 10:21:59,134 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 109.0 111.0 110.0 110.0 110.0 10:21:59 INFO - 2015-11-14 10:21:59,134 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,134 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:146.00 stddev:1.91 (1.3%) stddev-sans-first:0.71 10:21:59 INFO - 2015-11-14 10:21:59,134 DEBUG : BROWSER_OUTPUT: Values: 152.0 146.0 146.0 146.0 146.0 148.0 146.0 146.0 146.0 147.0 10:21:59 INFO - 2015-11-14 10:21:59,134 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,134 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 10:21:59 INFO - 2015-11-14 10:21:59,135 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 97.0 96.0 96.0 98.0 96.0 96.0 96.0 96.0 10:21:59 INFO - 2015-11-14 10:21:59,135 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,135 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.00 stddev:1.65 (2.7%) stddev-sans-first:1.73 10:21:59 INFO - 2015-11-14 10:21:59,135 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 62.0 63.0 61.0 62.0 61.0 60.0 65.0 59.0 10:21:59 INFO - 2015-11-14 10:21:59,135 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,135 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 10:21:59 INFO - 2015-11-14 10:21:59,135 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 70.0 67.0 68.0 68.0 67.0 68.0 67.0 10:21:59 INFO - 2015-11-14 10:21:59,135 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,135 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:1.27 (1.5%) stddev-sans-first:1.22 10:21:59 INFO - 2015-11-14 10:21:59,135 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 87.0 84.0 87.0 84.0 86.0 87.0 85.0 86.0 10:21:59 INFO - 2015-11-14 10:21:59,135 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,135 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:121.00 stddev:6.20 (5.1%) stddev-sans-first:6.22 10:21:59 INFO - 2015-11-14 10:21:59,136 DEBUG : BROWSER_OUTPUT: Values: 116.0 117.0 135.0 120.0 121.0 119.0 124.0 121.0 129.0 115.0 10:21:59 INFO - 2015-11-14 10:21:59,136 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,136 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:148.00 stddev:5.33 (3.6%) stddev-sans-first:4.74 10:21:59 INFO - 2015-11-14 10:21:59,136 DEBUG : BROWSER_OUTPUT: Values: 140.0 148.0 158.0 147.0 156.0 149.0 143.0 148.0 147.0 147.0 10:21:59 INFO - 2015-11-14 10:21:59,136 DEBUG : BROWSER_OUTPUT: 10:21:59 INFO - 2015-11-14 10:21:59,136 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:2.07 (3.1%) stddev-sans-first:2.12 10:21:59 INFO - 2015-11-14 10:21:59,136 DEBUG : BROWSER_OUTPUT: Values: 66.0 69.0 69.0 68.0 66.0 72.0 67.0 66.0 67.0 65.0 10:21:59 INFO - 2015-11-14 10:21:59,136 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:21:59 INFO - 2015-11-14 10:21:59,136 DEBUG : BROWSER_OUTPUT: 10:22:00 INFO - 2015-11-14 10:22:00,149 INFO : Browser exited with error code: 0 10:22:00 INFO - 2015-11-14 10:22:00,203 INFO : Completed test kraken (00:00:59) 10:22:00 INFO - 2015-11-14 10:22:00,203 INFO : Starting test v8_7 10:22:00 INFO - 2015-11-14 10:22:00,203 DEBUG : operating with platform_type : linux_ 10:22:00 INFO - 2015-11-14 10:22:00,203 INFO : Initialising browser for v8_7 test... 10:22:00 INFO - 2015-11-14 10:22:00,209 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSa9JNE/profile http://localhost:52437/getInfo.html 10:22:04 INFO - 2015-11-14 10:22:04,916 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:22:04 INFO - 2015-11-14 10:22:04,916 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:22:04 INFO - 2015-11-14 10:22:04,916 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:22:04 INFO - 2015-11-14 10:22:04,916 DEBUG : BROWSER_OUTPUT: __metrics 10:22:05 INFO - 2015-11-14 10:22:05,957 INFO : Browser initialized. 10:22:05 INFO - 2015-11-14 10:22:05,958 INFO : Running cycle 1/1 for v8_7 test... 10:22:05 INFO - 2015-11-14 10:22:05,958 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSa9JNE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:22:17 INFO - 2015-11-14 10:22:17,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 140644352 10:22:17 INFO - 2015-11-14 10:22:17,696 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,174 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52437/tests/v8_7/run.html (next: http://localhost:52437/tests/v8_7/run.html) 10:22:39 INFO - 2015-11-14 10:22:39,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 137940992 10:22:39 INFO - 2015-11-14 10:22:39,424 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,425 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:22:39 INFO - 2015-11-14 10:22:39,426 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:22:39 INFO - 2015-11-14 10:22:39,426 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:22:39 INFO - 2015-11-14 10:22:39,426 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:22:39 INFO - 2015-11-14 10:22:39,426 DEBUG : BROWSER_OUTPUT: |0;Richards;162.76041666666666 10:22:39 INFO - 2015-11-14 10:22:39,426 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.19938176197837 10:22:39 INFO - 2015-11-14 10:22:39,426 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.97780275358247 10:22:39 INFO - 2015-11-14 10:22:39,426 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 10:22:39 INFO - 2015-11-14 10:22:39,427 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1062.6992561105208 10:22:39 INFO - 2015-11-14 10:22:39,427 DEBUG : BROWSER_OUTPUT: |5;Earley;712.2507122507122 10:22:39 INFO - 2015-11-14 10:22:39,427 DEBUG : BROWSER_OUTPUT: |6;Boyer;11732.558139534884 10:22:39 INFO - 2015-11-14 10:22:39,427 DEBUG : BROWSER_OUTPUT: |7;RegExp;24902.439024390245 10:22:39 INFO - 2015-11-14 10:22:39,427 DEBUG : BROWSER_OUTPUT: |8;Splay;701.7426273458445 10:22:39 INFO - 2015-11-14 10:22:39,427 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 10:22:39 INFO - 2015-11-14 10:22:39,427 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:22:39 INFO - 2015-11-14 10:22:39,428 DEBUG : BROWSER_OUTPUT: __startTimestamp1447525359424__endTimestamp 10:22:39 INFO - 2015-11-14 10:22:39,428 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,428 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:22:39 INFO - 2015-11-14 10:22:39,428 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:22:39 INFO - 2015-11-14 10:22:39,429 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,429 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.76 Median:162.76 stddev:0.00 (0.0%) 10:22:39 INFO - 2015-11-14 10:22:39,429 DEBUG : BROWSER_OUTPUT: Values: 162.8 10:22:39 INFO - 2015-11-14 10:22:39,429 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,429 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.20 Median:193.20 stddev:0.00 (0.0%) 10:22:39 INFO - 2015-11-14 10:22:39,429 DEBUG : BROWSER_OUTPUT: Values: 193.2 10:22:39 INFO - 2015-11-14 10:22:39,429 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,429 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 10:22:39 INFO - 2015-11-14 10:22:39,429 DEBUG : BROWSER_OUTPUT: Values: 281.0 10:22:39 INFO - 2015-11-14 10:22:39,430 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,430 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 10:22:39 INFO - 2015-11-14 10:22:39,430 DEBUG : BROWSER_OUTPUT: Values: 5050.5 10:22:39 INFO - 2015-11-14 10:22:39,430 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,430 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 10:22:39 INFO - 2015-11-14 10:22:39,431 DEBUG : BROWSER_OUTPUT: Values: 1062.7 10:22:39 INFO - 2015-11-14 10:22:39,431 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,431 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:712.25 Median:712.25 stddev:0.00 (0.0%) 10:22:39 INFO - 2015-11-14 10:22:39,432 DEBUG : BROWSER_OUTPUT: Values: 712.3 10:22:39 INFO - 2015-11-14 10:22:39,432 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,432 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11732.56 Median:11732.56 stddev:0.00 (0.0%) 10:22:39 INFO - 2015-11-14 10:22:39,433 DEBUG : BROWSER_OUTPUT: Values: 11732.6 10:22:39 INFO - 2015-11-14 10:22:39,433 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,433 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24902.44 Median:24902.44 stddev:0.00 (0.0%) 10:22:39 INFO - 2015-11-14 10:22:39,433 DEBUG : BROWSER_OUTPUT: Values: 24902.4 10:22:39 INFO - 2015-11-14 10:22:39,433 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,433 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:701.74 Median:701.74 stddev:0.00 (0.0%) 10:22:39 INFO - 2015-11-14 10:22:39,433 DEBUG : BROWSER_OUTPUT: Values: 701.7 10:22:39 INFO - 2015-11-14 10:22:39,433 DEBUG : BROWSER_OUTPUT: 10:22:39 INFO - 2015-11-14 10:22:39,434 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 10:22:39 INFO - 2015-11-14 10:22:39,434 DEBUG : BROWSER_OUTPUT: Values: 4822.1 10:22:39 INFO - 2015-11-14 10:22:39,434 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:22:39 INFO - 2015-11-14 10:22:39,434 DEBUG : BROWSER_OUTPUT: 10:22:40 INFO - 2015-11-14 10:22:40,305 INFO : Browser exited with error code: 0 10:22:40 INFO - 2015-11-14 10:22:40,320 INFO : Completed test v8_7 (00:00:40) 10:22:40 INFO - 2015-11-14 10:22:40,415 INFO : Completed test suite (00:20:10) 10:22:40 INFO - 2015-11-14 10:22:40,415 DEBUG : Working with test: dromaeo_css 10:22:40 INFO - 2015-11-14 10:22:40,415 DEBUG : Generating results file: dromaeo_css 10:22:40 INFO - 2015-11-14 10:22:40,416 DEBUG : Working with test: kraken 10:22:40 INFO - 2015-11-14 10:22:40,416 DEBUG : Generating results file: kraken 10:22:40 INFO - 2015-11-14 10:22:40,416 INFO : javascript benchmark 10:22:40 INFO - 2015-11-14 10:22:40,417 DEBUG : Working with test: v8_7 10:22:40 INFO - 2015-11-14 10:22:40,417 DEBUG : Generating results file: v8_7 10:22:40 INFO - 2015-11-14 10:22:40,417 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:22:40 INFO - 2015-11-14 10:22:40,479 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 10:22:40 INFO - 2015-11-14 10:22:40,479 DEBUG : process_Request line: dromaeo_css 6626.89 graph.html#tests=[[72,64,43]] 10:22:40 INFO - 2015-11-14 10:22:40,479 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:22:40 INFO - 2015-11-14 10:22:40,519 DEBUG : process_Request line: kraken 1510.50 graph.html#tests=[[232,64,43]] 10:22:40 INFO - 2015-11-14 10:22:40,519 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:22:40 INFO - 2015-11-14 10:22:40,637 DEBUG : process_Request line: v8_7 21235.60 graph.html#tests=[[230,64,43]] 10:22:40 INFO - 2015-11-14 10:22:40,638 INFO : javascript benchmark 10:22:40 INFO - 2015-11-14 10:22:40,641 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [326.9803811771294, 332.5842696629214, 334.61017914130036, 336.2988169666246, 337.9324135172966, 12004.45979930903, 12387.0, 16558.254878530464, 16733.163341832904, 17822.198001089935, 10854.023137917586, 11067.225294229407, 11094.112471002321, 11241.0, 11263.098952083834, 4475.776211189435, 4599.747013914233, 4611.0, 4613.723176609397, 4623.722576645395, 4477.507474177838, 4541.65937554683, 4554.111948170108, 4554.385158003677, 4573.7713114344315, 4543.8182472701055, 4552.749598772066, 4576.97711511442, 4657.347971284023, 4688.953110468903, 4599.931001034987, 4687.9531204687855, 4687.976560117212, 4699.506551812062, 4702.24764037754, 4222.345536441856, 4233.51314598822, 4246.108317253381, 4250.723702959298, 4254.298040823261, 13572.660683482893, 13640.454381824815, 13899.722005559934, 13940.0, 13960.511382101678, 1843.75109360236, 1937.903104844752, 1959.6276707425543, 2003.6601514648069, 2011.0, 10172.287939844215, 10193.745156371077, 10199.694009179662, 10279.691609251735, 10314.535845886952, 1652.8099268584147, 1707.598714302138, 1723.9482815515555, 1727.1795896948975, 1746.6244757377224, 55114.0, 60174.39825601732, 63173.68413157951, 63752.681236593984, 63756.043659345145, 6734.6632668367365, 6830.965845170742, 6969.05917701114, 6996.635656047022, 7022.719091236293, 8259.876101858477, 8266.793330166794, 8280.58597070144, 8299.460535065202, 8325.916740832636, 5347.491988261109, 5347.572194224453, 5376.542993845489, 5421.05131601976, 5428.240046393508, 5351.678899266057, 5377.085895397791, 5422.186671999231, 5432.103702889058, 5483.095289277225, 3242.1084201844683, 3242.416365054313, 3269.3297873935785, 3290.2596915693775, 3303.669633036677, 1092.5575142067476, 1110.6334909479851, 1119.5242022140558, 1121.4504892602565, 1150.551284998851, 375.0548617483925, 381.32505465326216, 381.88161669882425, 393.7873548283895, 414.14892396125646, 10091.344062635904, 10399.220058495643, 10445.895541044645, 10671.626493072861, 10692.411917344465, 402.7965877231979, 403.24794258707885, 410.14484799194014, 420.81063521415484, 436.0211325574043, 5550.972245138829, 5827.562932780059, 6104.38956104386, 6460.063290822804, 6462.644554549451, 491191.0, 493818.0, 499186.0, 511529.0, 512440.0, 75939.62030189813, 76351.0, 77318.0, 77498.0, 79189.0, 516.5789881246772, 518.0467938992197, 518.5022378516591, 518.5048278893723, 518.8261932252738, 10792.406417647106, 11062.391568463812, 11140.275882067639, 11171.162162837658, 11202.88797112051, 31318.843405782824, 31508.369832602762, 32183.195420114684, 32894.1776455581, 33125.66874331226, 40868.386974194815, 41046.1790764189, 41745.16509669729, 42328.57671423246, 42536.57463425326, 6537.084808126771, 6803.829904252433, 6807.523473356818, 6820.420264277592, 6839.692213850488, 11780.293182409083, 11896.881031189923, 12113.454894529592, 12174.147809653594, 12245.89786919146, 10062.195024397884, 10447.0, 10477.633282835064, 10497.2127090467, 10554.736131596772, 9968.202543796624, 10249.897501025192, 10364.689059328231, 10442.947785261329, 10519.053285204369, 10516.631917882838, 10572.259941803999, 10579.788404231718, 10650.254482186172, 10702.250842440955, 6624.370684784938, 6671.432928201158, 6800.727970881109, 6832.931670683429, 6838.658067096526, 10450.529726162189, 10735.94632026835, 10798.082163015917, 10835.241533092609, 10874.619388321371], "dojo.html": [3216.356728654269, 3230.85461154248, 3249.10649571368, 3271.280318329968, 3283.9983804939498, 5384.057789886769, 5400.729963501829, 5438.184272359148, 5451.999999999995, 5466.098093814521, 5318.335208098988, 5403.83788486346, 5492.972535137319, 5526.640768350055, 5528.087865502187, 4976.228684553891, 5025.271335656327, 5102.938237057772, 5104.719240441774, 5111.6166287528395, 4877.975610121945, 4945.480724523927, 4990.900181996358, 4998.6750861193905, 5016.47327030662, 4878.219484882419, 4978.128827455181, 4995.55040046394, 4997.525235102659, 5000.199968005102, 4905.583025442842, 4980.178270585386, 5041.949580504184, 5050.292958985745, 5053.671511351788, 4937.777799998973, 4969.950300497021, 4978.6514943953935, 4979.427365852937, 5013.674111182761, 5073.289739436482, 5185.092608793446, 5226.8693282667855, 5353.812616558402, 5355.794946137127, 5961.344252132262, 5984.581079324449, 5988.131720900445, 6000.369961154103, 6001.2498437695285, 5974.462298393122, 6015.699215039274, 6017.187679663233, 6017.398260173992, 6035.517158627299, 5352.437994010612, 5447.5641948644015, 5455.563554915597, 5458.317710286215, 5613.691246981414, 5951.434613711691, 6037.909431358533, 6054.303755068224, 6060.0, 6101.908471372933, 5761.164631128463, 5771.9711401443565, 5781.797637082682, 5832.1834943108, 5885.087811389241, 5739.799107031234, 5796.507296879812, 5801.042827933344, 5803.0, 5873.794417195378, 5824.475797178275, 5828.562857785599, 5841.970790146022, 5872.500837428781, 5925.140854576062, 5774.740136693859, 5787.942120578825, 5811.593188476766, 5814.418558144152, 5830.795922142789, 4403.471583409947, 4449.822007119679, 4478.731276123443, 4501.122281155209, 4505.887352816206, 4020.0954785173103, 4043.433919251307, 4050.4936882889638, 4056.350983842571, 4076.979615101965, 5563.36021357541, 5570.582206334541, 5582.0, 5617.550595952314, 5622.240997465372, 5784.1902133701315, 5866.032104702762, 5907.734151963172, 5933.910991335133, 6046.244219472566, 5518.834434966958, 5542.0, 5552.639078459887, 5556.611037227355, 5601.719914004283, 5045.217991211368, 5069.695818250917, 5089.541941225233, 5097.439281679012, 5120.078385890501, 5804.506616937608, 5933.3769954154195, 6123.050927106306, 6199.907001394983, 6207.844803879939, 5891.204687367151, 5906.497947674496, 5927.288725352985, 5945.672987985702, 5958.255218097738, 5952.494038006645, 6101.145839582551, 6120.755169793337, 6167.722452489738, 6188.597741146811, 5775.191473193672, 5775.306963164448, 5875.706214689334, 5890.852728681817, 5940.405959404025, 5837.824865254049, 5844.766209351578, 5873.500752436091, 5877.882442351214, 5889.293284805679, 5582.385937546947, 5662.462066103713, 5692.459216374438, 5698.487136157766, 5734.0, 5694.1458781183155, 5755.597108202385, 5766.798162064308, 5794.420557944172, 5846.795362162304, 5708.942910571007, 5744.224529688606, 5750.482456578928, 5755.65466072037, 5759.65442073477, 5759.625624334405, 5778.537716982715, 5835.124731290341, 5857.502112320501, 5905.734241959036, 5666.858328541819, 5675.205471233948, 5678.148277758204, 5685.459881311269, 5737.08206686928], "mootools.html": [1511.8714909232715, 1681.7309230523115, 1727.9654406911861, 1732.5668582854291, 1740.24299429748, 6149.815505534841, 6200.224971878515, 7500.624968751561, 7698.384129269666, 7745.573993430359, 7328.487005909588, 7423.257674232587, 7486.251374862524, 7514.96242518788, 7559.546427214371, 2189.627763280246, 2222.744384395791, 2228.8774117423536, 2235.7540670526228, 2236.6756820261053, 2224.944376390587, 2231.0964059555904, 2304.2741536415974, 2313.4794671199015, 2318.6290193569034, 2081.2299449203815, 2115.7566879808865, 2129.7018417421573, 2130.424785307966, 2168.067730875731, 2237.1722462688745, 2240.316703405461, 2255.76314486979, 2276.658501224813, 2277.703898493202, 2075.5122546201633, 2112.0812446585783, 2119.9258025969016, 2126.3514628038442, 2126.3620913725977, 7342.853142937111, 7373.373263272628, 7389.039424874785, 7402.0, 7402.777916662509, 4512.932306015412, 4543.363929049936, 4568.88577785558, 4590.724556526619, 4600.0, 2906.1426879070723, 2936.3686807336526, 2936.7063293670676, 2950.867210975511, 2968.584398184256, 921.8064206516573, 929.4609126706493, 938.1134827587932, 966.5747071288611, 977.1157102821886, 10132.746681333025, 10195.541200645988, 10202.285839991204, 10290.897091029143, 10296.948515257376, 4011.5988401159652, 4058.5332686740812, 4075.0627355708352, 4118.9588104119175, 4121.876343709693, 8436.156384361515, 8439.578021099043, 8443.788905277293, 8447.23974842255, 8450.746477605682, 4544.500104988449, 4574.83988060423, 4593.724376537419, 4594.793234304398, 4612.192866248461, 4200.894977625584, 4217.219814334297, 4254.532001479834, 4260.318349064135, 4271.0, 3280.7867488613642, 3310.337932413527, 3323.651016643266, 3340.0, 3354.4297469429766, 1027.7584767579613, 1032.5972870580479, 1036.9688909332733, 1038.5326603028668, 1049.4280617063719, 1015.0762805846645, 1023.8464230365356, 1046.0742243114746, 1163.953441862333, 1327.8605746396684, 7096.290370962863, 7214.422846172293, 7216.278372162847, 7245.529040612343, 7245.89131163033, 492.5911493460419, 492.97781599828096, 498.8902441462872, 499.1464595541592, 503.7456084677288, 5531.9723401382735, 5541.085720856095, 5549.112142057252, 5562.666240025612, 5593.188987596775, 8471.618777155043, 8718.128187181357, 8740.125987401208, 8794.208521232991, 8802.427842190365, 8747.16901894319, 8751.343649226334, 8841.69054083104, 8864.822703545893, 8879.023307436177, 6731.360520750521, 6859.965700171567, 6883.3116688330765, 6960.095187625576, 6969.9303006969285, 6906.930930690629, 6962.025316455802, 6981.965090174516, 7011.6494175292055, 7021.508494405342, 7737.342325902361, 7929.762107136795, 7937.642806073625, 8061.234182752629, 8082.110967793656, 8006.679732810622, 8193.426460147732, 8217.465864718773, 8219.794505137419, 8262.42163048581, 6667.19993600771, 6738.797836064926, 6923.688434020582, 6928.861422771415, 6936.167659880846, 7425.108986921604, 7438.925610743823, 7444.962775186306, 7445.441591880739, 7453.776386708408, 6830.0, 6963.7562685305775, 6985.406240469617, 7028.753993610199, 7039.859202816017, 6669.633170175687, 6698.464122870061, 6699.095622090956, 6736.259011508632, 6840.760573379908, 6650.301718319701, 6785.117934668659, 6797.28628494001, 6800.863982720219, 6880.346367095118, 6400.103985442135, 6442.677866106769, 6483.994980777987, 6508.8047358579315, 6530.379613936669, 6410.551261411656, 6449.3873082057125, 6538.771143009972, 6539.6076235424125, 6552.082708420729], "ext.html": [555.5194756535598, 599.7121381736767, 606.551152147411, 609.8810731907278, 610.5054905526526, 39259.80370098152, 39274.80362598187, 40187.79906100469, 40238.396424053586, 40316.19367612646, 42077.36883946736, 43011.784941075326, 43079.78460107703, 43218.783906080425, 43255.0, 8759.167879051496, 8899.555022248895, 8910.955445222764, 8913.331500137483, 8919.063498332678, 8666.220040196382, 8730.083341249172, 8763.255123314526, 8802.559872006374, 8845.380823342368, 8802.339824513156, 8856.867146992769, 8896.688615898445, 8907.153820387053, 8923.73228803137, 8760.737177884674, 8806.779830504225, 8842.381033327669, 8869.822603547926, 8875.511846848422, 8559.614817333235, 8754.518501482416, 8772.912270877274, 8778.868316975251, 8804.691835785718, 40308.39537406941, 40506.594934050576, 40609.39085913714, 40792.59207407918, 40939.1812163758, 3110.9533356999664, 3205.1218422750603, 3236.8543415546355, 3250.2686895448337, 3303.157694787838, 29189.27026824325, 29279.70720292791, 29485.70514294851, 29509.85245073761, 29693.851530742424, 3363.0, 3402.387570237356, 3409.7613167078316, 3469.6877281044576, 3531.940417874627, 273199.0, 274664.0, 274670.999999998, 275231.0, 275925.0, 41763.37354939678, 42462.57537424586, 42598.78700606477, 55726.0, 56074.71962640161, 42006.78996605059, 42057.94855128646, 42096.15807683829, 42205.0, 42262.36606450906, 12541.93729031349, 12739.681507962376, 12786.360681965865, 12794.552190673281, 12806.935965320301, 10256.43589602579, 10320.277580569438, 10341.896581034094, 10368.118709909591, 10398.532066057045, 14610.123392596266, 14626.561203163923, 14639.341229644691, 14760.0, 14790.8167346612, 5859.121131830174, 5922.851928701731, 5998.700064996733, 6006.429389208019, 6035.107355755513, 859.0378775771052, 969.6121551379364, 1002.9197664186847, 1082.6048492300254, 1122.93262404256, 28639.856800715865, 28745.85627071893, 28947.7105228945, 29061.85469072641, 29244.268893277836, 992.6029588164791, 995.0646392391129, 1000.7598176437602, 1021.897810218987, 1087.2280680716622, 15162.0, 15191.392344306325, 15218.488949323239, 15326.770098448533, 15515.767263491056, 329829.0, 334433.0, 334436.0, 335022.0, 336445.0, 51001.744991274805, 51260.0, 51461.2280815788, 51632.22551661728, 51657.48342516602, 1266.3415024187555, 1274.8788865057804, 1276.0939732789823, 1310.1156719214491, 1320.8679132086716, 27868.442631147667, 28799.5680064795, 28838.42323153483, 28846.278843029093, 29044.7095529042, 46399.3040104392, 46633.0, 46734.298985515925, 46798.0, 46960.0, 306813.0, 307018.0, 308556.0, 308621.2844678901, 309000.0, 46307.53692463032, 46493.302600460345, 46636.53363466458, 46937.76531117323, 47507.0, 43413.565864340955, 43491.17307375137, 43988.7800561008, 44610.10779784451, 44738.77630611826, 36348.27303453969, 36779.26441471102, 37115.44326835153, 37420.251594967405, 38399.616003839605, 37189.62810371862, 37582.8120859394, 38200.2359952805, 38247.0, 38702.41946370863, 36207.63792362148, 36932.81533592315, 36977.0, 37170.8141459291, 37247.81376093102, 33613.0, 36390.454143187344, 37819.62180378161, 37962.43056354212, 38707.6129238704, 25374.873125634254, 25477.872610636827, 26197.4760504785, 26323.4735305289, 26645.200643980712], "prototype.html": [287.06989354491446, 287.9021132814843, 294.86288875672795, 295.11906957731156, 301.27092436304144, 6279.591826531272, 6296.307406185316, 6330.620162790236, 6388.233411990562, 6508.576942498734, 6251.312355640887, 6324.525660575464, 6358.777442789503, 6363.968180159104, 6374.139491168691, 4692.460367057781, 4700.55344742249, 4705.270683044134, 4710.128626204146, 4710.90578188436, 4706.976465117669, 4711.717296962176, 4713.43438787346, 4720.150372932871, 4726.0547890421885, 4586.243269860469, 4658.534146585348, 4663.3937588113495, 4679.578837904588, 4680.836170734025, 4647.581717645428, 4647.837325693618, 4653.697509661861, 4657.51096134906, 4667.766611669437, 3954.228925359556, 3955.7626542407547, 3959.8812035638975, 3963.0290578808376, 3966.226585815767, 6006.489448396892, 6039.547033972426, 6056.666883321415, 6062.42406971337, 6068.57519973602, 5246.554042906358, 5401.918971215435, 5405.405405405402, 5408.296921400193, 5426.375966763833, 6710.865782684368, 6718.764843230512, 6730.562513436611, 6761.830954226134, 6770.559913605649, 4346.174226896911, 4385.364122202294, 4393.780310984438, 4394.362817391492, 4408.030233348658, 6771.255161932184, 6888.724451021953, 6921.792346229571, 6936.410405115571, 7038.859222815515, 4379.167958087953, 4390.824367025347, 4395.494518130456, 4405.911881762411, 4406.62543683784, 4455.888602784957, 4457.8439754608435, 4462.419885414875, 4463.933041004388, 4473.373727678128, 5340.412554618989, 5340.49265319794, 5341.973290133602, 5348.598855085884, 5359.062164121341, 6681.164854393201, 6747.257801641816, 6771.762988295386, 6794.626295553693, 6815.386615204656, 1535.4702627593463, 1561.6017915431719, 1569.897956632838, 1570.0658108425696, 1570.583795294248, 1001.2790790630734, 1007.3804610164696, 1008.4403156248206, 1009.1271050541229, 1016.9796604067877, 6389.552731308764, 6407.839804004937, 6424.229092508929, 6425.903611445832, 6442.387973142544, 6830.453563714891, 6899.448044156456, 6930.0, 6933.68798404073, 6942.757003504853, 6250.15622890913, 6352.936470635234, 6356.713947872357, 6395.52033597482, 6396.712147953353, 3752.380857158593, 3755.2677227940835, 3764.265968136187, 3782.7541209821275, 3806.2197249563774, 7163.31948464895, 7179.246179151114, 7209.855802883913, 7217.566945983152, 7218.422526197892, 7048.612326321999, 7073.398761105261, 7101.183363913113, 7112.786616401516, 7132.857342853217, 7271.818204544823, 7334.706611735471, 7350.08123984502, 7357.963210184022, 7396.963015184997, 7037.859242815218, 7073.115860517435, 7082.0, 7084.539504932163, 7121.6439178039855, 6826.112605361272, 6946.583205007716, 6946.8610627788175, 6954.3393377629045, 6956.37392634645, 7263.34629883313, 7319.451041171827, 7353.338199562065, 7355.190928997913, 7356.154042285206, 4458.461830668414, 4473.5526447355005, 4483.372327874035, 4483.484399294123, 4516.187086324493, 6942.2363540011565, 6997.230304666585, 7027.0, 7047.224805271519, 7057.294270572902, 6830.214525329452, 6836.589804611739, 6861.313868613099, 6861.348171923659, 6869.450443964371, 6844.726210951506, 6850.486213533905, 6852.040714300102, 6856.177258728984, 6862.210845752802, 6437.903431448625, 6636.402723754885, 6707.463402927851, 6720.462363011045, 6723.495737819585, 6844.28135045813, 6865.450763938973, 6866.896996544956, 6907.758228461979, 6911.3779759821855, 6572.7042283098335, 6640.734370625121, 6677.399034086956, 6677.499187560855, 6679.432248258952], "yui.html": [702.0872865275147, 724.967376468059, 824.1826771967811, 846.8137009857829, 873.0352959979223, 13066.150700204493, 13268.270245136513, 13373.799393009089, 13417.06080574359, 13471.73056538871, 12550.560730374438, 12883.806742898863, 13241.536546220885, 13428.127171733831, 13431.462741490353, 785.2893131715792, 798.480987358219, 801.1707882341777, 801.2748462641318, 801.310872649521, 788.7081779741503, 796.9242921922408, 797.5493845977034, 798.8881556582083, 801.6032064128265, 816.2979837339913, 828.8756686497044, 829.6598394658191, 830.4560512864053, 831.6756464978663, 803.9839203215932, 815.955122468264, 816.3183741575791, 817.5421763812254, 821.7657967479299, 602.6203491800181, 603.2369053147771, 604.2597817673314, 604.4559896093507, 605.893968555501, 12251.387430628432, 12313.630591082281, 12380.938095309466, 12391.93804030974, 12399.814002789966, 10945.179111566586, 10945.398003109825, 10947.178961577834, 11314.943425282903, 11329.943350283278, 8905.421147625448, 9102.362834601581, 9112.134347237068, 9177.587008584629, 9197.310201734897, 3288.2272665923488, 3396.252824378633, 3396.3037577296595, 3430.6397828227928, 3508.28080243552, 41105.383419248436, 41424.0, 47376.5262347379, 47531.0, 47914.281285780744, 10100.242481813893, 10167.0, 10173.389596624078, 10377.896221037843, 10474.895251047545, 18494.81505184958, 18588.349407770933, 18599.53501162482, 18600.255989760528, 18624.0, 6808.6255255960405, 6881.621510816954, 6933.445324374038, 6998.930010699828, 7091.1490621125795, 4417.425734654475, 4450.310201918708, 4578.107269082497, 4619.076184763061, 4660.161170989254, 3000.924976875596, 3005.4590173768934, 3015.7135072168107, 3015.8190508569555, 3044.375902939892, 457.2797843396664, 460.59927862758946, 466.8226074091891, 470.7457972694775, 471.24130150457734, 540.5756481162348, 615.0808342589164, 633.9270983836825, 658.9308122647149, 704.4927652090487, 8457.830843383097, 8580.871286930702, 8688.348373871984, 8703.521306328086, 9047.954760226157, 533.3812777178455, 543.7661805423627, 571.3058633760002, 698.6122701900495, 704.6371118873784, 3795.791231482295, 3893.2213557288655, 3927.113571524927, 3972.8609498667406, 4056.20903923732, 59475.405245947855, 60118.69940650269, 60161.39838601645, 60184.777826661084, 61352.69323653353, 54122.72938635282, 54274.0, 55146.44853551413, 55238.447615524135, 55314.446855531736, 47146.5285347149, 49144.50855491471, 50121.24818127731, 50538.241926371134, 55195.72402138044, 8287.12985136552, 8339.874901876598, 8344.749657510285, 8360.247577718035, 8505.617247224014, 34183.4872476918, 34498.137546561535, 34849.65150348464, 35023.29953400969, 35795.284094318486, 40912.79543602263, 45211.0, 45359.0, 45812.770936145105, 46025.0, 10655.210736943729, 10803.189760767817, 10911.618093366695, 11226.55093796239, 11280.717982050515, 11282.605108821152, 11634.825477617673, 11836.644900652995, 12105.0, 13003.869961300645, 11317.207795454238, 11577.363245021268, 11719.121065919919, 11934.522619095485, 12004.519819207135, 10719.946400267949, 11332.6033588824, 11689.590864319707, 11693.941530292293, 12246.081543884065, 11334.716632084264, 11566.768664626492, 11682.24065435744, 11881.881181188422, 11906.642800715992, 9515.619375225191, 9595.0, 9808.068233517804, 10065.69802905914, 10128.797424051625, 8358.791030224293, 9113.954430227806, 9375.156235938799, 9379.437233765995, 9455.479948602893]}, "summary": {"lowerIsBetter": false, "suite": 6626.892461261295, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6637.008238099127, "unit": "ms", "value": 6637.008238099127}, "dojo.html": {"lowerIsBetter": false, "filtered": 5422.29073978347, "unit": "ms", "value": 5422.29073978347}, "mootools.html": {"lowerIsBetter": false, "filtered": 4233.668933347741, "unit": "ms", "value": 4233.668933347741}, "ext.html": {"lowerIsBetter": false, "filtered": 18120.662357907604, "unit": "ms", "value": 18120.662357907604}, "prototype.html": {"lowerIsBetter": false, "filtered": 4958.085757091772, "unit": "ms", "value": 4958.085757091772}, "yui.html": {"lowerIsBetter": false, "filtered": 6186.752432809843, "unit": "ms", "value": 6186.752432809843}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-001.e"}, "testrun": {"date": 1447524149, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114083154", "branch": "Fx-Team", "revision": "ea060d62594e0cb3522b7fcc9fcfc7ca635007ad"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 162.0, 161.0, 160.0, 162.0, 161.0, 162.0, 164.0, 172.0, 162.0], "ai-astar": [112.0, 106.0, 111.0, 112.0, 114.0, 122.0, 111.0, 112.0, 111.0, 112.0], "imaging-gaussian-blur": [110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 111.0, 110.0, 110.0, 110.0], "audio-beat-detection": [153.0, 129.0, 152.0, 166.0, 127.0, 147.0, 157.0, 136.0, 167.0, 127.0], "json-stringify-tinderbox": [68.0, 68.0, 69.0, 70.0, 67.0, 68.0, 68.0, 67.0, 68.0, 67.0], "stanford-crypto-pbkdf2": [140.0, 148.0, 158.0, 147.0, 156.0, 149.0, 143.0, 148.0, 147.0, 147.0], "json-parse-financial": [61.0, 62.0, 62.0, 63.0, 61.0, 62.0, 61.0, 60.0, 65.0, 59.0], "stanford-crypto-sha256-iterative": [66.0, 69.0, 69.0, 68.0, 66.0, 72.0, 67.0, 66.0, 67.0, 65.0], "audio-fft": [72.0, 73.0, 72.0, 74.0, 73.0, 72.0, 144.0, 73.0, 72.0, 72.0], "imaging-darkroom": [152.0, 146.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 147.0], "stanford-crypto-ccm": [116.0, 117.0, 135.0, 120.0, 121.0, 119.0, 124.0, 121.0, 129.0, 115.0], "audio-oscillator": [91.0, 90.0, 130.0, 90.0, 91.0, 91.0, 139.0, 90.0, 90.0, 137.0], "stanford-crypto-aes": [84.0, 85.0, 87.0, 84.0, 87.0, 84.0, 86.0, 87.0, 85.0, 86.0], "imaging-desaturate": [97.0, 97.0, 97.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1510.5, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.7, "unit": "ms", "value": 79.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 148.3, "unit": "ms", "value": 148.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 146.1, "unit": "ms", "value": 146.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.7, "unit": "ms", "value": 121.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.9, "unit": "ms", "value": 146.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.6, "unit": "ms", "value": 61.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.9, "unit": "ms", "value": 103.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 112.3, "unit": "ms", "value": 112.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.7, "unit": "ms", "value": 162.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.5, "unit": "ms", "value": 67.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.0, "unit": "ms", "value": 68.0}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.8, "unit": "ms", "value": 109.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.5, "unit": "ms", "value": 85.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.5, "unit": "ms", "value": 96.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-001.e"}, "testrun": {"date": 1447524149, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114083154", "branch": "Fx-Team", "revision": "ea060d62594e0cb3522b7fcc9fcfc7ca635007ad"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.19938176197837], "Encrypt": [280.97780275358247], "NavierStokes": [4822.115384615385], "Decrypt": [5050.50505050505], "Splay": [701.7426273458445], "Richards": [162.76041666666666], "RegExp": [24902.439024390245], "Earley": [712.2507122507122], "Boyer": [11732.558139534884], "RayTrace": [1062.6992561105208]}, "summary": {"lowerIsBetter": false, "suite": 21235.5965299892, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 342.226768, "unit": "score", "value": 342.226768}, "Encrypt": {"lowerIsBetter": false, "filtered": 947.3381789999996, "unit": "score", "value": 947.3381789999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.70383799999996, "unit": "score", "value": 52.70383799999996}, "Splay": {"lowerIsBetter": false, "filtered": 116.12662082139444, "unit": "score", "value": 116.12662082139444}, "RegExp": {"lowerIsBetter": false, "filtered": 36.58215964740448, "unit": "score", "value": 36.58215964740448}, "Richards": {"lowerIsBetter": false, "filtered": 216.895488, "unit": "score", "value": 216.895488}, "Earley": {"lowerIsBetter": false, "filtered": 935.7140519999998, "unit": "score", "value": 935.7140519999998}, "Boyer": {"lowerIsBetter": false, "filtered": 56.80457680872147, "unit": "score", "value": 56.80457680872147}, "RayTrace": {"lowerIsBetter": false, "filtered": 696.3296489999998, "unit": "score", "value": 696.3296489999998}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-001.e"}, "testrun": {"date": 1447524149, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114083154", "branch": "Fx-Team", "revision": "ea060d62594e0cb3522b7fcc9fcfc7ca635007ad"}}] 10:22:40 INFO - RETURN: dromaeo_css: 6626.89 10:22:40 INFO - RETURN: kraken: 1510.50 10:22:40 INFO - RETURN: v8_7: 21235.60 10:22:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21235.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1510.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6626.89"}}} 10:22:40 INFO - Return code: 0 10:22:40 INFO - # TBPL SUCCESS # 10:22:40 INFO - Running post-action listener: _resource_record_post_action 10:22:40 INFO - Running post-run listener: _resource_record_post_run 10:22:41 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518000640; Read time: 12; Write time: 527708 10:22:41 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 229875712; Read time: 0; Write time: 305364 10:22:41 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277151744; Read time: 12; Write time: 161220 10:22:41 INFO - Running post-run listener: _upload_blobber_files 10:22:41 INFO - Blob upload gear active. 10:22:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:22:41 INFO - Copying logs to upload dir... 10:22:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.071916 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-14 10:22:41.379225) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 10:22:41.382331) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008523 build_url: 'https://queue.taskcluster.net/v1/task/LiHGpWS5Q6CyGFb-wh2mWw/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-14 10:22:41.430705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 10:22:41.431038) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447522579.400958-1114621494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 10:22:41.480813) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 10:22:41.481139) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 10:22:41.481434) ========= ========= Total master_lag: 0.30 =========