builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1448077309.5 results: success (0) buildid: 20151120173020 builduid: 3a546bb4e8634f7287815116a653b87d revision: da4011bf914cfde650934458cd10c4a1c283980e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.499125) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.499586) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.499941) ========= 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=004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009148 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.548172) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.548487) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.569612) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.569959) ========= 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=004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.619649) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.619979) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.620373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.620705) ========= 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=004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 19:41:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.5M=0.001s 2015-11-20 19:41:50 (21.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.221478 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.856829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.857383) ========= 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=004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015400 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:49.913695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 19:41:49.914183) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev da4011bf914cfde650934458cd10c4a1c283980e --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/b2g-inbound --rev da4011bf914cfde650934458cd10c4a1c283980e --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=004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 19:41:51,066 truncating revision to first 12 chars 2015-11-20 19:41:51,066 Setting DEBUG logging. 2015-11-20 19:41:51,066 attempt 1/10 2015-11-20 19:41:51,066 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/da4011bf914c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 19:41:52,360 unpacking tar archive at: b2g-inbound-da4011bf914c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.610578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 19:41:51.539112) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:51.539459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:51.548775) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:51.549091) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 19:41:51.549553) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-20 19:41:51.549938) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:41:52 INFO - MultiFileLogger online at 20151120 19:41:52 in /builds/slave/test-pgo 19:41:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 19:41:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:41:52 INFO - {'append_to_log': False, 19:41:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:41:52 INFO - 'blob_upload_branch': 'B2G-Inbound', 19:41:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:41:52 INFO - 'branch': 'B2G-Inbound', 19:41:52 INFO - 'buildbot_json_path': 'buildprops.json', 19:41:52 INFO - 'config_files': ('talos/linux_config.py',), 19:41:52 INFO - 'default_actions': ('clobber', 19:41:52 INFO - 'read-buildbot-config', 19:41:52 INFO - 'download-and-extract', 19:41:52 INFO - 'populate-webroot', 19:41:52 INFO - 'create-virtualenv', 19:41:52 INFO - 'install', 19:41:52 INFO - 'run-tests'), 19:41:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:41:52 INFO - 'download_minidump_stackwalk': True, 19:41:52 INFO - 'download_symbols': 'ondemand', 19:41:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:41:52 INFO - 'tooltool.py': '/tools/tooltool.py', 19:41:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:41:52 INFO - '/tools/misc-python/virtualenv.py')}, 19:41:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:41:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:41:52 INFO - 'installer_path': 'installer.exe', 19:41:52 INFO - 'log_level': 'info', 19:41:52 INFO - 'log_name': 'talos', 19:41:52 INFO - 'log_to_console': True, 19:41:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:41:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:41:52 INFO - 'opt_config_files': (), 19:41:52 INFO - 'pip_index': False, 19:41:52 INFO - 'sps_profile': False, 19:41:52 INFO - 'sps_profile_interval': 0, 19:41:52 INFO - 'suite': 'dromaeojs', 19:41:52 INFO - 'system_bits': '64', 19:41:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:41:52 INFO - 'title': 'talos-linux64-ix-066', 19:41:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:41:52 INFO - 'use_talos_json': True, 19:41:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:41:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:41:52 INFO - 'work_dir': 'build'} 19:41:52 INFO - ##### 19:41:52 INFO - ##### Running clobber step. 19:41:52 INFO - ##### 19:41:52 INFO - Running pre-action listener: _resource_record_pre_action 19:41:52 INFO - Running main action method: clobber 19:41:52 INFO - rmtree: /builds/slave/test-pgo/build 19:41:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:41:53 INFO - Running post-action listener: _resource_record_post_action 19:41:53 INFO - ##### 19:41:53 INFO - ##### Running read-buildbot-config step. 19:41:53 INFO - ##### 19:41:53 INFO - Running pre-action listener: _resource_record_pre_action 19:41:53 INFO - Running main action method: read_buildbot_config 19:41:53 INFO - Using buildbot properties: 19:41:53 INFO - { 19:41:53 INFO - "properties": { 19:41:53 INFO - "buildnumber": 49, 19:41:53 INFO - "product": "firefox", 19:41:53 INFO - "script_repo_revision": "production", 19:41:53 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 19:41:53 INFO - "repository": "", 19:41:53 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 19:41:53 INFO - "buildid": "20151120173020", 19:41:53 INFO - "slavename": "talos-linux64-ix-066", 19:41:53 INFO - "pgo_build": "True", 19:41:53 INFO - "basedir": "/builds/slave/test-pgo", 19:41:53 INFO - "project": "", 19:41:53 INFO - "platform": "ubuntu64_hw", 19:41:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:41:53 INFO - "slavebuilddir": "test", 19:41:53 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 19:41:53 INFO - "branch": "b2g-inbound", 19:41:53 INFO - "repo_path": "integration/b2g-inbound", 19:41:53 INFO - "stage_platform": "linux64-pgo", 19:41:53 INFO - "builduid": "3a546bb4e8634f7287815116a653b87d", 19:41:53 INFO - "revision": "da4011bf914cfde650934458cd10c4a1c283980e" 19:41:53 INFO - }, 19:41:53 INFO - "sourcestamp": { 19:41:53 INFO - "repository": "", 19:41:53 INFO - "hasPatch": false, 19:41:53 INFO - "project": "", 19:41:53 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 19:41:53 INFO - "changes": [ 19:41:53 INFO - { 19:41:53 INFO - "category": null, 19:41:53 INFO - "files": [ 19:41:53 INFO - { 19:41:53 INFO - "url": null, 19:41:53 INFO - "name": "https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 19:41:53 INFO - } 19:41:53 INFO - ], 19:41:53 INFO - "repository": "", 19:41:53 INFO - "rev": "da4011bf914cfde650934458cd10c4a1c283980e", 19:41:53 INFO - "who": "sendchange", 19:41:53 INFO - "when": 1448077259, 19:41:53 INFO - "number": 6691822, 19:41:53 INFO - "comments": "", 19:41:53 INFO - "project": "", 19:41:53 INFO - "at": "Fri 20 Nov 2015 19:40:59", 19:41:53 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 19:41:53 INFO - "revlink": "", 19:41:53 INFO - "properties": [ 19:41:53 INFO - [ 19:41:53 INFO - "buildid", 19:41:53 INFO - "20151120173020", 19:41:53 INFO - "Change" 19:41:53 INFO - ], 19:41:53 INFO - [ 19:41:53 INFO - "builduid", 19:41:53 INFO - "3a546bb4e8634f7287815116a653b87d", 19:41:53 INFO - "Change" 19:41:53 INFO - ], 19:41:53 INFO - [ 19:41:53 INFO - "pgo_build", 19:41:53 INFO - "True", 19:41:53 INFO - "Change" 19:41:53 INFO - ] 19:41:53 INFO - ], 19:41:53 INFO - "revision": "da4011bf914cfde650934458cd10c4a1c283980e" 19:41:53 INFO - } 19:41:53 INFO - ], 19:41:53 INFO - "revision": "da4011bf914cfde650934458cd10c4a1c283980e" 19:41:53 INFO - } 19:41:53 INFO - } 19:41:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 19:41:53 INFO - Running post-action listener: _resource_record_post_action 19:41:53 INFO - ##### 19:41:53 INFO - ##### Running download-and-extract step. 19:41:53 INFO - ##### 19:41:53 INFO - Running pre-action listener: _resource_record_pre_action 19:41:53 INFO - Running main action method: download_and_extract 19:41:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:41:53 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')]} 19:41:53 INFO - https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:41:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/test_packages.json 19:41:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/test_packages.json 19:41:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:41:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:41:56 INFO - Downloaded 1302 bytes. 19:41:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:41:56 INFO - Using the following test package requirements: 19:41:56 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:41:56 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:41:56 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:56 INFO - u'jsshell-linux-x86_64.zip'], 19:41:56 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:41:56 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:41:56 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:41:56 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:41:56 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:41:56 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:41:56 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:41:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:41:56 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')]} 19:41:56 INFO - https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:41:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:41:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:41:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/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 19:41:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/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 19:41:58 INFO - Downloaded 22522872 bytes. 19:41:58 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 19:41:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:41:58 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 19:41:59 INFO - Return code: 0 19:41:59 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 19:41: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')]} 19:41:59 INFO - https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:41:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:41:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:41:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/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 19:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/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 19:42:02 INFO - Downloaded 22522872 bytes. 19:42:02 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 19:42:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:42:02 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 19:42:03 INFO - Return code: 0 19:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:03 INFO - https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:42:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:42:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:42:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/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 19:42:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/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 19:42:04 INFO - Downloaded 11130997 bytes. 19:42:04 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 19:42:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:42:04 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 19:42:05 INFO - Return code: 0 19:42:05 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')]} 19:42:05 INFO - https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:42:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:42:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:42:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/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 19:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Knj546atSOONOAQd_gBHdg/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 19:42:06 INFO - Downloaded 57453215 bytes. 19:42:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:42:06 INFO - mkdir: /builds/slave/test-pgo/properties 19:42:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:42:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:42:06 INFO - Contents: 19:42:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:42:06 INFO - Running post-action listener: _resource_record_post_action 19:42:06 INFO - Running post-action listener: set_extra_try_arguments 19:42:06 INFO - ##### 19:42:06 INFO - ##### Running populate-webroot step. 19:42:06 INFO - ##### 19:42:06 INFO - Running pre-action listener: _resource_record_pre_action 19:42:06 INFO - Running main action method: populate_webroot 19:42:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:42:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:42:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:42:06 INFO - '../fennec_ids.txt'], 19:42:06 INFO - 'tests': ['tcheck2']}, 19:42:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:42:06 INFO - '--tppagecycles', 19:42:06 INFO - '7'], 19:42:06 INFO - 'tests': ['tsvgm']}}, 19:42:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:42:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:42:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:42:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:42:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:42:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:42:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:42:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:06 INFO - 'talos_options': ['--e10s'], 19:42:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:42:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:06 INFO - 'tests': ['damp', 'tps']}, 19:42:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:06 INFO - 'talos_options': ['--e10s'], 19:42:06 INFO - 'tests': ['damp', 'tps']}, 19:42:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:42:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:42:06 INFO - 'other': {'tests': ['a11yr', 19:42:06 INFO - 'ts_paint', 19:42:06 INFO - 'tpaint', 19:42:06 INFO - 'sessionrestore', 19:42:06 INFO - 'sessionrestore_no_auto_restore']}, 19:42:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:42:06 INFO - 'tests': ['a11yr', 19:42:06 INFO - 'ts_paint', 19:42:06 INFO - 'tpaint', 19:42:06 INFO - 'sessionrestore', 19:42:06 INFO - 'sessionrestore_no_auto_restore']}, 19:42:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:42:06 INFO - 'tests': ['a11yr', 19:42:06 INFO - 'ts_paint', 19:42:06 INFO - 'tpaint', 19:42:06 INFO - 'sessionrestore', 19:42:06 INFO - 'sessionrestore_no_auto_restore']}, 19:42:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:42:06 INFO - 'tests': ['a11yr', 19:42:06 INFO - 'ts_paint', 19:42:06 INFO - 'tpaint', 19:42:06 INFO - 'sessionrestore', 19:42:06 INFO - 'sessionrestore_no_auto_restore']}, 19:42:06 INFO - 'other_l64': {'tests': ['a11yr', 19:42:06 INFO - 'ts_paint', 19:42:06 INFO - 'tpaint', 19:42:06 INFO - 'sessionrestore', 19:42:06 INFO - 'sessionrestore_no_auto_restore']}, 19:42:06 INFO - 'other_nol64': {'tests': ['a11yr', 19:42:06 INFO - 'ts_paint', 19:42:06 INFO - 'tpaint', 19:42:06 INFO - 'sessionrestore', 19:42:06 INFO - 'sessionrestore_no_auto_restore']}, 19:42:06 INFO - 'svgr': {'tests': ['tsvgx', 19:42:06 INFO - 'tsvgr_opacity', 19:42:06 INFO - 'tart', 19:42:06 INFO - 'tscrollx', 19:42:06 INFO - 'cart']}, 19:42:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:42:06 INFO - 'tests': ['tsvgx', 19:42:06 INFO - 'tsvgr_opacity', 19:42:06 INFO - 'tart', 19:42:06 INFO - 'tscrollx', 19:42:06 INFO - 'cart']}, 19:42:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:06 INFO - 'tests': ['tp5o']}, 19:42:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:06 INFO - 'talos_options': ['--e10s'], 19:42:06 INFO - 'tests': ['tp5o']}, 19:42:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:06 INFO - 'talos_options': ['--xperf_path', 19:42:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:42:06 INFO - 'tests': ['tp5n']}, 19:42:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:06 INFO - 'talos_options': ['--e10s', 19:42:06 INFO - '--xperf_path', 19:42:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:42:06 INFO - 'tests': ['tp5n']}}, 19:42:06 INFO - 'talos.zip': {'path': '', 19:42:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:42:06 INFO - Running post-action listener: _resource_record_post_action 19:42:06 INFO - ##### 19:42:06 INFO - ##### Running create-virtualenv step. 19:42:06 INFO - ##### 19:42:06 INFO - Running pre-action listener: _resource_record_pre_action 19:42:06 INFO - Running main action method: create_virtualenv 19:42:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:42:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:42:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:42:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:42:06 INFO - Using real prefix '/usr' 19:42:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:42:07 INFO - Installing distribute.............................................................................................................................................................................................done. 19:42:09 INFO - Installing pip.................done. 19:42:09 INFO - Return code: 0 19:42:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d15b97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5a90>, '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 0x1e07f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e082e0>, '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': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', '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 19:42:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:42:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:42:09 INFO - Using env: {'DISPLAY': ':0', 19:42:09 INFO - 'HOME': '/home/cltbld', 19:42:09 INFO - 'LANG': 'en_US.UTF-8', 19:42:09 INFO - 'LANGUAGE': 'en_US:en', 19:42:09 INFO - 'LOGNAME': 'cltbld', 19:42:09 INFO - 'MAIL': '/var/mail/cltbld', 19:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:09 INFO - 'MOZ_NO_REMOTE': '1', 19:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:09 INFO - 'NO_EM_RESTART': '1', 19:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:42:09 INFO - 'PWD': '/builds/slave/test-pgo', 19:42:09 INFO - 'SHELL': '/bin/bash', 19:42:09 INFO - 'SHLVL': '1', 19:42:09 INFO - 'TERM': 'linux', 19:42:09 INFO - 'TMOUT': '86400', 19:42:09 INFO - 'USER': 'cltbld', 19:42:09 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', 19:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:09 INFO - '_': '/tools/buildbot/bin/python'} 19:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:09 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 19:42:09 INFO - Cleaning up... 19:42:09 INFO - Return code: 0 19:42:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d15b97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5a90>, '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 0x1e07f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e082e0>, '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': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', '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 19:42:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:42:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:42:09 INFO - Using env: {'DISPLAY': ':0', 19:42:09 INFO - 'HOME': '/home/cltbld', 19:42:09 INFO - 'LANG': 'en_US.UTF-8', 19:42:09 INFO - 'LANGUAGE': 'en_US:en', 19:42:09 INFO - 'LOGNAME': 'cltbld', 19:42:09 INFO - 'MAIL': '/var/mail/cltbld', 19:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:09 INFO - 'MOZ_NO_REMOTE': '1', 19:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:09 INFO - 'NO_EM_RESTART': '1', 19:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:42:09 INFO - 'PWD': '/builds/slave/test-pgo', 19:42:09 INFO - 'SHELL': '/bin/bash', 19:42:09 INFO - 'SHLVL': '1', 19:42:09 INFO - 'TERM': 'linux', 19:42:09 INFO - 'TMOUT': '86400', 19:42:09 INFO - 'USER': 'cltbld', 19:42:09 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', 19:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:09 INFO - '_': '/tools/buildbot/bin/python'} 19:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:09 INFO - Downloading/unpacking psutil>=0.7.1 19:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:11 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:42:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:42:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:42:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:42:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:42:11 INFO - Installing collected packages: psutil 19:42:11 INFO - Running setup.py install for psutil 19:42:11 INFO - building 'psutil._psutil_linux' extension 19:42:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:42:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:42:11 INFO - building 'psutil._psutil_posix' extension 19:42:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:42:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:42:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:42:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:42:11 INFO - Successfully installed psutil 19:42:11 INFO - Cleaning up... 19:42:11 INFO - Return code: 0 19:42:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d15b97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5a90>, '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 0x1e07f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e082e0>, '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': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', '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 19:42:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:42:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:42:11 INFO - Using env: {'DISPLAY': ':0', 19:42:11 INFO - 'HOME': '/home/cltbld', 19:42:11 INFO - 'LANG': 'en_US.UTF-8', 19:42:11 INFO - 'LANGUAGE': 'en_US:en', 19:42:11 INFO - 'LOGNAME': 'cltbld', 19:42:11 INFO - 'MAIL': '/var/mail/cltbld', 19:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:11 INFO - 'MOZ_NO_REMOTE': '1', 19:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:11 INFO - 'NO_EM_RESTART': '1', 19:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:42:11 INFO - 'PWD': '/builds/slave/test-pgo', 19:42:11 INFO - 'SHELL': '/bin/bash', 19:42:11 INFO - 'SHLVL': '1', 19:42:11 INFO - 'TERM': 'linux', 19:42:11 INFO - 'TMOUT': '86400', 19:42:11 INFO - 'USER': 'cltbld', 19:42:11 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', 19:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:11 INFO - '_': '/tools/buildbot/bin/python'} 19:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:42:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:42:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:42:13 INFO - Installing collected packages: mozsystemmonitor 19:42:13 INFO - Running setup.py install for mozsystemmonitor 19:42:13 INFO - Successfully installed mozsystemmonitor 19:42:13 INFO - Cleaning up... 19:42:13 INFO - Return code: 0 19:42:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d15b97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5a90>, '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 0x1e07f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e082e0>, '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': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', '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 19:42:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:42:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:42:13 INFO - Using env: {'DISPLAY': ':0', 19:42:13 INFO - 'HOME': '/home/cltbld', 19:42:13 INFO - 'LANG': 'en_US.UTF-8', 19:42:13 INFO - 'LANGUAGE': 'en_US:en', 19:42:13 INFO - 'LOGNAME': 'cltbld', 19:42:13 INFO - 'MAIL': '/var/mail/cltbld', 19:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:13 INFO - 'MOZ_NO_REMOTE': '1', 19:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:13 INFO - 'NO_EM_RESTART': '1', 19:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:42:13 INFO - 'PWD': '/builds/slave/test-pgo', 19:42:13 INFO - 'SHELL': '/bin/bash', 19:42:13 INFO - 'SHLVL': '1', 19:42:13 INFO - 'TERM': 'linux', 19:42:13 INFO - 'TMOUT': '86400', 19:42:13 INFO - 'USER': 'cltbld', 19:42:13 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', 19:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:13 INFO - '_': '/tools/buildbot/bin/python'} 19:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:14 INFO - Downloading/unpacking blobuploader==1.2.4 19:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:15 INFO - Downloading blobuploader-1.2.4.tar.gz 19:42:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:42:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:42:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:42:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:42:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:42:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:16 INFO - Downloading docopt-0.6.1.tar.gz 19:42:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:42:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:42:16 INFO - Installing collected packages: blobuploader, requests, docopt 19:42:16 INFO - Running setup.py install for blobuploader 19:42:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:42:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:42:16 INFO - Running setup.py install for requests 19:42:16 INFO - Running setup.py install for docopt 19:42:16 INFO - Successfully installed blobuploader requests docopt 19:42:16 INFO - Cleaning up... 19:42:17 INFO - Return code: 0 19:42:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:42:17 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')]} 19:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:17 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')]} 19:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:17 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 0x7f5d15b97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5a90>, '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 0x1e07f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e082e0>, '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': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', '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 19:42:17 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 19:42:17 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 19:42:17 INFO - Using env: {'DISPLAY': ':0', 19:42:17 INFO - 'HOME': '/home/cltbld', 19:42:17 INFO - 'LANG': 'en_US.UTF-8', 19:42:17 INFO - 'LANGUAGE': 'en_US:en', 19:42:17 INFO - 'LOGNAME': 'cltbld', 19:42:17 INFO - 'MAIL': '/var/mail/cltbld', 19:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:17 INFO - 'MOZ_NO_REMOTE': '1', 19:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:17 INFO - 'NO_EM_RESTART': '1', 19:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:42:17 INFO - 'PWD': '/builds/slave/test-pgo', 19:42:17 INFO - 'SHELL': '/bin/bash', 19:42:17 INFO - 'SHLVL': '1', 19:42:17 INFO - 'TERM': 'linux', 19:42:17 INFO - 'TMOUT': '86400', 19:42:17 INFO - 'USER': 'cltbld', 19:42:17 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', 19:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:17 INFO - '_': '/tools/buildbot/bin/python'} 19:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:42:17 INFO - Running setup.py (path:/tmp/pip-IVc8yw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:42:17 INFO - Running setup.py (path:/tmp/pip-3cdIR6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:42:17 INFO - Running setup.py (path:/tmp/pip-mLz9Ki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:42:17 INFO - Running setup.py (path:/tmp/pip-i9N0UV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:42:17 INFO - Running setup.py (path:/tmp/pip-sFjVcj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:42:17 INFO - Running setup.py (path:/tmp/pip-qFlT7q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:42:17 INFO - Running setup.py (path:/tmp/pip-ZBjCBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:42:17 INFO - Running setup.py (path:/tmp/pip-IwFmRm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:42:17 INFO - Running setup.py (path:/tmp/pip-ajoBWi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:42:17 INFO - Running setup.py (path:/tmp/pip-Z3Qm_j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:42:17 INFO - Running setup.py (path:/tmp/pip-Iqh8PX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:42:18 INFO - Running setup.py (path:/tmp/pip-OQ52T4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:42:18 INFO - Running setup.py (path:/tmp/pip-hUNAEw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:42:18 INFO - Running setup.py (path:/tmp/pip-WfQsZ0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:42:18 INFO - Running setup.py (path:/tmp/pip-LHJx1v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:42:18 INFO - Running setup.py (path:/tmp/pip-elVoUg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:42:18 INFO - Running setup.py (path:/tmp/pip-_7bqkJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:42:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:42:18 INFO - Running setup.py install for manifestparser 19:42:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:42:18 INFO - Running setup.py install for mozcrash 19:42:18 INFO - Running setup.py install for mozdebug 19:42:18 INFO - Running setup.py install for mozdevice 19:42:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:42:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:42:18 INFO - Running setup.py install for mozfile 19:42:19 INFO - Running setup.py install for mozhttpd 19:42:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:42:19 INFO - Running setup.py install for mozinfo 19:42:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:42:19 INFO - Running setup.py install for mozInstall 19:42:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:42:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:42:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:42:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:42:19 INFO - Running setup.py install for mozleak 19:42:19 INFO - Running setup.py install for mozlog 19:42:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:42:19 INFO - Running setup.py install for moznetwork 19:42:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:42:19 INFO - Running setup.py install for mozprocess 19:42:19 INFO - Running setup.py install for mozprofile 19:42:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:42:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:42:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:42:19 INFO - Running setup.py install for mozrunner 19:42:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:42:19 INFO - Running setup.py install for mozscreenshot 19:42:20 INFO - Running setup.py install for moztest 19:42:20 INFO - Running setup.py install for mozversion 19:42:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:42:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:42:20 INFO - Cleaning up... 19:42:20 INFO - Return code: 0 19:42:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:42:20 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')]} 19:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:20 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')]} 19:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:20 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 0x7f5d15b97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5a90>, '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 0x1e07f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e082e0>, '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': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', '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 19:42:20 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 19:42:20 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 19:42:20 INFO - Using env: {'DISPLAY': ':0', 19:42:20 INFO - 'HOME': '/home/cltbld', 19:42:20 INFO - 'LANG': 'en_US.UTF-8', 19:42:20 INFO - 'LANGUAGE': 'en_US:en', 19:42:20 INFO - 'LOGNAME': 'cltbld', 19:42:20 INFO - 'MAIL': '/var/mail/cltbld', 19:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:20 INFO - 'MOZ_NO_REMOTE': '1', 19:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:20 INFO - 'NO_EM_RESTART': '1', 19:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:42:20 INFO - 'PWD': '/builds/slave/test-pgo', 19:42:20 INFO - 'SHELL': '/bin/bash', 19:42:20 INFO - 'SHLVL': '1', 19:42:20 INFO - 'TERM': 'linux', 19:42:20 INFO - 'TMOUT': '86400', 19:42:20 INFO - 'USER': 'cltbld', 19:42:20 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', 19:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:20 INFO - '_': '/tools/buildbot/bin/python'} 19:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:42:20 INFO - Running setup.py (path:/tmp/pip-QnOctG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:42:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:42:20 INFO - Running setup.py (path:/tmp/pip-uM2P02-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:42:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:42:20 INFO - Running setup.py (path:/tmp/pip-YB6zhl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:42:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:42:20 INFO - Running setup.py (path:/tmp/pip-KjYedj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:42:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:42:20 INFO - Running setup.py (path:/tmp/pip-or_urM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:42:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:42:20 INFO - Running setup.py (path:/tmp/pip-3qBvon-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:42:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:42:20 INFO - Running setup.py (path:/tmp/pip-cvJMK3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:42:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:42:20 INFO - Running setup.py (path:/tmp/pip-0bXeIu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:42:21 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)) 19:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:42:21 INFO - Running setup.py (path:/tmp/pip-arBxM5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:42:21 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)) 19:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:42:21 INFO - Running setup.py (path:/tmp/pip-IT0YMP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:42:21 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)) 19:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:42:21 INFO - Running setup.py (path:/tmp/pip-aX0JvI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:42:21 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)) 19:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:42:21 INFO - Running setup.py (path:/tmp/pip-0NhRVo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:42:21 INFO - Running setup.py (path:/tmp/pip-EkLnzQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:42:21 INFO - Running setup.py (path:/tmp/pip-xgLTHX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:42:21 INFO - Running setup.py (path:/tmp/pip-ehNPU7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:42:21 INFO - Running setup.py (path:/tmp/pip-zPlJ8O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:42:21 INFO - Running setup.py (path:/tmp/pip-tARjV2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:42:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:42:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:23 INFO - Downloading blessings-1.5.1.tar.gz 19:42:23 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:42:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:42:23 INFO - Installing collected packages: blessings 19:42:23 INFO - Running setup.py install for blessings 19:42:23 INFO - Successfully installed blessings 19:42:23 INFO - Cleaning up... 19:42:23 INFO - Return code: 0 19:42:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:42:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:42:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:42:23 INFO - Reading from file tmpfile_stdout 19:42:23 INFO - Current package versions: 19:42:23 INFO - argparse == 1.2.1 19:42:23 INFO - blessings == 1.5.1 19:42:23 INFO - blobuploader == 1.2.4 19:42:23 INFO - docopt == 0.6.1 19:42:23 INFO - manifestparser == 1.1 19:42:23 INFO - mozInstall == 1.12 19:42:23 INFO - mozcrash == 0.16 19:42:23 INFO - mozdebug == 0.1 19:42:23 INFO - mozdevice == 0.47 19:42:23 INFO - mozfile == 1.2 19:42:23 INFO - mozhttpd == 0.7 19:42:23 INFO - mozinfo == 0.9 19:42:23 INFO - mozleak == 0.1 19:42:23 INFO - mozlog == 3.0 19:42:23 INFO - moznetwork == 0.27 19:42:23 INFO - mozprocess == 0.22 19:42:23 INFO - mozprofile == 0.27 19:42:23 INFO - mozrunner == 6.11 19:42:23 INFO - mozscreenshot == 0.1 19:42:23 INFO - mozsystemmonitor == 0.0 19:42:23 INFO - moztest == 0.7 19:42:23 INFO - mozversion == 1.4 19:42:23 INFO - psutil == 3.1.1 19:42:23 INFO - requests == 1.2.3 19:42:23 INFO - wsgiref == 0.1.2 19:42:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d15b97c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5a90>, '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 0x1e07f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e082e0>, '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': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', '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 19:42:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:42:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:42:23 INFO - Using env: {'DISPLAY': ':0', 19:42:23 INFO - 'HOME': '/home/cltbld', 19:42:23 INFO - 'LANG': 'en_US.UTF-8', 19:42:23 INFO - 'LANGUAGE': 'en_US:en', 19:42:23 INFO - 'LOGNAME': 'cltbld', 19:42:23 INFO - 'MAIL': '/var/mail/cltbld', 19:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:23 INFO - 'MOZ_NO_REMOTE': '1', 19:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:23 INFO - 'NO_EM_RESTART': '1', 19:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:42:23 INFO - 'PWD': '/builds/slave/test-pgo', 19:42:23 INFO - 'SHELL': '/bin/bash', 19:42:23 INFO - 'SHLVL': '1', 19:42:23 INFO - 'TERM': 'linux', 19:42:23 INFO - 'TMOUT': '86400', 19:42:23 INFO - 'USER': 'cltbld', 19:42:23 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', 19:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:23 INFO - '_': '/tools/buildbot/bin/python'} 19:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:24 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)) 19:42:24 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)) 19:42:24 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)) 19:42:24 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)) 19:42:24 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)) 19:42:24 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)) 19:42:24 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)) 19:42:24 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)) 19:42:24 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)) 19:42:24 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)) 19:42:24 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)) 19:42:24 INFO - Cleaning up... 19:42:24 INFO - Return code: 0 19:42:24 INFO - Running post-action listener: _resource_record_post_action 19:42:24 INFO - Running post-action listener: _start_resource_monitoring 19:42:24 INFO - Starting resource monitoring. 19:42:24 INFO - ##### 19:42:24 INFO - ##### Running install step. 19:42:24 INFO - ##### 19:42:24 INFO - Running pre-action listener: _resource_record_pre_action 19:42:24 INFO - Running main action method: install 19:42:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:42:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:42:24 INFO - Reading from file tmpfile_stdout 19:42:24 INFO - Detecting whether we're running mozinstall >=1.0... 19:42:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:42:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:42:24 INFO - Reading from file tmpfile_stdout 19:42:24 INFO - Output received: 19:42:24 INFO - Usage: mozinstall [options] installer 19:42:24 INFO - Options: 19:42:24 INFO - -h, --help show this help message and exit 19:42:24 INFO - -d DEST, --destination=DEST 19:42:24 INFO - Directory to install application into. [default: 19:42:24 INFO - "/builds/slave/test-pgo"] 19:42:24 INFO - --app=APP Application being installed. [default: firefox] 19:42:24 INFO - mkdir: /builds/slave/test-pgo/build/application 19:42:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:42:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:42:38 INFO - Reading from file tmpfile_stdout 19:42:38 INFO - Output received: 19:42:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:42:38 INFO - Running post-action listener: _resource_record_post_action 19:42:38 INFO - ##### 19:42:38 INFO - ##### Running run-tests step. 19:42:38 INFO - ##### 19:42:38 INFO - Running pre-action listener: _resource_record_pre_action 19:42:38 INFO - Running main action method: run_tests 19:42:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:42:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:42:38 INFO - Python 2.7.3 19:42:38 INFO - Return code: 0 19:42:38 INFO - grabbing minidump binary from tooltool 19:42: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')]} 19:42:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5a90>, '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 0x1e07f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e082e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:42:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:42:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:42:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:42:38 INFO - Return code: 0 19:42:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:42:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:42:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:42:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:42:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:42:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:42:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost 19:42:38 INFO - Using env: {'DISPLAY': ':0', 19:42:38 INFO - 'HOME': '/home/cltbld', 19:42:38 INFO - 'LANG': 'en_US.UTF-8', 19:42:38 INFO - 'LANGUAGE': 'en_US:en', 19:42:38 INFO - 'LOGNAME': 'cltbld', 19:42:38 INFO - 'MAIL': '/var/mail/cltbld', 19:42:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:42:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:38 INFO - 'MOZ_NO_REMOTE': '1', 19:42:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:38 INFO - 'NO_EM_RESTART': '1', 19:42:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:42:38 INFO - 'PWD': '/builds/slave/test-pgo', 19:42:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:42:38 INFO - 'SHELL': '/bin/bash', 19:42:38 INFO - 'SHLVL': '1', 19:42:38 INFO - 'TERM': 'linux', 19:42:38 INFO - 'TMOUT': '86400', 19:42:38 INFO - 'USER': 'cltbld', 19:42:38 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858', 19:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:38 INFO - '_': '/tools/buildbot/bin/python'} 19:42:38 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] with output_timeout 3600 19:42:39 INFO - mozversion INFO | application_buildid: 20151120173020 19:42:39 INFO - mozversion INFO | application_changeset: da4011bf914cfde650934458cd10c4a1c283980e 19:42:39 INFO - mozversion INFO | application_display_name: Nightly 19:42:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:42:39 INFO - mozversion INFO | application_name: Firefox 19:42:39 INFO - mozversion INFO | application_remotingname: firefox 19:42:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 19:42:39 INFO - mozversion INFO | application_vendor: Mozilla 19:42:39 INFO - mozversion INFO | application_version: 45.0a1 19:42:39 INFO - mozversion INFO | platform_buildid: 20151120173020 19:42:39 INFO - mozversion INFO | platform_changeset: da4011bf914cfde650934458cd10c4a1c283980e 19:42:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 19:42:39 INFO - mozversion INFO | platform_version: 45.0a1 19:42:39 INFO - 2015-11-20 19:42:39,078 DEBUG : using testdate: 1448077359 19:42:39 INFO - 2015-11-20 19:42:39,078 DEBUG : actual date: 1448077359 19:42:39 INFO - 2015-11-20 19:42:39,087 INFO : starting webserver on 'localhost:59498' 19:42:39 INFO - 2015-11-20 19:42:39,088 INFO : Starting test suite talos-linux64-ix-066 19:42:39 INFO - 2015-11-20 19:42:39,088 INFO : Starting test dromaeo_css 19:42:39 INFO - 2015-11-20 19:42:39,088 DEBUG : operating with platform_type : linux_ 19:42:39 INFO - 2015-11-20 19:42:39,089 INFO : Initialising browser for dromaeo_css test... 19:42:39 INFO - 2015-11-20 19:42:39,103 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3shWWS/profile http://localhost:59498/getInfo.html 19:42:42 INFO - 2015-11-20 19:42:42,942 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:42:42 INFO - 2015-11-20 19:42:42,942 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:42:42 INFO - 2015-11-20 19:42:42,942 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:42:42 INFO - 2015-11-20 19:42:42,942 DEBUG : BROWSER_OUTPUT: __metrics 19:42:43 INFO - 2015-11-20 19:42:43,159 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:42:44 INFO - 2015-11-20 19:42:44,372 INFO : Browser initialized. 19:42:44 INFO - 2015-11-20 19:42:44,373 INFO : Running cycle 1/1 for dromaeo_css test... 19:42:44 INFO - 2015-11-20 19:42:44,373 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3shWWS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:42:56 INFO - 2015-11-20 19:42:56,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 141533184 19:42:56 INFO - 2015-11-20 19:42:56,177 DEBUG : BROWSER_OUTPUT: 19:43:47 INFO - 2015-11-20 19:43:47,734 DEBUG : BROWSER_OUTPUT: 1448077427734 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] 19:45:56 INFO - 2015-11-20 19:45:56,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59498/tests/dromaeo/cssquery-ext.html) 19:45:57 INFO - 2015-11-20 19:45:57,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 268931072 19:45:57 INFO - 2015-11-20 19:45:57,770 DEBUG : BROWSER_OUTPUT: 19:49:00 INFO - 2015-11-20 19:49:00,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/dromaeo/cssquery-ext.html (next: http://localhost:59498/tests/dromaeo/cssquery-jquery.html) 19:49:00 INFO - 2015-11-20 19:49:00,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 227303424 19:49:00 INFO - 2015-11-20 19:49:00,858 DEBUG : BROWSER_OUTPUT: 19:52:02 INFO - 2015-11-20 19:52:02,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59498/tests/dromaeo/cssquery-mootools.html) 19:52:03 INFO - 2015-11-20 19:52:03,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 215523328 19:52:03 INFO - 2015-11-20 19:52:03,283 DEBUG : BROWSER_OUTPUT: 19:55:05 INFO - 2015-11-20 19:55:05,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59498/tests/dromaeo/cssquery-prototype.html) 19:55:05 INFO - 2015-11-20 19:55:05,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 202625024 19:55:05 INFO - 2015-11-20 19:55:05,786 DEBUG : BROWSER_OUTPUT: 19:58:08 INFO - 2015-11-20 19:58:08,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59498/tests/dromaeo/cssquery-yui.html) 19:58:08 INFO - 2015-11-20 19:58:08,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 208084992 19:58:08 INFO - 2015-11-20 19:58:08,969 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-20 20:01:11,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/dromaeo/cssquery-yui.html (next: http://localhost:59498/tests/dromaeo/cssquery-dojo.html) 20:01:11 INFO - 2015-11-20 20:01:11,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 270897152 20:01:11 INFO - 2015-11-20 20:01:11,562 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-20 20:01:11,564 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:01:11 INFO - 2015-11-20 20:01:11,564 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:01:11 INFO - 2015-11-20 20:01:11,564 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:01:11 INFO - 2015-11-20 20:01:11,564 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:01:11 INFO - 2015-11-20 20:01:11,566 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3212.8232947187903;3272.7381809455246;3310.2717402171515;3316.502524621308;3339.465685490322;5344.706041167734;5446.809361672343;5489.176623506471;5499.147632117023;5506.862328441781;5286.180642000496;5488.259085023521;5515.834524964247;5532.419095994923;5532.723363831802;4978.427480839714;5027.773750181251;5048.747562621873;5096.745162741848;5157.5358217760395;4845.878853028685;5169.663971841818;5178.249153872686;5203.245529398235;5250.579953603722;4942.678725882806;4976.726280054596;5005.34930459038;5009.974950125226;5031.572316353115;5012.072766538202;5044.6973181608855;5048.268001139851;5062.696238225682;5096.464871188509;4905.337779399771;4996.100701873661;5015.247712843066;5027.547520723116;5045.167547354718;5282.947170528322;5346.1713434417725;5355.062863998784;5360.9463905360835;5362.705051222181;5992.250968628921;6039.275286965549;6042.788502402439;6043.8791224175275;6045.879082418327;5813.128030795372;5917.852053698649;5931.139984702238;6057.636541807506;6083.361247069082;5396.163594642837;5493.066178749622;5526.944730552683;5550.333959924835;5550.500454959073;6021.157038014681;6021.57848950578;6022.066579680157;6075.210222671025;6133.049377346519;5755.079187330007;5792.189093526909;5792.362840087587;5799.971000144972;5831.241938547962;5865.853353666193;5903.0260007099205;5956.583039187215;5968.432998865188;5991.820245392645;5890.823275301748;5907.7046147692445;5916.585838991229;5930.644161350333;5952.107183922446;5760.769569217268;5923.407659234128;5929.911051334234;5940.108983652487;5941.405859414111;4529.728216307032;4575.22221222393;4625.352450656911;4643.883902902455;4646.814127434933;4032.1330913853662;4036.7577945323374;4042.6159514846045;4043.5754245804355;4073.409355643415;5571.526420254324;5572.219889215513;5574.136008918624;5575.637583557056;5629.43705629442;5785.27684039495;5866.208061911588;5911.349751527328;5914.733836977346;5922.289325280994;5620.072688006433;5620.85947851307;5622.409646987089;5624.887502250014;5630.296212973379;5157.381114266312;5164.948350516447;5171.198464238049;5180.093483640348;5212.817551385683;6000.969995149996;6043.184170137063;6099.113073221168;6111.205543279434;6239.594426362272;6015.292440509923;6023;6026.276846778414;6028.788992385245;6089;6269.279032911091;6270.968645156745;6271.811845644638;6272.310045894857;6282.811515654537;5681.375048744718;5777.7977770777825;5813.128030795415;5843.152742852348;5875.882482350415;5909.970450147722;5918.408159184047;5919.6152250103605;5920.171176035445;5928;5709.600327977002;5786.161006654096;5792.7103644818435;5848.970755146197;5852.18069470266;5723.456271654186;5750.079987202028;5764.423557644202;5856.94143058564;5904.970475147768;5694.743736531949;5697.401772813961;5752.856178595569;5757.884842303214;5765.56758243125;5630.5777066720975;5851.736671849691;5874.911876321773;5876.41235876409;5883.852903677443;5694.402087780723;5727.284089488814;5771;5809.331926828299;5854.882902342015 20:01:11 INFO - 2015-11-20 20:01:11,569 DEBUG : BROWSER_OUTPUT: |1;ext.html;581.4214856218063;582.883423315337;584.3367777572455;600.2167171840752;601.5728832528904;28958.85520572397;29779.5110244488;29796.553051704243;29847.552286715716;29849.403011939747;32067.35865282693;32328.838355808188;40157.397639035364;40898;40926.79536602313;8672.219500244977;8791.384603077755;8797.560121993874;8811.691590794324;8820.426672266314;8646.956765216166;8739.95630021849;8752;8760.824783504326;8764.43031202973;7774.2614451627005;7919.168487308807;10455;10717;10765.515551800148;10229.181665466782;10342.586296548128;10344.034633419664;10358.63744768937;10362;7910.4067194960035;8124.390670699662;10176.389416634951;10334.534945927377;10355.534000969974;43043.7847810759;44154.55845441537;44179.55820441787;44181.337279940824;44203.557964420266;3194.552762613236;3231.046841181857;3235.8705651773903;3275.0829767664854;3326.467765157563;28446.857765711247;29621.70378296211;30185.849070754724;30187.849060754557;30654.846725766227;3906.2187562487616;3958.782266975315;4015.8393664253394;4082.265192265391;4107.650849677781;254639;255754;255931.72034139896;256022;256561;59101.70449147727;59118.40881591215;59201;59207.111893321635;59258;62460;62488;62492.68753656203;62546.68726656429;62645;15120.168390738614;15199.31603077842;15284.923575382052;15397.769033464507;15405.15271660047;11558.768824623461;11641.53433862636;11651.242669226473;11651.766964660828;11653.41732913351;18465.169067392;19642.410727678194;19727.30954416617;19750.30873919406;19771.30800422007;7802.804929876798;8021.2379823916635;8025.117237103914;8086.757397278091;8129.227723366271;907.9409838360485;918.6509126531876;959.836827739286;1050.2543194331956;1067.1196263082988;28534.28664283368;28738.856305718757;28822.855885720437;28930.42139157205;29100.854495727384;946.3091942881734;1000.8298589239847;1035.9585616575253;1037.7872536130076;1045.1429827541494;14231.644208894653;14232.146071235758;14551;14555.345009474388;15811.920940395454;378969.2618442847;382603;382763;383640;676496;47162.76418617885;47679.28481072787;58625.70687146537;60587.39412605818;60899.69550152309;1306.6276111308232;1333.3200067965408;1338.9263590502617;1341.6310514608365;1341.9329033548088;25964.74035259699;27494;27734.5839812407;28681.42637147287;31138.37723245477;48142;48750.756246219964;48754.75622622006;48766.51233487762;48790.51209488002;283837;285035;285462;285983;286151;31309.84345078351;31337.529937050505;31705.68294317027;32000;32006.199845004063;40694.79652601718;40812.79593602013;41081.79459102685;41095.1780964373;41181.382279266436;34865.30269394547;35308.29383412369;35447.64552354444;35560.110997225274;36032.639673603975;35305.293894122486;35484;35743.285134296646;36102.4584631236;36155.81922090373;34251.82874085614;35086.29827403489;35340;35367.29265414626;35429.29141417209;28708;31918.488966213234;32013.35973280568;32042.51936220912;32346.353072937938;23608.763912361344;23675;23703.881480592485;23889.641655374835;23976.760232397453 20:01:11 INFO - 2015-11-20 20:01:11,571 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.27402188502634;354.6046158533235;356.4528448831045;358.7506682855415;359.2402069622747;13881.514147004857;14127;16418.753718694214;17238.482845514638;18404.539886502844;14996;16258.674826503493;16328.591785205375;16368;16955;5312.442193569668;5445.782168713246;5450.809221677242;5454.836354909359;5456.072467680504;3884.8834534964;3904.824282907262;5432.70120143392;5443.129099344106;5922.822315330547;6001.579889407743;6033.668148251844;6042.486388656969;6052.697365131726;6060.454559089681;5590.748416321276;5747.023006088975;5750.108733146327;5750.539956803445;6015.939840601582;5074.619403544712;5075.365579302587;5081.568066714333;5081.745912704387;5254.106801843695;19600.117994690274;20180.69728954067;20240.696389554167;20988.580228395498;21007.684884726743;2010.45717656232;2068.214078650118;2088.5196404826825;2089.5925294567564;2200.9779902200935;9549.09283618055;9613.038696130401;9725.65960191397;9733.707988760349;9740.512974351324;1834.257125864027;1865.3378050792044;1886.745289385929;1891.6689579323702;1920.6446807340687;59844.40155598432;63773.36226637767;67556;68183.65908170477;69020.6548967252;14905.180215088274;15246.46637367709;15304.770428443582;15320.770188447183;15338.539843804703;22945.54108917812;22953.885230573742;23045.193418230283;23076.423089422562;23147.189848355563;8286.254237118568;8287.212714792086;8311.376646751518;8324.70863519786;8466.830663386698;6956.373926346653;6958.965205173941;6982.965085174643;6990.61551614666;7005.754798582026;7911.564863932424;7930.444868859125;7960.363170946311;8056.39577031725;8103;2731.4810186064583;3014.8492575371583;3038.5594088857433;3116.25209949615;3132.7493800495904;446.910617876426;903.7857249738167;922.6678395777515;951.4909523404945;981.4945303168873;10598.258121931545;11028.393438360967;11096;11223.989840914357;11226.943865280622;427.50196021634446;438.8595649392164;450.11103071433655;462.6183398696089;469.99295010574866;5932.466078052996;6061.181740465069;6065;6144.539159563051;6170.259568851767;492061;529494;534008;539384;550344;81981.59009204915;85163.5741821287;85226.14773852307;85229;85531.14468855232;1025.6307729217624;1106.7011906785124;1119.731264496515;1123.853898993142;1131.332513816852;13138.408771605109;14777.482788102365;14947.177905215318;15485.458008969632;15727.213639317759;36854.26909925917;36863.07842303964;37076.258474830895;37119.814400927826;37787.81106094452;48626.5137348622;48709.26936096032;50573.74713126411;51494;51554;9360.906390936003;9662.613495460102;9728.270379721691;9751.902480975099;9762.658306959222;11428.2000259981;11446.885531144582;12053.879461205275;17308.91345543264;17427.39004134849;14359.425622974964;14455.566333010027;14631.634209144431;14793.559062754955;14910.925445372704;14159.504417345755;14202.431902723776;14403.42386304536;14521.201333926736;14631.487897923522;14356.85643143597;14516.927415362856;14756.778648320069;15070.397184112513;15201.6199595011;9212.953935230282;9425.151736343762;9620.567074481525;9642.264392409434;9674.371165874196;10081.092701656886;10137.797244055226;12374.876251237372;13834.15804468428;14104.730574248368 20:01:11 INFO - 2015-11-20 20:01:11,572 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1298.0653929170994;1665.8417450342217;1717.1585922897775;1728.5678580354906;1736.9218385172674;6641.867162656744;7689.577073260968;7848.332891704212;7854.92145078549;7855.567943763105;7684.846303073935;7811.882821757678;7818.257265559762;7819.178986206452;7820.061592608895;1976.2984140630085;2007.6586980213326;2214.1254204589177;2290.8854557272193;2312.838101332907;2311.2257393773107;2314.2710046335433;2316.7104111986;2316.9189078382174;2320.118355025088;2217.090992692996;2301.5051763870765;2303.53929214157;2304.9078036878504;2306.077568972408;1987.473319570315;2023.2513969831184;2269.5234000859755;2300.1489448904013;2300.367398965281;2269.909203631853;2279.658051292319;2304.919327823518;2305.4005958450757;2357.7760112789256;7807.258310460497;7886.960565197137;7889.974303340529;7893.171217022187;7897.052353717533;4576.695641742088;4621.7920193591035;4652.162610730067;4655.301704744282;4673.859784206479;3095.9845200773852;3124.156477751017;3138.1997590614474;3183.267848394882;3312.5362449257123;981.3670182732169;985.4481490365418;1019.2661283875598;1021.5505177721778;1050.3907733514543;10850.29473084247;10957.342559446459;10966.232363734542;10976.12191024716;10977.506012229469;4067.471228740245;4167.91664166715;4174.248635245624;4215;4271.829126834954;8965.820683586291;8970.82058358829;8978.595963181673;8978.685745998859;8983.505907175168;4649.930251046237;4693.084848454587;4695.131400690883;4701.177293973541;4702.059588082398;4272.786360681954;4318.654507639381;4319.8488052918;4319.956800431955;4320.481542214891;3313.7183339415938;3369.0566641340465;3391.0844072100394;3392.660733926637;3402.6767457091537;1022.5194158745378;1033.452270296744;1042.3954106618144;1043.9269251152498;1047.4134484688598;961.2358175250693;1266.4934026389517;1293.6959814443599;1297.331874084847;1347.9595612131652;6557.803265902031;7486.7005319786595;7488.438367122488;7488.438367122488;7499.437542184358;574.5977815529146;577.4946921443736;592.1295695327861;595.8748662780778;604.7701873288211;5668.036433806263;5713.228714123623;5719.799807006735;5734.369219385864;5787.710614469344;9554.283428742872;9588.424694518211;9694.175995040501;9694.46680432583;9723.659671911591;9395.436273823592;9589.849218093874;9599.760005999906;9604.75988100303;9607.711768646952;7357.558546487228;7357.705691772377;7419.183889772121;7421.369183619345;7429.702811887572;7008.789736307919;7102.18324892644;7129.643517824192;7150.320719531636;7154;8360.331173506227;8421.747347579583;8482.660693572188;8485.830283394174;8530.78673033179;8672.739817805475;8696.521691307038;8804.559772011502;8809.823803523765;8831.116888311117;6786.21958474762;6864.862702746017;6870;6871.244163142151;6877.277885821916;7662.310392064741;7736.613169341623;7740.729074482366;7765.7670269892;7775.805604859924;7183;7233.348998590152;7290.781276561712;7330.670119844726;7396.889046664197;7092.5389849659605;7196.712131514891;7198.6400679964745;7304.744333948286;7332.633368331455;6281.52888533371;6361.650109244036;7199.1361036675935;7280.526765760209;7281.05346304977;6436;6525.967370163309;6599.571027883172;6603.9009414859775;6609.173853268341;6559.508036897348;6594.538382313192;6608.900866486911;6627.768028118992;6630.469562434897 20:01:11 INFO - 2015-11-20 20:01:11,576 DEBUG : BROWSER_OUTPUT: |4;prototype.html;336.87872365948255;337.98986030419087;341.82396066026;350.6125731067172;353.90267676388976;5799.1881136640795;5952.6130801497875;5953.464188223059;5959.165716799641;5960.493358064565;5754.4533269339345;5897.911531327023;5916.0830071338905;5922.674252916088;5946.672932988684;4567.748773817447;4569.9314510282375;4571.748553829538;4579.3131030345385;4579.931301030487;4421.314696222091;4465.218586747323;4500.459944806627;4580.038191979688;4597.54024597541;4531.728096314215;4545.772711364435;4554.795034223452;4581.518940511249;4587.311903214528;4580.816767329303;4586.174488592069;4587.7706114694465;4593.379893714339;4602.976985115087;4063;4067.5118985721606;4067.7559346439307;4070.30804763188;4071.145059537501;5524.8342549723175;5633.070543360341;5637.49262566371;5720.2849643794525;5728.799492017801;5398.78404863805;5402.324709411324;5403.864903377408;5404.405515393303;5404.432534583891;6051.485623721989;6344.873102537969;6365.458935990447;6371.458426033792;6372.076048972873;4389.824407023715;4422.84520041797;4510.458744950627;4513.165064463052;4518.819247230107;6475.51433642474;6564.7374105036215;6570.704318305688;6576.375244351779;6577.375149360803;4655.790489427984;4661.580457758818;4664.160451118763;4666.906661866744;4670.042641258534;4617.960958784314;4712.31671407644;4717.599004084623;4729.456112547101;4758.714477131314;5382.49290198745;5394.64934779246;5396.568274538027;5400.702961337164;5401.081816091274;6419.486441084702;6419.775307864203;6420.293767685551;6420.454261387741;6425.971844504857;1641.3024464602736;1646.209819286749;1656.2795184094716;1657.9336826526803;1658.0549087020524;1128.610629332879;1148.2364227788594;1150.764093360859;1151.3955173533961;1174.8590169179581;6088.452039316483;6120.204373431426;6129.448349648553;6131.50947924165;6131.724072416752;6458.806235812933;6467.838304042437;6474.12599299098;6479.740810367627;6480.125183100221;5955.106733989849;6106.969465152646;6118.021116621319;6122.785702500391;6127.908081378783;3464.72282217422;3508.8421021053605;3508.8421021054114;3513;3516.7538272320694;6735.696893639798;6738.9554619034125;6744.258131605519;6746.763863264762;6746.865062698718;6538.640374779433;6548.770793022221;6551.312112228243;6573.441257493167;6582.473402127818;6671.799846004531;6837.829054273583;6891.517593768388;6910.896336554955;6912.101426814482;6349.238091429058;6451.2903580607035;6529.118568993125;6627.436667883284;6634.601923884582;6501.674916254263;6512.869742605216;6551.4103730664465;6553.377429144223;6563.507736919654;6873.725050997904;6886.7933961979215;6893.724251029903;6894.965525172342;6895.827604309932;4405.03089320349;4414.381986521826;4429.180601588717;4520.299353600197;4522.728636281834;6548.869022619426;6557.9179435394535;6563.573367731082;6566;6571.01434784767;6355.428011478989;6373.107764912823;6373.745050198126;6379.106925030406;6380.712867921047;6211.844703882439;6306.054091886253;6332.050192471166;6401;6416.101745755504;6298.685065746786;6321.0834429008455;6328.145700330397;6331.746730130927;6338.873222535616;6447.806565803034;6456.12842266288;6458;6461.935380646321;6475.708593113415;6169.907451388143;6312.495000400048;6312.558120931674;6317.810465686037;6324.905126423016 20:01:11 INFO - 2015-11-20 20:01:11,576 DEBUG : BROWSER_OUTPUT: |5;yui.html;790.8497385496757;847.3856454070798;849.4818160921841;851.7444766570028;860.3074525007366;13167.934160329198;13355.933220333885;13379.933100334485;13535.255560944157;13540.322983850805;11203.383813890232;12342.876571234285;12367.690807729812;12403.069769767259;12438.81341779874;652.6867103790172;660.3693472733552;804.6580203413555;818.8648872935959;819.4059307002435;811.7524155132683;818.2308629887887;818.2594751749676;819.6639377855081;821.6918655504186;835.5237514616671;837.392890154636;846.1453931529169;846.7713717296326;848.007830837918;839.8068444257793;840.7435732101707;840.756180707594;840.9789755256106;842.9114942930996;515.9045576568309;522.0550803046498;619.3991827926903;627.9152314437538;628.6259675493075;12808.295543745091;12881.355932203445;12909.031822613342;12920.22478651284;12968.221906685534;11420.486078126421;12432.813507797391;12654.746905061938;12692.873071269261;12944.87055129446;9541.47521886303;9588.568514416867;9588.90411095887;9672.468014259213;9847.704568862946;3628.1473853644375;3630.3465376232266;3684.9263014739554;3688.5573731152435;3776.9811150944342;44161.33757993633;44247.77876110631;44257.33613995793;44443.111137777385;44576.554234457886;9717.514124293757;9856.655017074369;9914.80170396588;9930.106290433896;9945.602175913027;17749.467515974542;17769.11154442273;17800.198991045436;17819.10904454772;17829.554261143574;7219.963900180465;7367.263273672697;7383.593902335316;7433.331000210007;7565.167831538526;4162.146759914211;4198.64784251341;4212.143584013424;4253.191893540279;4254.361845723104;3028.13698096046;3050.6949305069315;3056.831874246938;3057.373238486105;3060.648025477054;519.3819354967577;521.7287010754386;527.4224723927293;527.8891432799155;532.6138549551545;617.718937883262;625.6934102289845;641.7144370754969;663.2935923241732;680.3638597910871;7850.725224617111;8376.288015518627;8504.914950850412;8584.527850968132;8668.956655216683;595.2440400691098;642.877853207889;669.263859256581;677.3463607618671;684.1619016704498;3472.8958131256104;3734.6452087051684;3740.5137332146646;3825.158465137665;3829.100161462054;56553;57855.42144578585;57871;58086.4191358081;58251;48588.5141148584;49467.257991130165;49839.50160498349;49979;49996;46080.5391946083;46758.29862552064;47553.76223118862;48021.75989120032;48641.27038094431;7675.527268189193;7680.731174408869;8060;8100.594970251346;8244.464109832841;33872.49191262182;34155.82922085374;34826.303473929875;34833.30333393368;35070.82464587661;39544.40683389809;41796;43945.56054439543;44548.77725611351;45402.86492837706;9675.806483870143;10089.545970431202;10354.275200736178;10368.42973636427;10443.895561044596;10431.895681043092;10511.211659125443;10537.63118290856;10790.298630588986;11533.82699259495;9109;9455.243580513405;9663.420194788336;10404.167666586807;10424.843627345444;9944.45305508204;10049.748756280858;10125.493725313558;10154.187664986635;10155.796884062129;9517.23862091045;9773.9022609773;10132.49337533135;10184.18526517862;10187.949060254949;8736.69421570242;9013.909860901307;9102.226310763393;9290.62837486493;9300.069993000645;7706.499077559941;7889.211078892295;7996.680132794856;8262.504249745034;8365.916340836757 20:01:11 INFO - 2015-11-20 20:01:11,576 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:01:11 INFO - 2015-11-20 20:01:11,576 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:01:11 INFO - 2015-11-20 20:01:11,576 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,979 20:01:11 INFO - 2015-11-20 20:01:11,576 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:01:11 INFO - 2015-11-20 20:01:11,576 DEBUG : BROWSER_OUTPUT: __startTimestamp1448078471563__endTimestamp 20:01:11 INFO - 2015-11-20 20:01:11,577 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-20 20:01:11,577 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:01:11 INFO - 2015-11-20 20:01:11,577 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:01:11 INFO - 2015-11-20 20:01:11,577 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-20 20:01:11,577 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5511.07 Median:5727.28 stddev:619.22 (10.8%) stddev-sans-first:594.29 20:01:11 INFO - 2015-11-20 20:01:11,577 DEBUG : BROWSER_OUTPUT: Values: 3212.8 3272.7 3310.3 3316.5 3339.5 5344.7 5446.8 5489.2 5499.1 5506.9 5286.2 5488.3 5515.8 5532.4 5532.7 4978.4 5027.8 5048.7 5096.7 5157.5 4845.9 5169.7 5178.2 5203.2 5250.6 4942.7 4976.7 5005.3 5010.0 5031.6 5012.1 5044.7 5048.3 5062.7 5096.5 4905.3 4996.1 5015.2 5027.5 5045.2 5282.9 5346.2 5355.1 5360.9 5362.7 5992.3 6039.3 6042.8 6043.9 6045.9 5813.1 5917.9 5931.1 6057.6 6083.4 5396.2 5493.1 5526.9 5550.3 5550.5 6021.2 6021.6 6022.1 6075.2 6133.0 5755.1 5792.2 5792.4 5800.0 5831.2 5865.9 5903.0 5956.6 5968.4 5991.8 5890.8 5907.7 5916.6 5930.6 5952.1 5760.8 5923.4 5929.9 5940.1 5941.4 4529.7 4575.2 4625.4 4643.9 4646.8 4032.1 4036.8 4042.6 4043.6 4073.4 5571.5 5572.2 5574.1 5575.6 5629.4 5785.3 5866.2 5911.3 5914.7 5922.3 5620.1 5620.9 5622.4 5624.9 5630.3 5157.4 5164.9 5171.2 5180.1 5212.8 6001.0 6043.2 6099.1 6111.2 6239.6 6015.3 6023.0 6026.3 6028.8 6089.0 6269.3 6271.0 6271.8 6272.3 6282.8 5681.4 5777.8 5813.1 5843.2 5875.9 5910.0 5918.4 5919.6 5920.2 5928.0 5709.6 5786.2 5792.7 5849.0 5852.2 5723.5 5750.1 5764.4 5856.9 5905.0 5694.7 5697.4 5752.9 5757.9 5765.6 5630.6 5851.7 5874.9 5876.4 5883.9 5694.4 5727.3 5771.0 5809.3 5854.9 20:01:11 INFO - 2015-11-20 20:01:11,577 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-20 20:01:11,577 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49059.63 Median:17791.11 stddev:91162.39 (512.4%) stddev-sans-first:91345.46 20:01:11 INFO - 2015-11-20 20:01:11,578 DEBUG : BROWSER_OUTPUT: Values: 581.4 582.9 584.3 600.2 601.6 28958.9 29779.5 29796.6 29847.6 29849.4 32067.4 32328.8 40157.4 40898.0 40926.8 8672.2 8791.4 8797.6 8811.7 8820.4 8647.0 8740.0 8752.0 8760.8 8764.4 7774.3 7919.2 10455.0 10717.0 10765.5 10229.2 10342.6 10344.0 10358.6 10362.0 7910.4 8124.4 10176.4 10334.5 10355.5 43043.8 44154.6 44179.6 44181.3 44203.6 3194.6 3231.0 3235.9 3275.1 3326.5 28446.9 29621.7 30185.8 30187.8 30654.8 3906.2 3958.8 4015.8 4082.3 4107.7 254639.0 255754.0 255931.7 256022.0 256561.0 59101.7 59118.4 59201.0 59207.1 59258.0 62460.0 62488.0 62492.7 62546.7 62645.0 15120.2 15199.3 15284.9 15397.8 15405.2 11558.8 11641.5 11651.2 11651.8 11653.4 18465.2 19642.4 19727.3 19750.3 19771.3 7802.8 8021.2 8025.1 8086.8 8129.2 907.9 918.7 959.8 1050.3 1067.1 28534.3 28738.9 28822.9 28930.4 29100.9 946.3 1000.8 1036.0 1037.8 1045.1 14231.6 14232.1 14551.0 14555.3 15811.9 378969.3 382603.0 382763.0 383640.0 676496.0 47162.8 47679.3 58625.7 60587.4 60899.7 1306.6 1333.3 1338.9 1341.6 1341.9 25964.7 27494.0 27734.6 28681.4 31138.4 48142.0 48750.8 48754.8 48766.5 48790.5 283837.0 285035.0 285462.0 285983.0 286151.0 31309.8 31337.5 31705.7 32000.0 32006.2 40694.8 40812.8 41081.8 41095.2 41181.4 34865.3 35308.3 35447.6 35560.1 36032.6 35305.3 35484.0 35743.3 36102.5 36155.8 34251.8 35086.3 35340.0 35367.3 35429.3 28708.0 31918.5 32013.4 32042.5 32346.4 23608.8 23675.0 23703.9 23889.6 23976.8 20:01:11 INFO - 2015-11-20 20:01:11,578 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-20 20:01:11,578 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29123.46 Median:3894.85 stddev:86658.57 (2225.0%) stddev-sans-first:86874.74 20:01:11 INFO - 2015-11-20 20:01:11,579 DEBUG : BROWSER_OUTPUT: Values: 353.3 354.6 356.5 358.8 359.2 13881.5 14127.0 16418.8 17238.5 18404.5 14996.0 16258.7 16328.6 16368.0 16955.0 5312.4 5445.8 5450.8 5454.8 5456.1 3884.9 3904.8 5432.7 5443.1 5922.8 6001.6 6033.7 6042.5 6052.7 6060.5 5590.7 5747.0 5750.1 5750.5 6015.9 5074.6 5075.4 5081.6 5081.7 5254.1 19600.1 20180.7 20240.7 20988.6 21007.7 2010.5 2068.2 2088.5 2089.6 2201.0 9549.1 9613.0 9725.7 9733.7 9740.5 1834.3 1865.3 1886.7 1891.7 1920.6 59844.4 63773.4 67556.0 68183.7 69020.7 14905.2 15246.5 15304.8 15320.8 15338.5 22945.5 22953.9 23045.2 23076.4 23147.2 8286.3 8287.2 8311.4 8324.7 8466.8 6956.4 6959.0 6983.0 6990.6 7005.8 7911.6 7930.4 7960.4 8056.4 8103.0 2731.5 3014.8 3038.6 3116.3 3132.7 446.9 903.8 922.7 951.5 981.5 10598.3 11028.4 11096.0 11224.0 11226.9 427.5 438.9 450.1 462.6 470.0 5932.5 6061.2 6065.0 6144.5 6170.3 492061.0 529494.0 534008.0 539384.0 550344.0 81981.6 85163.6 85226.1 85229.0 85531.1 1025.6 1106.7 1119.7 1123.9 1131.3 13138.4 14777.5 14947.2 15485.5 15727.2 36854.3 36863.1 37076.3 37119.8 37787.8 48626.5 48709.3 50573.7 51494.0 51554.0 9360.9 9662.6 9728.3 9751.9 9762.7 11428.2 11446.9 12053.9 17308.9 17427.4 14359.4 14455.6 14631.6 14793.6 14910.9 14159.5 14202.4 14403.4 14521.2 14631.5 14356.9 14516.9 14756.8 15070.4 15201.6 9213.0 9425.2 9620.6 9642.3 9674.4 10081.1 10137.8 12374.9 13834.2 14104.7 20:01:11 INFO - 2015-11-20 20:01:11,579 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-20 20:01:11,579 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5482.60 Median:6541.89 stddev:2905.60 (44.4%) stddev-sans-first:2896.72 20:01:11 INFO - 2015-11-20 20:01:11,580 DEBUG : BROWSER_OUTPUT: Values: 1298.1 1665.8 1717.2 1728.6 1736.9 6641.9 7689.6 7848.3 7854.9 7855.6 7684.8 7811.9 7818.3 7819.2 7820.1 1976.3 2007.7 2214.1 2290.9 2312.8 2311.2 2314.3 2316.7 2316.9 2320.1 2217.1 2301.5 2303.5 2304.9 2306.1 1987.5 2023.3 2269.5 2300.1 2300.4 2269.9 2279.7 2304.9 2305.4 2357.8 7807.3 7887.0 7890.0 7893.2 7897.1 4576.7 4621.8 4652.2 4655.3 4673.9 3096.0 3124.2 3138.2 3183.3 3312.5 981.4 985.4 1019.3 1021.6 1050.4 10850.3 10957.3 10966.2 10976.1 10977.5 4067.5 4167.9 4174.2 4215.0 4271.8 8965.8 8970.8 8978.6 8978.7 8983.5 4649.9 4693.1 4695.1 4701.2 4702.1 4272.8 4318.7 4319.8 4320.0 4320.5 3313.7 3369.1 3391.1 3392.7 3402.7 1022.5 1033.5 1042.4 1043.9 1047.4 961.2 1266.5 1293.7 1297.3 1348.0 6557.8 7486.7 7488.4 7488.4 7499.4 574.6 577.5 592.1 595.9 604.8 5668.0 5713.2 5719.8 5734.4 5787.7 9554.3 9588.4 9694.2 9694.5 9723.7 9395.4 9589.8 9599.8 9604.8 9607.7 7357.6 7357.7 7419.2 7421.4 7429.7 7008.8 7102.2 7129.6 7150.3 7154.0 8360.3 8421.7 8482.7 8485.8 8530.8 8672.7 8696.5 8804.6 8809.8 8831.1 6786.2 6864.9 6870.0 6871.2 6877.3 7662.3 7736.6 7740.7 7765.8 7775.8 7183.0 7233.3 7290.8 7330.7 7396.9 7092.5 7196.7 7198.6 7304.7 7332.6 6281.5 6361.7 7199.1 7280.5 7281.1 6436.0 6526.0 6599.6 6603.9 6609.2 6559.5 6594.5 6608.9 6627.8 6630.5 20:01:11 INFO - 2015-11-20 20:01:11,580 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-20 20:01:11,580 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5330.46 Median:6005.99 stddev:1588.80 (26.5%) stddev-sans-first:1548.41 20:01:11 INFO - 2015-11-20 20:01:11,581 DEBUG : BROWSER_OUTPUT: Values: 336.9 338.0 341.8 350.6 353.9 5799.2 5952.6 5953.5 5959.2 5960.5 5754.5 5897.9 5916.1 5922.7 5946.7 4567.7 4569.9 4571.7 4579.3 4579.9 4421.3 4465.2 4500.5 4580.0 4597.5 4531.7 4545.8 4554.8 4581.5 4587.3 4580.8 4586.2 4587.8 4593.4 4603.0 4063.0 4067.5 4067.8 4070.3 4071.1 5524.8 5633.1 5637.5 5720.3 5728.8 5398.8 5402.3 5403.9 5404.4 5404.4 6051.5 6344.9 6365.5 6371.5 6372.1 4389.8 4422.8 4510.5 4513.2 4518.8 6475.5 6564.7 6570.7 6576.4 6577.4 4655.8 4661.6 4664.2 4666.9 4670.0 4618.0 4712.3 4717.6 4729.5 4758.7 5382.5 5394.6 5396.6 5400.7 5401.1 6419.5 6419.8 6420.3 6420.5 6426.0 1641.3 1646.2 1656.3 1657.9 1658.1 1128.6 1148.2 1150.8 1151.4 1174.9 6088.5 6120.2 6129.4 6131.5 6131.7 6458.8 6467.8 6474.1 6479.7 6480.1 5955.1 6107.0 6118.0 6122.8 6127.9 3464.7 3508.8 3508.8 3513.0 3516.8 6735.7 6739.0 6744.3 6746.8 6746.9 6538.6 6548.8 6551.3 6573.4 6582.5 6671.8 6837.8 6891.5 6910.9 6912.1 6349.2 6451.3 6529.1 6627.4 6634.6 6501.7 6512.9 6551.4 6553.4 6563.5 6873.7 6886.8 6893.7 6895.0 6895.8 4405.0 4414.4 4429.2 4520.3 4522.7 6548.9 6557.9 6563.6 6566.0 6571.0 6355.4 6373.1 6373.7 6379.1 6380.7 6211.8 6306.1 6332.1 6401.0 6416.1 6298.7 6321.1 6328.1 6331.7 6338.9 6447.8 6456.1 6458.0 6461.9 6475.7 6169.9 6312.5 6312.6 6317.8 6324.9 20:01:11 INFO - 2015-11-20 20:01:11,581 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-20 20:01:11,581 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13268.97 Median:521.89 stddev:15666.03 (3001.8%) stddev-sans-first:15681.95 20:01:11 INFO - 2015-11-20 20:01:11,582 DEBUG : BROWSER_OUTPUT: Values: 790.8 847.4 849.5 851.7 860.3 13167.9 13355.9 13379.9 13535.3 13540.3 11203.4 12342.9 12367.7 12403.1 12438.8 652.7 660.4 804.7 818.9 819.4 811.8 818.2 818.3 819.7 821.7 835.5 837.4 846.1 846.8 848.0 839.8 840.7 840.8 841.0 842.9 515.9 522.1 619.4 627.9 628.6 12808.3 12881.4 12909.0 12920.2 12968.2 11420.5 12432.8 12654.7 12692.9 12944.9 9541.5 9588.6 9588.9 9672.5 9847.7 3628.1 3630.3 3684.9 3688.6 3777.0 44161.3 44247.8 44257.3 44443.1 44576.6 9717.5 9856.7 9914.8 9930.1 9945.6 17749.5 17769.1 17800.2 17819.1 17829.6 7220.0 7367.3 7383.6 7433.3 7565.2 4162.1 4198.6 4212.1 4253.2 4254.4 3028.1 3050.7 3056.8 3057.4 3060.6 519.4 521.7 527.4 527.9 532.6 617.7 625.7 641.7 663.3 680.4 7850.7 8376.3 8504.9 8584.5 8669.0 595.2 642.9 669.3 677.3 684.2 3472.9 3734.6 3740.5 3825.2 3829.1 56553.0 57855.4 57871.0 58086.4 58251.0 48588.5 49467.3 49839.5 49979.0 49996.0 46080.5 46758.3 47553.8 48021.8 48641.3 7675.5 7680.7 8060.0 8100.6 8244.5 33872.5 34155.8 34826.3 34833.3 35070.8 39544.4 41796.0 43945.6 44548.8 45402.9 9675.8 10089.5 10354.3 10368.4 10443.9 10431.9 10511.2 10537.6 10790.3 11533.8 9109.0 9455.2 9663.4 10404.2 10424.8 9944.5 10049.7 10125.5 10154.2 10155.8 9517.2 9773.9 10132.5 10184.2 10187.9 8736.7 9013.9 9102.2 9290.6 9300.1 7706.5 7889.2 7996.7 8262.5 8365.9 20:01:11 INFO - 2015-11-20 20:01:11,582 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:01:11 INFO - 2015-11-20 20:01:11,582 DEBUG : BROWSER_OUTPUT: 20:01:12 INFO - 2015-11-20 20:01:12,254 INFO : Browser exited with error code: 0 20:01:12 INFO - 2015-11-20 20:01:12,275 INFO : Completed test dromaeo_css (00:18:33) 20:01:12 INFO - 2015-11-20 20:01:12,275 INFO : Starting test kraken 20:01:12 INFO - 2015-11-20 20:01:12,275 DEBUG : operating with platform_type : linux_ 20:01:12 INFO - 2015-11-20 20:01:12,275 INFO : Initialising browser for kraken test... 20:01:12 INFO - 2015-11-20 20:01:12,282 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIsIX3L/profile http://localhost:59498/getInfo.html 20:01:16 INFO - 2015-11-20 20:01:16,209 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:01:16 INFO - 2015-11-20 20:01:16,209 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:01:16 INFO - 2015-11-20 20:01:16,209 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:01:16 INFO - 2015-11-20 20:01:16,209 DEBUG : BROWSER_OUTPUT: __metrics 20:01:16 INFO - 2015-11-20 20:01:16,331 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:01:17 INFO - 2015-11-20 20:01:17,701 INFO : Browser initialized. 20:01:17 INFO - 2015-11-20 20:01:17,702 INFO : Running cycle 1/1 for kraken test... 20:01:17 INFO - 2015-11-20 20:01:17,702 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIsIX3L/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:01:29 INFO - 2015-11-20 20:01:29,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 142180352 20:01:29 INFO - 2015-11-20 20:01:29,498 DEBUG : BROWSER_OUTPUT: 20:01:31 INFO - 2015-11-20 20:01:31,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59498/tests/kraken/driver.html?testName=audio-beat-detection) 20:01:32 INFO - 2015-11-20 20:01:32,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 179093504 20:01:32 INFO - 2015-11-20 20:01:32,540 DEBUG : BROWSER_OUTPUT: 20:01:35 INFO - 2015-11-20 20:01:35,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59498/tests/kraken/driver.html?testName=audio-dft) 20:01:35 INFO - 2015-11-20 20:01:35,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 166031360 20:01:35 INFO - 2015-11-20 20:01:35,698 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59498/tests/kraken/driver.html?testName=audio-fft) 20:01:39 INFO - 2015-11-20 20:01:39,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 151937024 20:01:39 INFO - 2015-11-20 20:01:39,164 DEBUG : BROWSER_OUTPUT: 20:01:41 INFO - 2015-11-20 20:01:41,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59498/tests/kraken/driver.html?testName=audio-oscillator) 20:01:41 INFO - 2015-11-20 20:01:41,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 153530368 20:01:41 INFO - 2015-11-20 20:01:41,710 DEBUG : BROWSER_OUTPUT: 20:01:43 INFO - 2015-11-20 20:01:43,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59498/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:01:44 INFO - 2015-11-20 20:01:44,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 156401664 20:01:44 INFO - 2015-11-20 20:01:44,408 DEBUG : BROWSER_OUTPUT: 20:01:47 INFO - 2015-11-20 20:01:47,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59498/tests/kraken/driver.html?testName=imaging-darkroom) 20:01:47 INFO - 2015-11-20 20:01:47,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 154853376 20:01:47 INFO - 2015-11-20 20:01:47,897 DEBUG : BROWSER_OUTPUT: 20:01:51 INFO - 2015-11-20 20:01:51,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59498/tests/kraken/driver.html?testName=imaging-desaturate) 20:01:51 INFO - 2015-11-20 20:01:51,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 155615232 20:01:51 INFO - 2015-11-20 20:01:51,854 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-20 20:01:54,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59498/tests/kraken/driver.html?testName=json-parse-financial) 20:01:55 INFO - 2015-11-20 20:01:55,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 155869184 20:01:55 INFO - 2015-11-20 20:01:55,172 DEBUG : BROWSER_OUTPUT: 20:01:56 INFO - 2015-11-20 20:01:56,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59498/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:01:57 INFO - 2015-11-20 20:01:57,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 164839424 20:01:57 INFO - 2015-11-20 20:01:57,283 DEBUG : BROWSER_OUTPUT: 20:01:59 INFO - 2015-11-20 20:01:59,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59498/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:01:59 INFO - 2015-11-20 20:01:59,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 164106240 20:01:59 INFO - 2015-11-20 20:01:59,694 DEBUG : BROWSER_OUTPUT: 20:02:01 INFO - 2015-11-20 20:02:01,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59498/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:02:02 INFO - 2015-11-20 20:02:02,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 172765184 20:02:02 INFO - 2015-11-20 20:02:02,297 DEBUG : BROWSER_OUTPUT: 20:02:04 INFO - 2015-11-20 20:02:04,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:02:05 INFO - 2015-11-20 20:02:05,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 180932608 20:02:05 INFO - 2015-11-20 20:02:05,326 DEBUG : BROWSER_OUTPUT: 20:02:07 INFO - 2015-11-20 20:02:07,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:02:08 INFO - 2015-11-20 20:02:08,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 178704384 20:02:08 INFO - 2015-11-20 20:02:08,459 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59498/tests/kraken/driver.html?testName=ai-astar) 20:02:10 INFO - 2015-11-20 20:02:10,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 238120960 20:02:10 INFO - 2015-11-20 20:02:10,378 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,381 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:02:10 INFO - 2015-11-20 20:02:10,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:02:10 INFO - 2015-11-20 20:02:10,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:02:10 INFO - 2015-11-20 20:02:10,382 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:02:10 INFO - 2015-11-20 20:02:10,382 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;105;111;113;112;101;110;116;113 20:02:10 INFO - 2015-11-20 20:02:10,382 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;130;147;159;127;150;152;126;171;126 20:02:10 INFO - 2015-11-20 20:02:10,382 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;161;161;161;162;166;160;162 20:02:10 INFO - 2015-11-20 20:02:10,382 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;83;92;72;73;72;96;91;73 20:02:10 INFO - 2015-11-20 20:02:10,383 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;133;91;91;90;127;90;90;133 20:02:10 INFO - 2015-11-20 20:02:10,383 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;109;109;109;109;110;109 20:02:10 INFO - 2015-11-20 20:02:10,383 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;144;145;145;145;146;145;145;145 20:02:10 INFO - 2015-11-20 20:02:10,383 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;96;95;96;95;95 20:02:10 INFO - 2015-11-20 20:02:10,383 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;56;56;56;55;57;56;65;55;54 20:02:10 INFO - 2015-11-20 20:02:10,383 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;70;69;70;70;71;69;70 20:02:10 INFO - 2015-11-20 20:02:10,383 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;84;84;84;86;84;85;84;85;83 20:02:10 INFO - 2015-11-20 20:02:10,384 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;137;126;122;121;123;117;122;124;116;116 20:02:10 INFO - 2015-11-20 20:02:10,384 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;157;162;154;152;144;154;151;151;143 20:02:10 INFO - 2015-11-20 20:02:10,384 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;66;67;74;66;66;67;65;66 20:02:10 INFO - 2015-11-20 20:02:10,384 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:02:10 INFO - 2015-11-20 20:02:10,384 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:02:10 INFO - 2015-11-20 20:02:10,384 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,926 20:02:10 INFO - 2015-11-20 20:02:10,384 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:02:10 INFO - 2015-11-20 20:02:10,384 DEBUG : BROWSER_OUTPUT: __startTimestamp1448078530379__endTimestamp 20:02:10 INFO - 2015-11-20 20:02:10,385 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,388 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:02:10 INFO - 2015-11-20 20:02:10,388 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:02:10 INFO - 2015-11-20 20:02:10,388 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,388 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:4.33 (3.9%) stddev-sans-first:4.54 20:02:10 INFO - 2015-11-20 20:02:10,388 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 105.0 111.0 113.0 112.0 101.0 110.0 116.0 113.0 20:02:10 INFO - 2015-11-20 20:02:10,388 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,388 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:151.00 stddev:15.85 (10.5%) stddev-sans-first:16.54 20:02:10 INFO - 2015-11-20 20:02:10,388 DEBUG : BROWSER_OUTPUT: Values: 152.0 130.0 147.0 159.0 127.0 150.0 152.0 126.0 171.0 126.0 20:02:10 INFO - 2015-11-20 20:02:10,389 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,389 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.63 (1.0%) stddev-sans-first:1.73 20:02:10 INFO - 2015-11-20 20:02:10,389 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 161.0 161.0 161.0 162.0 166.0 160.0 162.0 20:02:10 INFO - 2015-11-20 20:02:10,389 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,389 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:78.00 stddev:9.91 (12.7%) stddev-sans-first:10.01 20:02:10 INFO - 2015-11-20 20:02:10,389 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 83.0 92.0 72.0 73.0 72.0 96.0 91.0 73.0 20:02:10 INFO - 2015-11-20 20:02:10,389 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,389 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.70 Median:90.50 stddev:19.60 (21.7%) stddev-sans-first:20.33 20:02:10 INFO - 2015-11-20 20:02:10,389 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 133.0 91.0 91.0 90.0 127.0 90.0 90.0 133.0 20:02:10 INFO - 2015-11-20 20:02:10,389 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,389 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 20:02:10 INFO - 2015-11-20 20:02:10,389 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 144.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:3.06 (5.5%) stddev-sans-first:3.24 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: Values: 57.0 56.0 56.0 56.0 55.0 57.0 56.0 65.0 55.0 54.0 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 69.0 70.0 70.0 71.0 69.0 70.0 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,390 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:1.97 (2.3%) stddev-sans-first:0.87 20:02:10 INFO - 2015-11-20 20:02:10,391 DEBUG : BROWSER_OUTPUT: Values: 90.0 84.0 84.0 84.0 86.0 84.0 85.0 84.0 85.0 83.0 20:02:10 INFO - 2015-11-20 20:02:10,391 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,391 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:122.50 stddev:6.17 (5.0%) stddev-sans-first:3.63 20:02:10 INFO - 2015-11-20 20:02:10,391 DEBUG : BROWSER_OUTPUT: Values: 137.0 126.0 122.0 121.0 123.0 117.0 122.0 124.0 116.0 116.0 20:02:10 INFO - 2015-11-20 20:02:10,391 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,391 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:153.00 stddev:6.57 (4.3%) stddev-sans-first:5.92 20:02:10 INFO - 2015-11-20 20:02:10,391 DEBUG : BROWSER_OUTPUT: Values: 141.0 157.0 162.0 154.0 152.0 144.0 154.0 151.0 151.0 143.0 20:02:10 INFO - 2015-11-20 20:02:10,391 DEBUG : BROWSER_OUTPUT: 20:02:10 INFO - 2015-11-20 20:02:10,391 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:2.53 (3.8%) stddev-sans-first:2.67 20:02:10 INFO - 2015-11-20 20:02:10,391 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 66.0 67.0 74.0 66.0 66.0 67.0 65.0 66.0 20:02:10 INFO - 2015-11-20 20:02:10,391 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:02:10 INFO - 2015-11-20 20:02:10,391 DEBUG : BROWSER_OUTPUT: 20:02:11 INFO - 2015-11-20 20:02:11,218 INFO : Browser exited with error code: 0 20:02:11 INFO - 2015-11-20 20:02:11,267 INFO : Completed test kraken (00:00:58) 20:02:11 INFO - 2015-11-20 20:02:11,267 INFO : Starting test v8_7 20:02:11 INFO - 2015-11-20 20:02:11,267 DEBUG : operating with platform_type : linux_ 20:02:11 INFO - 2015-11-20 20:02:11,267 INFO : Initialising browser for v8_7 test... 20:02:11 INFO - 2015-11-20 20:02:11,273 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0mEZ9g/profile http://localhost:59498/getInfo.html 20:02:15 INFO - 2015-11-20 20:02:15,091 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:02:15 INFO - 2015-11-20 20:02:15,091 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:02:15 INFO - 2015-11-20 20:02:15,091 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:02:15 INFO - 2015-11-20 20:02:15,091 DEBUG : BROWSER_OUTPUT: __metrics 20:02:15 INFO - 2015-11-20 20:02:15,179 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:02:16 INFO - 2015-11-20 20:02:16,542 INFO : Browser initialized. 20:02:16 INFO - 2015-11-20 20:02:16,543 INFO : Running cycle 1/1 for v8_7 test... 20:02:16 INFO - 2015-11-20 20:02:16,543 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0mEZ9g/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:02:28 INFO - 2015-11-20 20:02:28,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 142204928 20:02:28 INFO - 2015-11-20 20:02:28,314 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59498/tests/v8_7/run.html (next: http://localhost:59498/tests/v8_7/run.html) 20:02:49 INFO - 2015-11-20 20:02:49,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 544243712 20:02:49 INFO - 2015-11-20 20:02:49,949 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,950 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:02:49 INFO - 2015-11-20 20:02:49,951 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:02:49 INFO - 2015-11-20 20:02:49,951 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:02:49 INFO - 2015-11-20 20:02:49,951 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:02:49 INFO - 2015-11-20 20:02:49,951 DEBUG : BROWSER_OUTPUT: |0;Richards;162.86644951140065 20:02:49 INFO - 2015-11-20 20:02:49,952 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.53590090961873 20:02:49 INFO - 2015-11-20 20:02:49,952 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.56569652444193 20:02:49 INFO - 2015-11-20 20:02:49,952 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 20:02:49 INFO - 2015-11-20 20:02:49,952 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1114.8272017837235 20:02:49 INFO - 2015-11-20 20:02:49,952 DEBUG : BROWSER_OUTPUT: |5;Earley;778.816199376947 20:02:49 INFO - 2015-11-20 20:02:49,953 DEBUG : BROWSER_OUTPUT: |6;Boyer;12023.809523809523 20:02:49 INFO - 2015-11-20 20:02:49,953 DEBUG : BROWSER_OUTPUT: |7;RegExp;26500 20:02:49 INFO - 2015-11-20 20:02:49,953 DEBUG : BROWSER_OUTPUT: |8;Splay;600.9615384615385 20:02:49 INFO - 2015-11-20 20:02:49,953 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 20:02:49 INFO - 2015-11-20 20:02:49,954 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:02:49 INFO - 2015-11-20 20:02:49,954 DEBUG : BROWSER_OUTPUT: __startTimestamp1448078569950__endTimestamp 20:02:49 INFO - 2015-11-20 20:02:49,954 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,954 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:02:49 INFO - 2015-11-20 20:02:49,955 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:02:49 INFO - 2015-11-20 20:02:49,955 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,956 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.87 Median:162.87 stddev:0.00 (0.0%) 20:02:49 INFO - 2015-11-20 20:02:49,957 DEBUG : BROWSER_OUTPUT: Values: 162.9 20:02:49 INFO - 2015-11-20 20:02:49,957 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,957 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.54 Median:193.54 stddev:0.00 (0.0%) 20:02:49 INFO - 2015-11-20 20:02:49,957 DEBUG : BROWSER_OUTPUT: Values: 193.5 20:02:49 INFO - 2015-11-20 20:02:49,957 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,958 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.57 Median:282.57 stddev:0.00 (0.0%) 20:02:49 INFO - 2015-11-20 20:02:49,958 DEBUG : BROWSER_OUTPUT: Values: 282.6 20:02:49 INFO - 2015-11-20 20:02:49,958 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,958 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 20:02:49 INFO - 2015-11-20 20:02:49,959 DEBUG : BROWSER_OUTPUT: Values: 5030.2 20:02:49 INFO - 2015-11-20 20:02:49,959 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,959 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1114.83 Median:1114.83 stddev:0.00 (0.0%) 20:02:49 INFO - 2015-11-20 20:02:49,959 DEBUG : BROWSER_OUTPUT: Values: 1114.8 20:02:49 INFO - 2015-11-20 20:02:49,959 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,960 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:778.82 Median:778.82 stddev:0.00 (0.0%) 20:02:49 INFO - 2015-11-20 20:02:49,960 DEBUG : BROWSER_OUTPUT: Values: 778.8 20:02:49 INFO - 2015-11-20 20:02:49,960 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,960 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12023.81 Median:12023.81 stddev:0.00 (0.0%) 20:02:49 INFO - 2015-11-20 20:02:49,961 DEBUG : BROWSER_OUTPUT: Values: 12023.8 20:02:49 INFO - 2015-11-20 20:02:49,961 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,961 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26500.00 Median:26500.00 stddev:0.00 (0.0%) 20:02:49 INFO - 2015-11-20 20:02:49,961 DEBUG : BROWSER_OUTPUT: Values: 26500.0 20:02:49 INFO - 2015-11-20 20:02:49,961 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,961 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.96 Median:600.96 stddev:0.00 (0.0%) 20:02:49 INFO - 2015-11-20 20:02:49,962 DEBUG : BROWSER_OUTPUT: Values: 601.0 20:02:49 INFO - 2015-11-20 20:02:49,962 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2015-11-20 20:02:49,962 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 20:02:49 INFO - 2015-11-20 20:02:49,962 DEBUG : BROWSER_OUTPUT: Values: 4845.4 20:02:49 INFO - 2015-11-20 20:02:49,962 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:02:49 INFO - 2015-11-20 20:02:49,962 DEBUG : BROWSER_OUTPUT: 20:02:50 INFO - 2015-11-20 20:02:50,866 INFO : Browser exited with error code: 0 20:02:50 INFO - 2015-11-20 20:02:50,885 INFO : Completed test v8_7 (00:00:39) 20:02:50 INFO - 2015-11-20 20:02:50,979 INFO : Completed test suite (00:20:11) 20:02:50 INFO - 2015-11-20 20:02:50,979 DEBUG : Working with test: dromaeo_css 20:02:50 INFO - 2015-11-20 20:02:50,979 DEBUG : Generating results file: dromaeo_css 20:02:50 INFO - 2015-11-20 20:02:50,980 DEBUG : Working with test: kraken 20:02:50 INFO - 2015-11-20 20:02:50,980 DEBUG : Generating results file: kraken 20:02:50 INFO - 2015-11-20 20:02:50,980 INFO : javascript benchmark 20:02:50 INFO - 2015-11-20 20:02:50,981 DEBUG : Working with test: v8_7 20:02:50 INFO - 2015-11-20 20:02:50,981 DEBUG : Generating results file: v8_7 20:02:50 INFO - 2015-11-20 20:02:50,981 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:02:51 INFO - 2015-11-20 20:02:51,031 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 20:02:51 INFO - 2015-11-20 20:02:51,031 DEBUG : process_Request line: dromaeo_css 6993.42 graph.html#tests=[[72,201,35]] 20:02:51 INFO - 2015-11-20 20:02:51,031 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:02:51 INFO - 2015-11-20 20:02:51,061 DEBUG : process_Request line: kraken 1499.80 graph.html#tests=[[232,201,35]] 20:02:51 INFO - 2015-11-20 20:02:51,061 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:02:51 INFO - 2015-11-20 20:02:51,101 DEBUG : process_Request line: v8_7 21072.64 graph.html#tests=[[230,201,35]] 20:02:51 INFO - 2015-11-20 20:02:51,102 INFO : javascript benchmark 20:02:51 INFO - 2015-11-20 20:02:51,106 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3212.8232947187903, 3272.7381809455246, 3310.2717402171515, 3316.502524621308, 3339.465685490322, 5344.706041167734, 5446.809361672343, 5489.176623506471, 5499.147632117023, 5506.862328441781, 5286.180642000496, 5488.259085023521, 5515.834524964247, 5532.419095994923, 5532.723363831802, 4978.427480839714, 5027.773750181251, 5048.747562621873, 5096.745162741848, 5157.5358217760395, 4845.878853028685, 5169.663971841818, 5178.249153872686, 5203.245529398235, 5250.579953603722, 4942.678725882806, 4976.726280054596, 5005.34930459038, 5009.974950125226, 5031.572316353115, 5012.072766538202, 5044.6973181608855, 5048.268001139851, 5062.696238225682, 5096.464871188509, 4905.337779399771, 4996.100701873661, 5015.247712843066, 5027.547520723116, 5045.167547354718, 5282.947170528322, 5346.1713434417725, 5355.062863998784, 5360.9463905360835, 5362.705051222181, 5992.250968628921, 6039.275286965549, 6042.788502402439, 6043.8791224175275, 6045.879082418327, 5813.128030795372, 5917.852053698649, 5931.139984702238, 6057.636541807506, 6083.361247069082, 5396.163594642837, 5493.066178749622, 5526.944730552683, 5550.333959924835, 5550.500454959073, 6021.157038014681, 6021.57848950578, 6022.066579680157, 6075.210222671025, 6133.049377346519, 5755.079187330007, 5792.189093526909, 5792.362840087587, 5799.971000144972, 5831.241938547962, 5865.853353666193, 5903.0260007099205, 5956.583039187215, 5968.432998865188, 5991.820245392645, 5890.823275301748, 5907.7046147692445, 5916.585838991229, 5930.644161350333, 5952.107183922446, 5760.769569217268, 5923.407659234128, 5929.911051334234, 5940.108983652487, 5941.405859414111, 4529.728216307032, 4575.22221222393, 4625.352450656911, 4643.883902902455, 4646.814127434933, 4032.1330913853662, 4036.7577945323374, 4042.6159514846045, 4043.5754245804355, 4073.409355643415, 5571.526420254324, 5572.219889215513, 5574.136008918624, 5575.637583557056, 5629.43705629442, 5785.27684039495, 5866.208061911588, 5911.349751527328, 5914.733836977346, 5922.289325280994, 5620.072688006433, 5620.85947851307, 5622.409646987089, 5624.887502250014, 5630.296212973379, 5157.381114266312, 5164.948350516447, 5171.198464238049, 5180.093483640348, 5212.817551385683, 6000.969995149996, 6043.184170137063, 6099.113073221168, 6111.205543279434, 6239.594426362272, 6015.292440509923, 6023.0, 6026.276846778414, 6028.788992385245, 6089.0, 6269.279032911091, 6270.968645156745, 6271.811845644638, 6272.310045894857, 6282.811515654537, 5681.375048744718, 5777.7977770777825, 5813.128030795415, 5843.152742852348, 5875.882482350415, 5909.970450147722, 5918.408159184047, 5919.6152250103605, 5920.171176035445, 5928.0, 5709.600327977002, 5786.161006654096, 5792.7103644818435, 5848.970755146197, 5852.18069470266, 5723.456271654186, 5750.079987202028, 5764.423557644202, 5856.94143058564, 5904.970475147768, 5694.743736531949, 5697.401772813961, 5752.856178595569, 5757.884842303214, 5765.56758243125, 5630.5777066720975, 5851.736671849691, 5874.911876321773, 5876.41235876409, 5883.852903677443, 5694.402087780723, 5727.284089488814, 5771.0, 5809.331926828299, 5854.882902342015], "unit": "ms", "name": "dojo.html", "value": 5470.385054253129}, {"lowerIsBetter": false, "replicates": [581.4214856218063, 582.883423315337, 584.3367777572455, 600.2167171840752, 601.5728832528904, 28958.85520572397, 29779.5110244488, 29796.553051704243, 29847.552286715716, 29849.403011939747, 32067.35865282693, 32328.838355808188, 40157.397639035364, 40898.0, 40926.79536602313, 8672.219500244977, 8791.384603077755, 8797.560121993874, 8811.691590794324, 8820.426672266314, 8646.956765216166, 8739.95630021849, 8752.0, 8760.824783504326, 8764.43031202973, 7774.2614451627005, 7919.168487308807, 10455.0, 10717.0, 10765.515551800148, 10229.181665466782, 10342.586296548128, 10344.034633419664, 10358.63744768937, 10362.0, 7910.4067194960035, 8124.390670699662, 10176.389416634951, 10334.534945927377, 10355.534000969974, 43043.7847810759, 44154.55845441537, 44179.55820441787, 44181.337279940824, 44203.557964420266, 3194.552762613236, 3231.046841181857, 3235.8705651773903, 3275.0829767664854, 3326.467765157563, 28446.857765711247, 29621.70378296211, 30185.849070754724, 30187.849060754557, 30654.846725766227, 3906.2187562487616, 3958.782266975315, 4015.8393664253394, 4082.265192265391, 4107.650849677781, 254639.0, 255754.0, 255931.72034139896, 256022.0, 256561.0, 59101.70449147727, 59118.40881591215, 59201.0, 59207.111893321635, 59258.0, 62460.0, 62488.0, 62492.68753656203, 62546.68726656429, 62645.0, 15120.168390738614, 15199.31603077842, 15284.923575382052, 15397.769033464507, 15405.15271660047, 11558.768824623461, 11641.53433862636, 11651.242669226473, 11651.766964660828, 11653.41732913351, 18465.169067392, 19642.410727678194, 19727.30954416617, 19750.30873919406, 19771.30800422007, 7802.804929876798, 8021.2379823916635, 8025.117237103914, 8086.757397278091, 8129.227723366271, 907.9409838360485, 918.6509126531876, 959.836827739286, 1050.2543194331956, 1067.1196263082988, 28534.28664283368, 28738.856305718757, 28822.855885720437, 28930.42139157205, 29100.854495727384, 946.3091942881734, 1000.8298589239847, 1035.9585616575253, 1037.7872536130076, 1045.1429827541494, 14231.644208894653, 14232.146071235758, 14551.0, 14555.345009474388, 15811.920940395454, 378969.2618442847, 382603.0, 382763.0, 383640.0, 676496.0, 47162.76418617885, 47679.28481072787, 58625.70687146537, 60587.39412605818, 60899.69550152309, 1306.6276111308232, 1333.3200067965408, 1338.9263590502617, 1341.6310514608365, 1341.9329033548088, 25964.74035259699, 27494.0, 27734.5839812407, 28681.42637147287, 31138.37723245477, 48142.0, 48750.756246219964, 48754.75622622006, 48766.51233487762, 48790.51209488002, 283837.0, 285035.0, 285462.0, 285983.0, 286151.0, 31309.84345078351, 31337.529937050505, 31705.68294317027, 32000.0, 32006.199845004063, 40694.79652601718, 40812.79593602013, 41081.79459102685, 41095.1780964373, 41181.382279266436, 34865.30269394547, 35308.29383412369, 35447.64552354444, 35560.110997225274, 36032.639673603975, 35305.293894122486, 35484.0, 35743.285134296646, 36102.4584631236, 36155.81922090373, 34251.82874085614, 35086.29827403489, 35340.0, 35367.29265414626, 35429.29141417209, 28708.0, 31918.488966213234, 32013.35973280568, 32042.51936220912, 32346.353072937938, 23608.763912361344, 23675.0, 23703.881480592485, 23889.641655374835, 23976.760232397453], "unit": "ms", "name": "ext.html", "value": 18571.211362420414}, {"lowerIsBetter": false, "replicates": [353.27402188502634, 354.6046158533235, 356.4528448831045, 358.7506682855415, 359.2402069622747, 13881.514147004857, 14127.0, 16418.753718694214, 17238.482845514638, 18404.539886502844, 14996.0, 16258.674826503493, 16328.591785205375, 16368.0, 16955.0, 5312.442193569668, 5445.782168713246, 5450.809221677242, 5454.836354909359, 5456.072467680504, 3884.8834534964, 3904.824282907262, 5432.70120143392, 5443.129099344106, 5922.822315330547, 6001.579889407743, 6033.668148251844, 6042.486388656969, 6052.697365131726, 6060.454559089681, 5590.748416321276, 5747.023006088975, 5750.108733146327, 5750.539956803445, 6015.939840601582, 5074.619403544712, 5075.365579302587, 5081.568066714333, 5081.745912704387, 5254.106801843695, 19600.117994690274, 20180.69728954067, 20240.696389554167, 20988.580228395498, 21007.684884726743, 2010.45717656232, 2068.214078650118, 2088.5196404826825, 2089.5925294567564, 2200.9779902200935, 9549.09283618055, 9613.038696130401, 9725.65960191397, 9733.707988760349, 9740.512974351324, 1834.257125864027, 1865.3378050792044, 1886.745289385929, 1891.6689579323702, 1920.6446807340687, 59844.40155598432, 63773.36226637767, 67556.0, 68183.65908170477, 69020.6548967252, 14905.180215088274, 15246.46637367709, 15304.770428443582, 15320.770188447183, 15338.539843804703, 22945.54108917812, 22953.885230573742, 23045.193418230283, 23076.423089422562, 23147.189848355563, 8286.254237118568, 8287.212714792086, 8311.376646751518, 8324.70863519786, 8466.830663386698, 6956.373926346653, 6958.965205173941, 6982.965085174643, 6990.61551614666, 7005.754798582026, 7911.564863932424, 7930.444868859125, 7960.363170946311, 8056.39577031725, 8103.0, 2731.4810186064583, 3014.8492575371583, 3038.5594088857433, 3116.25209949615, 3132.7493800495904, 446.910617876426, 903.7857249738167, 922.6678395777515, 951.4909523404945, 981.4945303168873, 10598.258121931545, 11028.393438360967, 11096.0, 11223.989840914357, 11226.943865280622, 427.50196021634446, 438.8595649392164, 450.11103071433655, 462.6183398696089, 469.99295010574866, 5932.466078052996, 6061.181740465069, 6065.0, 6144.539159563051, 6170.259568851767, 492061.0, 529494.0, 534008.0, 539384.0, 550344.0, 81981.59009204915, 85163.5741821287, 85226.14773852307, 85229.0, 85531.14468855232, 1025.6307729217624, 1106.7011906785124, 1119.731264496515, 1123.853898993142, 1131.332513816852, 13138.408771605109, 14777.482788102365, 14947.177905215318, 15485.458008969632, 15727.213639317759, 36854.26909925917, 36863.07842303964, 37076.258474830895, 37119.814400927826, 37787.81106094452, 48626.5137348622, 48709.26936096032, 50573.74713126411, 51494.0, 51554.0, 9360.906390936003, 9662.613495460102, 9728.270379721691, 9751.902480975099, 9762.658306959222, 11428.2000259981, 11446.885531144582, 12053.879461205275, 17308.91345543264, 17427.39004134849, 14359.425622974964, 14455.566333010027, 14631.634209144431, 14793.559062754955, 14910.925445372704, 14159.504417345755, 14202.431902723776, 14403.42386304536, 14521.201333926736, 14631.487897923522, 14356.85643143597, 14516.927415362856, 14756.778648320069, 15070.397184112513, 15201.6199595011, 9212.953935230282, 9425.151736343762, 9620.567074481525, 9642.264392409434, 9674.371165874196, 10081.092701656886, 10137.797244055226, 12374.876251237372, 13834.15804468428, 14104.730574248368], "unit": "ms", "name": "jquery.html", "value": 8949.3468749503}, {"lowerIsBetter": false, "replicates": [1298.0653929170994, 1665.8417450342217, 1717.1585922897775, 1728.5678580354906, 1736.9218385172674, 6641.867162656744, 7689.577073260968, 7848.332891704212, 7854.92145078549, 7855.567943763105, 7684.846303073935, 7811.882821757678, 7818.257265559762, 7819.178986206452, 7820.061592608895, 1976.2984140630085, 2007.6586980213326, 2214.1254204589177, 2290.8854557272193, 2312.838101332907, 2311.2257393773107, 2314.2710046335433, 2316.7104111986, 2316.9189078382174, 2320.118355025088, 2217.090992692996, 2301.5051763870765, 2303.53929214157, 2304.9078036878504, 2306.077568972408, 1987.473319570315, 2023.2513969831184, 2269.5234000859755, 2300.1489448904013, 2300.367398965281, 2269.909203631853, 2279.658051292319, 2304.919327823518, 2305.4005958450757, 2357.7760112789256, 7807.258310460497, 7886.960565197137, 7889.974303340529, 7893.171217022187, 7897.052353717533, 4576.695641742088, 4621.7920193591035, 4652.162610730067, 4655.301704744282, 4673.859784206479, 3095.9845200773852, 3124.156477751017, 3138.1997590614474, 3183.267848394882, 3312.5362449257123, 981.3670182732169, 985.4481490365418, 1019.2661283875598, 1021.5505177721778, 1050.3907733514543, 10850.29473084247, 10957.342559446459, 10966.232363734542, 10976.12191024716, 10977.506012229469, 4067.471228740245, 4167.91664166715, 4174.248635245624, 4215.0, 4271.829126834954, 8965.820683586291, 8970.82058358829, 8978.595963181673, 8978.685745998859, 8983.505907175168, 4649.930251046237, 4693.084848454587, 4695.131400690883, 4701.177293973541, 4702.059588082398, 4272.786360681954, 4318.654507639381, 4319.8488052918, 4319.956800431955, 4320.481542214891, 3313.7183339415938, 3369.0566641340465, 3391.0844072100394, 3392.660733926637, 3402.6767457091537, 1022.5194158745378, 1033.452270296744, 1042.3954106618144, 1043.9269251152498, 1047.4134484688598, 961.2358175250693, 1266.4934026389517, 1293.6959814443599, 1297.331874084847, 1347.9595612131652, 6557.803265902031, 7486.7005319786595, 7488.438367122488, 7488.438367122488, 7499.437542184358, 574.5977815529146, 577.4946921443736, 592.1295695327861, 595.8748662780778, 604.7701873288211, 5668.036433806263, 5713.228714123623, 5719.799807006735, 5734.369219385864, 5787.710614469344, 9554.283428742872, 9588.424694518211, 9694.175995040501, 9694.46680432583, 9723.659671911591, 9395.436273823592, 9589.849218093874, 9599.760005999906, 9604.75988100303, 9607.711768646952, 7357.558546487228, 7357.705691772377, 7419.183889772121, 7421.369183619345, 7429.702811887572, 7008.789736307919, 7102.18324892644, 7129.643517824192, 7150.320719531636, 7154.0, 8360.331173506227, 8421.747347579583, 8482.660693572188, 8485.830283394174, 8530.78673033179, 8672.739817805475, 8696.521691307038, 8804.559772011502, 8809.823803523765, 8831.116888311117, 6786.21958474762, 6864.862702746017, 6870.0, 6871.244163142151, 6877.277885821916, 7662.310392064741, 7736.613169341623, 7740.729074482366, 7765.7670269892, 7775.805604859924, 7183.0, 7233.348998590152, 7290.781276561712, 7330.670119844726, 7396.889046664197, 7092.5389849659605, 7196.712131514891, 7198.6400679964745, 7304.744333948286, 7332.633368331455, 6281.52888533371, 6361.650109244036, 7199.1361036675935, 7280.526765760209, 7281.05346304977, 6436.0, 6525.967370163309, 6599.571027883172, 6603.9009414859775, 6609.173853268341, 6559.508036897348, 6594.538382313192, 6608.900866486911, 6627.768028118992, 6630.469562434897], "unit": "ms", "name": "mootools.html", "value": 4419.366454557732}, {"lowerIsBetter": false, "replicates": [336.87872365948255, 337.98986030419087, 341.82396066026, 350.6125731067172, 353.90267676388976, 5799.1881136640795, 5952.6130801497875, 5953.464188223059, 5959.165716799641, 5960.493358064565, 5754.4533269339345, 5897.911531327023, 5916.0830071338905, 5922.674252916088, 5946.672932988684, 4567.748773817447, 4569.9314510282375, 4571.748553829538, 4579.3131030345385, 4579.931301030487, 4421.314696222091, 4465.218586747323, 4500.459944806627, 4580.038191979688, 4597.54024597541, 4531.728096314215, 4545.772711364435, 4554.795034223452, 4581.518940511249, 4587.311903214528, 4580.816767329303, 4586.174488592069, 4587.7706114694465, 4593.379893714339, 4602.976985115087, 4063.0, 4067.5118985721606, 4067.7559346439307, 4070.30804763188, 4071.145059537501, 5524.8342549723175, 5633.070543360341, 5637.49262566371, 5720.2849643794525, 5728.799492017801, 5398.78404863805, 5402.324709411324, 5403.864903377408, 5404.405515393303, 5404.432534583891, 6051.485623721989, 6344.873102537969, 6365.458935990447, 6371.458426033792, 6372.076048972873, 4389.824407023715, 4422.84520041797, 4510.458744950627, 4513.165064463052, 4518.819247230107, 6475.51433642474, 6564.7374105036215, 6570.704318305688, 6576.375244351779, 6577.375149360803, 4655.790489427984, 4661.580457758818, 4664.160451118763, 4666.906661866744, 4670.042641258534, 4617.960958784314, 4712.31671407644, 4717.599004084623, 4729.456112547101, 4758.714477131314, 5382.49290198745, 5394.64934779246, 5396.568274538027, 5400.702961337164, 5401.081816091274, 6419.486441084702, 6419.775307864203, 6420.293767685551, 6420.454261387741, 6425.971844504857, 1641.3024464602736, 1646.209819286749, 1656.2795184094716, 1657.9336826526803, 1658.0549087020524, 1128.610629332879, 1148.2364227788594, 1150.764093360859, 1151.3955173533961, 1174.8590169179581, 6088.452039316483, 6120.204373431426, 6129.448349648553, 6131.50947924165, 6131.724072416752, 6458.806235812933, 6467.838304042437, 6474.12599299098, 6479.740810367627, 6480.125183100221, 5955.106733989849, 6106.969465152646, 6118.021116621319, 6122.785702500391, 6127.908081378783, 3464.72282217422, 3508.8421021053605, 3508.8421021054114, 3513.0, 3516.7538272320694, 6735.696893639798, 6738.9554619034125, 6744.258131605519, 6746.763863264762, 6746.865062698718, 6538.640374779433, 6548.770793022221, 6551.312112228243, 6573.441257493167, 6582.473402127818, 6671.799846004531, 6837.829054273583, 6891.517593768388, 6910.896336554955, 6912.101426814482, 6349.238091429058, 6451.2903580607035, 6529.118568993125, 6627.436667883284, 6634.601923884582, 6501.674916254263, 6512.869742605216, 6551.4103730664465, 6553.377429144223, 6563.507736919654, 6873.725050997904, 6886.7933961979215, 6893.724251029903, 6894.965525172342, 6895.827604309932, 4405.03089320349, 4414.381986521826, 4429.180601588717, 4520.299353600197, 4522.728636281834, 6548.869022619426, 6557.9179435394535, 6563.573367731082, 6566.0, 6571.01434784767, 6355.428011478989, 6373.107764912823, 6373.745050198126, 6379.106925030406, 6380.712867921047, 6211.844703882439, 6306.054091886253, 6332.050192471166, 6401.0, 6416.101745755504, 6298.685065746786, 6321.0834429008455, 6328.145700330397, 6331.746730130927, 6338.873222535616, 6447.806565803034, 6456.12842266288, 6458.0, 6461.935380646321, 6475.708593113415, 6169.907451388143, 6312.495000400048, 6312.558120931674, 6317.810465686037, 6324.905126423016], "unit": "ms", "name": "prototype.html", "value": 4821.195874492465}, {"lowerIsBetter": false, "replicates": [790.8497385496757, 847.3856454070798, 849.4818160921841, 851.7444766570028, 860.3074525007366, 13167.934160329198, 13355.933220333885, 13379.933100334485, 13535.255560944157, 13540.322983850805, 11203.383813890232, 12342.876571234285, 12367.690807729812, 12403.069769767259, 12438.81341779874, 652.6867103790172, 660.3693472733552, 804.6580203413555, 818.8648872935959, 819.4059307002435, 811.7524155132683, 818.2308629887887, 818.2594751749676, 819.6639377855081, 821.6918655504186, 835.5237514616671, 837.392890154636, 846.1453931529169, 846.7713717296326, 848.007830837918, 839.8068444257793, 840.7435732101707, 840.756180707594, 840.9789755256106, 842.9114942930996, 515.9045576568309, 522.0550803046498, 619.3991827926903, 627.9152314437538, 628.6259675493075, 12808.295543745091, 12881.355932203445, 12909.031822613342, 12920.22478651284, 12968.221906685534, 11420.486078126421, 12432.813507797391, 12654.746905061938, 12692.873071269261, 12944.87055129446, 9541.47521886303, 9588.568514416867, 9588.90411095887, 9672.468014259213, 9847.704568862946, 3628.1473853644375, 3630.3465376232266, 3684.9263014739554, 3688.5573731152435, 3776.9811150944342, 44161.33757993633, 44247.77876110631, 44257.33613995793, 44443.111137777385, 44576.554234457886, 9717.514124293757, 9856.655017074369, 9914.80170396588, 9930.106290433896, 9945.602175913027, 17749.467515974542, 17769.11154442273, 17800.198991045436, 17819.10904454772, 17829.554261143574, 7219.963900180465, 7367.263273672697, 7383.593902335316, 7433.331000210007, 7565.167831538526, 4162.146759914211, 4198.64784251341, 4212.143584013424, 4253.191893540279, 4254.361845723104, 3028.13698096046, 3050.6949305069315, 3056.831874246938, 3057.373238486105, 3060.648025477054, 519.3819354967577, 521.7287010754386, 527.4224723927293, 527.8891432799155, 532.6138549551545, 617.718937883262, 625.6934102289845, 641.7144370754969, 663.2935923241732, 680.3638597910871, 7850.725224617111, 8376.288015518627, 8504.914950850412, 8584.527850968132, 8668.956655216683, 595.2440400691098, 642.877853207889, 669.263859256581, 677.3463607618671, 684.1619016704498, 3472.8958131256104, 3734.6452087051684, 3740.5137332146646, 3825.158465137665, 3829.100161462054, 56553.0, 57855.42144578585, 57871.0, 58086.4191358081, 58251.0, 48588.5141148584, 49467.257991130165, 49839.50160498349, 49979.0, 49996.0, 46080.5391946083, 46758.29862552064, 47553.76223118862, 48021.75989120032, 48641.27038094431, 7675.527268189193, 7680.731174408869, 8060.0, 8100.594970251346, 8244.464109832841, 33872.49191262182, 34155.82922085374, 34826.303473929875, 34833.30333393368, 35070.82464587661, 39544.40683389809, 41796.0, 43945.56054439543, 44548.77725611351, 45402.86492837706, 9675.806483870143, 10089.545970431202, 10354.275200736178, 10368.42973636427, 10443.895561044596, 10431.895681043092, 10511.211659125443, 10537.63118290856, 10790.298630588986, 11533.82699259495, 9109.0, 9455.243580513405, 9663.420194788336, 10404.167666586807, 10424.843627345444, 9944.45305508204, 10049.748756280858, 10125.493725313558, 10154.187664986635, 10155.796884062129, 9517.23862091045, 9773.9022609773, 10132.49337533135, 10184.18526517862, 10187.949060254949, 8736.69421570242, 9013.909860901307, 9102.226310763393, 9290.62837486493, 9300.069993000645, 7706.499077559941, 7889.211078892295, 7996.680132794856, 8262.504249745034, 8365.916340836757], "unit": "ms", "name": "yui.html", "value": 6038.576513302033}], "name": "dromaeo_css", "value": 6993.420349341475}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 111.0, 113.0, 112.0, 101.0, 110.0, 116.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [152.0, 130.0, 147.0, 159.0, 127.0, 150.0, 152.0, 126.0, 171.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 161.0, 161.0, 161.0, 162.0, 166.0, 160.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 83.0, 92.0, 72.0, 73.0, 72.0, 96.0, 91.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 133.0, 91.0, 91.0, 90.0, 127.0, 90.0, 90.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 102.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 144.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 56.0, 55.0, 57.0, 56.0, 65.0, 55.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 70.0, 69.0, 70.0, 70.0, 71.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [90.0, 84.0, 84.0, 84.0, 86.0, 84.0, 85.0, 84.0, 85.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [137.0, 126.0, 122.0, 121.0, 123.0, 117.0, 122.0, 124.0, 116.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [141.0, 157.0, 162.0, 154.0, 152.0, 144.0, 154.0, 151.0, 151.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 67.0, 74.0, 66.0, 66.0, 67.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1499.8000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.86644951140065], "unit": "score", "name": "Richards", "value": 216.75427999999994}, {"lowerIsBetter": false, "replicates": [193.53590090961873], "unit": "score", "name": "DeltaBlue", "value": 341.6317059999999}, {"lowerIsBetter": false, "replicates": [282.56569652444193], "unit": "score", "name": "Encrypt", "value": 942.0145590000004}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [1114.8272017837235], "unit": "score", "name": "RayTrace", "value": 663.7701329999999}, {"lowerIsBetter": false, "replicates": [778.816199376947], "unit": "score", "name": "Earley", "value": 855.7384919999998}, {"lowerIsBetter": false, "replicates": [12023.809523809523], "unit": "score", "name": "Boyer", "value": 55.42860594059401}, {"lowerIsBetter": false, "replicates": [26500.0], "unit": "score", "name": "RegExp", "value": 34.37679245283018}, {"lowerIsBetter": false, "replicates": [600.9615384615385], "unit": "score", "name": "Splay", "value": 135.60102399999994}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21072.6379613743}]} 20:02:51 INFO - RETURN: dromaeo_css: 6993.42 20:02:51 INFO - RETURN: kraken: 1499.80 20:02:51 INFO - RETURN: v8_7: 21072.64 20:02:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "21072.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1499.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6993.42"}}} 20:02:51 INFO - Return code: 0 20:02:51 INFO - # TBPL SUCCESS # 20:02:51 INFO - Running post-action listener: _resource_record_post_action 20:02:51 INFO - Running post-run listener: _resource_record_post_run 20:02:52 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510742528; Read time: 20; Write time: 482412 20:02:52 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 240664576; Read time: 0; Write time: 281088 20:02:52 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 269078528; Read time: 20; Write time: 192692 20:02:52 INFO - Running post-run listener: _upload_blobber_files 20:02:52 INFO - Blob upload gear active. 20:02:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:02:52 INFO - Copying logs to upload dir... 20:02:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.637044 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-20 20:02:51.184009) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 20:02:51.187386) ========= 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=004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009978 build_url: 'https://queue.taskcluster.net/v1/task/Knj546atSOONOAQd_gBHdg/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-20 20:02:51.239819) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:02:51.240240) ========= 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=004b26eee9c3b360c8654f40000001e1-1448070859.181613-1744432858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:02:51.291370) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 20:02:51.291758) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 20:02:51.292148) ========= ========= Total master_lag: 0.24 =========