builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1448315548.56 results: success (0) buildid: 20151123113016 builduid: 2165e2b28f2f47dea388381d9c646f58 revision: 59a93569ae301becc903aa1cb0cc35f119da945f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:28.557422) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:28.557847) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:28.558169) ========= 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=a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004587 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:28.573739) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:28.574031) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:28.586318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:28.586567) ========= 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=a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.008926 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:28.634102) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:28.634396) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:28.634750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:28.635032) ========= 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=a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 13:52:28-- 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% 46.7M=0s 2015-11-23 13:52:28 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187008 ========= master_lag: 0.33 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:29.150700) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:29.151025) ========= 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=a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.142856 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:29.305084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 13:52:29.305469) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 59a93569ae301becc903aa1cb0cc35f119da945f --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 59a93569ae301becc903aa1cb0cc35f119da945f --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=a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 13:52:29,411 truncating revision to first 12 chars 2015-11-23 13:52:29,411 Setting DEBUG logging. 2015-11-23 13:52:29,411 attempt 1/10 2015-11-23 13:52:29,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/59a93569ae30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 13:52:30,168 unpacking tar archive at: b2g-inbound-59a93569ae30/testing/mozharness/ program finished with exit code 0 elapsedTime=1.074772 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 13:52:30.395871) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:30.396221) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:30.403364) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:30.403719) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 13:52:30.404210) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-23 13:52:30.404534) ========= /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=a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:52:30 INFO - MultiFileLogger online at 20151123 13:52:30 in /builds/slave/test-pgo 13:52:30 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 13:52:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:52:30 INFO - {'append_to_log': False, 13:52:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:52:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 13:52:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:52:30 INFO - 'branch': 'B2G-Inbound', 13:52:30 INFO - 'buildbot_json_path': 'buildprops.json', 13:52:30 INFO - 'config_files': ('talos/linux_config.py',), 13:52:30 INFO - 'default_actions': ('clobber', 13:52:30 INFO - 'read-buildbot-config', 13:52:30 INFO - 'download-and-extract', 13:52:30 INFO - 'populate-webroot', 13:52:30 INFO - 'create-virtualenv', 13:52:30 INFO - 'install', 13:52:30 INFO - 'run-tests'), 13:52:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:52:30 INFO - 'download_minidump_stackwalk': True, 13:52:30 INFO - 'download_symbols': 'ondemand', 13:52:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:52:30 INFO - 'tooltool.py': '/tools/tooltool.py', 13:52:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:52:30 INFO - '/tools/misc-python/virtualenv.py')}, 13:52:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:52:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:52:30 INFO - 'installer_path': 'installer.exe', 13:52:30 INFO - 'log_level': 'info', 13:52:30 INFO - 'log_name': 'talos', 13:52:30 INFO - 'log_to_console': True, 13:52:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:52:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:52:30 INFO - 'opt_config_files': (), 13:52:30 INFO - 'pip_index': False, 13:52:30 INFO - 'sps_profile': False, 13:52:30 INFO - 'sps_profile_interval': 0, 13:52:30 INFO - 'suite': 'dromaeojs', 13:52:30 INFO - 'system_bits': '64', 13:52:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:52:30 INFO - 'title': 'talos-linux64-ix-033', 13:52:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:52:30 INFO - 'use_talos_json': True, 13:52:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:52:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:52:30 INFO - 'work_dir': 'build'} 13:52:30 INFO - ##### 13:52:30 INFO - ##### Running clobber step. 13:52:30 INFO - ##### 13:52:30 INFO - Running pre-action listener: _resource_record_pre_action 13:52:30 INFO - Running main action method: clobber 13:52:30 INFO - rmtree: /builds/slave/test-pgo/build 13:52:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:52:36 INFO - Running post-action listener: _resource_record_post_action 13:52:36 INFO - ##### 13:52:36 INFO - ##### Running read-buildbot-config step. 13:52:36 INFO - ##### 13:52:36 INFO - Running pre-action listener: _resource_record_pre_action 13:52:36 INFO - Running main action method: read_buildbot_config 13:52:36 INFO - Using buildbot properties: 13:52:36 INFO - { 13:52:36 INFO - "properties": { 13:52:36 INFO - "buildnumber": 997, 13:52:36 INFO - "product": "firefox", 13:52:36 INFO - "script_repo_revision": "production", 13:52:36 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 13:52:36 INFO - "repository": "", 13:52:36 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 13:52:36 INFO - "buildid": "20151123113016", 13:52:36 INFO - "slavename": "talos-linux64-ix-033", 13:52:36 INFO - "pgo_build": "True", 13:52:36 INFO - "basedir": "/builds/slave/test-pgo", 13:52:36 INFO - "project": "", 13:52:36 INFO - "platform": "ubuntu64_hw", 13:52:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:52:36 INFO - "slavebuilddir": "test", 13:52:36 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 13:52:36 INFO - "branch": "b2g-inbound", 13:52:36 INFO - "repo_path": "integration/b2g-inbound", 13:52:36 INFO - "stage_platform": "linux64-pgo", 13:52:36 INFO - "builduid": "2165e2b28f2f47dea388381d9c646f58", 13:52:36 INFO - "revision": "59a93569ae301becc903aa1cb0cc35f119da945f" 13:52:36 INFO - }, 13:52:36 INFO - "sourcestamp": { 13:52:36 INFO - "repository": "", 13:52:36 INFO - "hasPatch": false, 13:52:36 INFO - "project": "", 13:52:36 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 13:52:36 INFO - "changes": [ 13:52:36 INFO - { 13:52:36 INFO - "category": null, 13:52:36 INFO - "files": [ 13:52:36 INFO - { 13:52:36 INFO - "url": null, 13:52:36 INFO - "name": "https://queue.taskcluster.net/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:52:36 INFO - } 13:52:36 INFO - ], 13:52:36 INFO - "repository": "", 13:52:36 INFO - "rev": "59a93569ae301becc903aa1cb0cc35f119da945f", 13:52:36 INFO - "who": "sendchange", 13:52:36 INFO - "when": 1448315352, 13:52:36 INFO - "number": 6696939, 13:52:36 INFO - "comments": "", 13:52:36 INFO - "project": "", 13:52:36 INFO - "at": "Mon 23 Nov 2015 13:49:12", 13:52:36 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 13:52:36 INFO - "revlink": "", 13:52:36 INFO - "properties": [ 13:52:36 INFO - [ 13:52:36 INFO - "buildid", 13:52:36 INFO - "20151123113016", 13:52:36 INFO - "Change" 13:52:36 INFO - ], 13:52:36 INFO - [ 13:52:36 INFO - "builduid", 13:52:36 INFO - "2165e2b28f2f47dea388381d9c646f58", 13:52:36 INFO - "Change" 13:52:36 INFO - ], 13:52:36 INFO - [ 13:52:36 INFO - "pgo_build", 13:52:36 INFO - "True", 13:52:36 INFO - "Change" 13:52:36 INFO - ] 13:52:36 INFO - ], 13:52:36 INFO - "revision": "59a93569ae301becc903aa1cb0cc35f119da945f" 13:52:36 INFO - } 13:52:36 INFO - ], 13:52:36 INFO - "revision": "59a93569ae301becc903aa1cb0cc35f119da945f" 13:52:36 INFO - } 13:52:36 INFO - } 13:52:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 13:52:36 INFO - Running post-action listener: _resource_record_post_action 13:52:36 INFO - ##### 13:52:36 INFO - ##### Running download-and-extract step. 13:52:36 INFO - ##### 13:52:36 INFO - Running pre-action listener: _resource_record_pre_action 13:52:36 INFO - Running main action method: download_and_extract 13:52:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:52:36 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')]} 13:52:36 INFO - https://queue.taskcluster.net/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/test_packages.json 13:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/test_packages.json 13:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:52:37 INFO - Downloaded 1302 bytes. 13:52:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:52:37 INFO - Using the following test package requirements: 13:52:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:52:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:52:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:37 INFO - u'jsshell-linux-x86_64.zip'], 13:52:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:52:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:52:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:52:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:52:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:52:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:52:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:52:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:37 INFO - https://queue.taskcluster.net/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/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 13:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/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 13:52:38 INFO - Downloaded 22525901 bytes. 13:52:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:52:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:52:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:52:39 INFO - Return code: 0 13:52:39 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 13:52:39 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')]} 13:52:39 INFO - https://queue.taskcluster.net/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:52:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:52:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:52:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/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 13:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/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 13:52:40 INFO - Downloaded 22525901 bytes. 13:52:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:52:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:52:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:52:41 INFO - Return code: 0 13:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:41 INFO - https://queue.taskcluster.net/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:52:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:52:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:52:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/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 13:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/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 13:52:42 INFO - Downloaded 11130997 bytes. 13:52:42 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 13:52:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:52:42 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 13:52:43 INFO - Return code: 0 13:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:43 INFO - https://queue.taskcluster.net/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/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 13:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/73OLHImqSpyLC9gWSXaxng/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 13:52:44 INFO - Downloaded 57564401 bytes. 13:52:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:52:44 INFO - mkdir: /builds/slave/test-pgo/properties 13:52:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:52:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:52:44 INFO - Contents: 13:52:44 INFO - build_url:https://queue.taskcluster.net/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:52:44 INFO - Running post-action listener: _resource_record_post_action 13:52:44 INFO - Running post-action listener: set_extra_try_arguments 13:52:44 INFO - ##### 13:52:44 INFO - ##### Running populate-webroot step. 13:52:44 INFO - ##### 13:52:44 INFO - Running pre-action listener: _resource_record_pre_action 13:52:44 INFO - Running main action method: populate_webroot 13:52:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:52:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:52:44 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:52:44 INFO - '../fennec_ids.txt'], 13:52:44 INFO - 'tests': ['tcheck2']}, 13:52:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:52:44 INFO - '--tppagecycles', 13:52:44 INFO - '7'], 13:52:44 INFO - 'tests': ['tsvgm']}}, 13:52:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:52:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:52:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:52:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:52:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:52:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:52:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:44 INFO - 'talos_options': ['--e10s'], 13:52:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:44 INFO - 'tests': ['damp', 'tps']}, 13:52:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:44 INFO - 'talos_options': ['--e10s'], 13:52:44 INFO - 'tests': ['damp', 'tps']}, 13:52:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:52:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:52:44 INFO - 'other': {'tests': ['a11yr', 13:52:44 INFO - 'ts_paint', 13:52:44 INFO - 'tpaint', 13:52:44 INFO - 'sessionrestore', 13:52:44 INFO - 'sessionrestore_no_auto_restore']}, 13:52:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:52:44 INFO - 'tests': ['a11yr', 13:52:44 INFO - 'ts_paint', 13:52:44 INFO - 'tpaint', 13:52:44 INFO - 'sessionrestore', 13:52:44 INFO - 'sessionrestore_no_auto_restore']}, 13:52:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:52:44 INFO - 'tests': ['a11yr', 13:52:44 INFO - 'ts_paint', 13:52:44 INFO - 'tpaint', 13:52:44 INFO - 'sessionrestore', 13:52:44 INFO - 'sessionrestore_no_auto_restore']}, 13:52:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:52:44 INFO - 'tests': ['a11yr', 13:52:44 INFO - 'ts_paint', 13:52:44 INFO - 'tpaint', 13:52:44 INFO - 'sessionrestore', 13:52:44 INFO - 'sessionrestore_no_auto_restore']}, 13:52:44 INFO - 'other_l64': {'tests': ['a11yr', 13:52:44 INFO - 'ts_paint', 13:52:44 INFO - 'tpaint', 13:52:44 INFO - 'sessionrestore', 13:52:44 INFO - 'sessionrestore_no_auto_restore']}, 13:52:44 INFO - 'other_nol64': {'tests': ['a11yr', 13:52:44 INFO - 'ts_paint', 13:52:44 INFO - 'tpaint', 13:52:44 INFO - 'sessionrestore', 13:52:44 INFO - 'sessionrestore_no_auto_restore']}, 13:52:44 INFO - 'svgr': {'tests': ['tsvgx', 13:52:44 INFO - 'tsvgr_opacity', 13:52:44 INFO - 'tart', 13:52:44 INFO - 'tscrollx', 13:52:44 INFO - 'cart']}, 13:52:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:52:44 INFO - 'tests': ['tsvgx', 13:52:44 INFO - 'tsvgr_opacity', 13:52:44 INFO - 'tart', 13:52:44 INFO - 'tscrollx', 13:52:44 INFO - 'cart']}, 13:52:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:44 INFO - 'tests': ['tp5o']}, 13:52:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:44 INFO - 'talos_options': ['--e10s'], 13:52:44 INFO - 'tests': ['tp5o']}, 13:52:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:44 INFO - 'talos_options': ['--xperf_path', 13:52:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:44 INFO - 'tests': ['tp5n']}, 13:52:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:44 INFO - 'talos_options': ['--e10s', 13:52:44 INFO - '--xperf_path', 13:52:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:44 INFO - 'tests': ['tp5n']}}, 13:52:44 INFO - 'talos.zip': {'path': '', 13:52:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:52:44 INFO - Running post-action listener: _resource_record_post_action 13:52:44 INFO - ##### 13:52:44 INFO - ##### Running create-virtualenv step. 13:52:44 INFO - ##### 13:52:44 INFO - Running pre-action listener: _resource_record_pre_action 13:52:44 INFO - Running main action method: create_virtualenv 13:52:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:52:44 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 13:52:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:52:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:52:44 INFO - Using real prefix '/usr' 13:52:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:52:45 INFO - Installing distribute.............................................................................................................................................................................................done. 13:52:47 INFO - Installing pip.................done. 13:52:47 INFO - Return code: 0 13:52:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:52:47 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')]} 13:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:47 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')]} 13:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:47 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 0x7fc023448c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', '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 13:52:47 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 13:52:47 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 13:52:47 INFO - Using env: {'DISPLAY': ':0', 13:52:47 INFO - 'HOME': '/home/cltbld', 13:52:47 INFO - 'LANG': 'en_US.UTF-8', 13:52:47 INFO - 'LANGUAGE': 'en_US:en', 13:52:47 INFO - 'LOGNAME': 'cltbld', 13:52:47 INFO - 'MAIL': '/var/mail/cltbld', 13:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:47 INFO - 'MOZ_NO_REMOTE': '1', 13:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:47 INFO - 'NO_EM_RESTART': '1', 13:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:47 INFO - 'SHELL': '/bin/bash', 13:52:47 INFO - 'SHLVL': '1', 13:52:47 INFO - 'TERM': 'linux', 13:52:47 INFO - 'TMOUT': '86400', 13:52:47 INFO - 'USER': 'cltbld', 13:52:47 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', 13:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:47 INFO - '_': '/tools/buildbot/bin/python'} 13:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:47 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 13:52:47 INFO - Cleaning up... 13:52:47 INFO - Return code: 0 13:52:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:52:47 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')]} 13:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:47 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')]} 13:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:47 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 0x7fc023448c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', '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 13:52:47 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 13:52:47 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 13:52:47 INFO - Using env: {'DISPLAY': ':0', 13:52:47 INFO - 'HOME': '/home/cltbld', 13:52:47 INFO - 'LANG': 'en_US.UTF-8', 13:52:47 INFO - 'LANGUAGE': 'en_US:en', 13:52:47 INFO - 'LOGNAME': 'cltbld', 13:52:47 INFO - 'MAIL': '/var/mail/cltbld', 13:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:47 INFO - 'MOZ_NO_REMOTE': '1', 13:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:47 INFO - 'NO_EM_RESTART': '1', 13:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:47 INFO - 'SHELL': '/bin/bash', 13:52:47 INFO - 'SHLVL': '1', 13:52:47 INFO - 'TERM': 'linux', 13:52:47 INFO - 'TMOUT': '86400', 13:52:47 INFO - 'USER': 'cltbld', 13:52:47 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', 13:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:47 INFO - '_': '/tools/buildbot/bin/python'} 13:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:47 INFO - Downloading/unpacking psutil>=0.7.1 13:52:47 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 13:52:47 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 13:52:47 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 13:52:47 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 13:52:47 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 13:52:47 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 13:52:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:52:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:52:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:52:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:49 INFO - Installing collected packages: psutil 13:52:49 INFO - Running setup.py install for psutil 13:52:49 INFO - building 'psutil._psutil_linux' extension 13:52:49 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 13:52:49 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 13:52:49 INFO - building 'psutil._psutil_posix' extension 13:52:49 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 13:52:49 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 13:52:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:50 INFO - Successfully installed psutil 13:52:50 INFO - Cleaning up... 13:52:50 INFO - Return code: 0 13:52:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:50 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 0x7fc023448c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', '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 13:52:50 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 13:52:50 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 13:52:50 INFO - Using env: {'DISPLAY': ':0', 13:52:50 INFO - 'HOME': '/home/cltbld', 13:52:50 INFO - 'LANG': 'en_US.UTF-8', 13:52:50 INFO - 'LANGUAGE': 'en_US:en', 13:52:50 INFO - 'LOGNAME': 'cltbld', 13:52:50 INFO - 'MAIL': '/var/mail/cltbld', 13:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:50 INFO - 'MOZ_NO_REMOTE': '1', 13:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:50 INFO - 'NO_EM_RESTART': '1', 13:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:50 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:50 INFO - 'SHELL': '/bin/bash', 13:52:50 INFO - 'SHLVL': '1', 13:52:50 INFO - 'TERM': 'linux', 13:52:50 INFO - 'TMOUT': '86400', 13:52:50 INFO - 'USER': 'cltbld', 13:52:50 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', 13:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:50 INFO - '_': '/tools/buildbot/bin/python'} 13:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:52:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:52:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:52:52 INFO - Installing collected packages: mozsystemmonitor 13:52:52 INFO - Running setup.py install for mozsystemmonitor 13:52:52 INFO - Successfully installed mozsystemmonitor 13:52:52 INFO - Cleaning up... 13:52:52 INFO - Return code: 0 13:52:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:52 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 0x7fc023448c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', '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 13:52:52 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 13:52:52 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 13:52:52 INFO - Using env: {'DISPLAY': ':0', 13:52:52 INFO - 'HOME': '/home/cltbld', 13:52:52 INFO - 'LANG': 'en_US.UTF-8', 13:52:52 INFO - 'LANGUAGE': 'en_US:en', 13:52:52 INFO - 'LOGNAME': 'cltbld', 13:52:52 INFO - 'MAIL': '/var/mail/cltbld', 13:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:52 INFO - 'MOZ_NO_REMOTE': '1', 13:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:52 INFO - 'NO_EM_RESTART': '1', 13:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:52 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:52 INFO - 'SHELL': '/bin/bash', 13:52:52 INFO - 'SHLVL': '1', 13:52:52 INFO - 'TERM': 'linux', 13:52:52 INFO - 'TMOUT': '86400', 13:52:52 INFO - 'USER': 'cltbld', 13:52:52 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', 13:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:52 INFO - '_': '/tools/buildbot/bin/python'} 13:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:52 INFO - Downloading/unpacking blobuploader==1.2.4 13:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:54 INFO - Downloading blobuploader-1.2.4.tar.gz 13:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:52:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:52:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:54 INFO - Downloading docopt-0.6.1.tar.gz 13:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:52:54 INFO - Installing collected packages: blobuploader, requests, docopt 13:52:54 INFO - Running setup.py install for blobuploader 13:52:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:52:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:52:54 INFO - Running setup.py install for requests 13:52:55 INFO - Running setup.py install for docopt 13:52:55 INFO - Successfully installed blobuploader requests docopt 13:52:55 INFO - Cleaning up... 13:52:55 INFO - Return code: 0 13:52:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:55 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 0x7fc023448c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', '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 13:52:55 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 13:52:55 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 13:52:55 INFO - Using env: {'DISPLAY': ':0', 13:52:55 INFO - 'HOME': '/home/cltbld', 13:52:55 INFO - 'LANG': 'en_US.UTF-8', 13:52:55 INFO - 'LANGUAGE': 'en_US:en', 13:52:55 INFO - 'LOGNAME': 'cltbld', 13:52:55 INFO - 'MAIL': '/var/mail/cltbld', 13:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:55 INFO - 'MOZ_NO_REMOTE': '1', 13:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:55 INFO - 'NO_EM_RESTART': '1', 13:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:55 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:55 INFO - 'SHELL': '/bin/bash', 13:52:55 INFO - 'SHLVL': '1', 13:52:55 INFO - 'TERM': 'linux', 13:52:55 INFO - 'TMOUT': '86400', 13:52:55 INFO - 'USER': 'cltbld', 13:52:55 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', 13:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:55 INFO - '_': '/tools/buildbot/bin/python'} 13:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:52:55 INFO - Running setup.py (path:/tmp/pip-khxtjo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:52:55 INFO - Running setup.py (path:/tmp/pip-fLWuVD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:52:55 INFO - Running setup.py (path:/tmp/pip-KyjsM0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:52:55 INFO - Running setup.py (path:/tmp/pip-9n46tn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:52:55 INFO - Running setup.py (path:/tmp/pip-XcYXf7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:52:55 INFO - Running setup.py (path:/tmp/pip-sVfwDa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:52:55 INFO - Running setup.py (path:/tmp/pip-TYXP9F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:52:56 INFO - Running setup.py (path:/tmp/pip-Bx72gw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:52:56 INFO - Running setup.py (path:/tmp/pip-n0t8Uc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:52:56 INFO - Running setup.py (path:/tmp/pip-B8gGax-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:52:56 INFO - Running setup.py (path:/tmp/pip-iT7tqn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:52:56 INFO - Running setup.py (path:/tmp/pip-k86o3J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:52:56 INFO - Running setup.py (path:/tmp/pip-vlNVSL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:52:56 INFO - Running setup.py (path:/tmp/pip-xp0Une-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:52:56 INFO - Running setup.py (path:/tmp/pip-udWpKV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:52:56 INFO - Running setup.py (path:/tmp/pip-R_fhHH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:52:56 INFO - Running setup.py (path:/tmp/pip-9ARARo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:52:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:52:56 INFO - Running setup.py install for manifestparser 13:52:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:52:56 INFO - Running setup.py install for mozcrash 13:52:56 INFO - Running setup.py install for mozdebug 13:52:57 INFO - Running setup.py install for mozdevice 13:52:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:52:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:52:57 INFO - Running setup.py install for mozfile 13:52:57 INFO - Running setup.py install for mozhttpd 13:52:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:52:57 INFO - Running setup.py install for mozinfo 13:52:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:52:57 INFO - Running setup.py install for mozInstall 13:52:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:52:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:52:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:52:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:52:57 INFO - Running setup.py install for mozleak 13:52:57 INFO - Running setup.py install for mozlog 13:52:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:52:57 INFO - Running setup.py install for moznetwork 13:52:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:52:57 INFO - Running setup.py install for mozprocess 13:52:57 INFO - Running setup.py install for mozprofile 13:52:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:52:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:52:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:52:58 INFO - Running setup.py install for mozrunner 13:52:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:52:58 INFO - Running setup.py install for mozscreenshot 13:52:58 INFO - Running setup.py install for moztest 13:52:58 INFO - Running setup.py install for mozversion 13:52:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:52:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:52:58 INFO - Cleaning up... 13:52:58 INFO - Return code: 0 13:52:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fc023448c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', '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 13:52:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 13:52:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 13:52:58 INFO - Using env: {'DISPLAY': ':0', 13:52:58 INFO - 'HOME': '/home/cltbld', 13:52:58 INFO - 'LANG': 'en_US.UTF-8', 13:52:58 INFO - 'LANGUAGE': 'en_US:en', 13:52:58 INFO - 'LOGNAME': 'cltbld', 13:52:58 INFO - 'MAIL': '/var/mail/cltbld', 13:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:58 INFO - 'MOZ_NO_REMOTE': '1', 13:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:58 INFO - 'NO_EM_RESTART': '1', 13:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:58 INFO - 'SHELL': '/bin/bash', 13:52:58 INFO - 'SHLVL': '1', 13:52:58 INFO - 'TERM': 'linux', 13:52:58 INFO - 'TMOUT': '86400', 13:52:58 INFO - 'USER': 'cltbld', 13:52:58 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', 13:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:58 INFO - '_': '/tools/buildbot/bin/python'} 13:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:52:58 INFO - Running setup.py (path:/tmp/pip-I68920-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:52:58 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)) 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:52:58 INFO - Running setup.py (path:/tmp/pip-6fTV8z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:52:58 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)) 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:52:58 INFO - Running setup.py (path:/tmp/pip-q4PoeJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:52:58 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)) 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:52:58 INFO - Running setup.py (path:/tmp/pip-BhVG6r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:52:59 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)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:52:59 INFO - Running setup.py (path:/tmp/pip-iyEnHO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:52:59 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)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:52:59 INFO - Running setup.py (path:/tmp/pip-3mKyf3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:52:59 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)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:52:59 INFO - Running setup.py (path:/tmp/pip-581I7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:52:59 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)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:52:59 INFO - Running setup.py (path:/tmp/pip-W9llJG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:52:59 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)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:52:59 INFO - Running setup.py (path:/tmp/pip-N4kOpA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:52:59 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)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:52:59 INFO - Running setup.py (path:/tmp/pip-6LC_Ch-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:52:59 INFO - Running setup.py (path:/tmp/pip-uVl8zy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:52:59 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)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:52:59 INFO - Running setup.py (path:/tmp/pip-k20GrV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:52:59 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)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:52:59 INFO - Running setup.py (path:/tmp/pip-vtgAMa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:52:59 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)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:52:59 INFO - Running setup.py (path:/tmp/pip-SO0_Cm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:52:59 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)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:52:59 INFO - Running setup.py (path:/tmp/pip-Q3X_Tt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:52:59 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)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:52:59 INFO - Running setup.py (path:/tmp/pip-7gcYCb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:52:59 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)) 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:52:59 INFO - Running setup.py (path:/tmp/pip-rUKj4z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:52:59 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)) 13:52:59 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)) 13:52:59 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)) 13:52:59 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)) 13:52:59 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)) 13:52:59 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)) 13:52:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:52:59 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 13:52:59 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 13:52:59 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 13:52:59 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 13:52:59 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 13:52:59 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 13:53:01 INFO - Downloading blessings-1.5.1.tar.gz 13:53:01 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 13:53:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:53:01 INFO - Installing collected packages: blessings 13:53:01 INFO - Running setup.py install for blessings 13:53:01 INFO - Successfully installed blessings 13:53:01 INFO - Cleaning up... 13:53:02 INFO - Return code: 0 13:53:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:53:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:53:02 INFO - Reading from file tmpfile_stdout 13:53:02 INFO - Current package versions: 13:53:02 INFO - argparse == 1.2.1 13:53:02 INFO - blessings == 1.5.1 13:53:02 INFO - blobuploader == 1.2.4 13:53:02 INFO - docopt == 0.6.1 13:53:02 INFO - manifestparser == 1.1 13:53:02 INFO - mozInstall == 1.12 13:53:02 INFO - mozcrash == 0.16 13:53:02 INFO - mozdebug == 0.1 13:53:02 INFO - mozdevice == 0.47 13:53:02 INFO - mozfile == 1.2 13:53:02 INFO - mozhttpd == 0.7 13:53:02 INFO - mozinfo == 0.9 13:53:02 INFO - mozleak == 0.1 13:53:02 INFO - mozlog == 3.1 13:53:02 INFO - moznetwork == 0.27 13:53:02 INFO - mozprocess == 0.22 13:53:02 INFO - mozprofile == 0.27 13:53:02 INFO - mozrunner == 6.11 13:53:02 INFO - mozscreenshot == 0.1 13:53:02 INFO - mozsystemmonitor == 0.0 13:53:02 INFO - moztest == 0.7 13:53:02 INFO - mozversion == 1.4 13:53:02 INFO - psutil == 3.1.1 13:53:02 INFO - requests == 1.2.3 13:53:02 INFO - wsgiref == 0.1.2 13:53:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fc023448c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', '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 13:53:02 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 13:53:02 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 13:53:02 INFO - Using env: {'DISPLAY': ':0', 13:53:02 INFO - 'HOME': '/home/cltbld', 13:53:02 INFO - 'LANG': 'en_US.UTF-8', 13:53:02 INFO - 'LANGUAGE': 'en_US:en', 13:53:02 INFO - 'LOGNAME': 'cltbld', 13:53:02 INFO - 'MAIL': '/var/mail/cltbld', 13:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:02 INFO - 'MOZ_NO_REMOTE': '1', 13:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:02 INFO - 'NO_EM_RESTART': '1', 13:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:02 INFO - 'SHELL': '/bin/bash', 13:53:02 INFO - 'SHLVL': '1', 13:53:02 INFO - 'TERM': 'linux', 13:53:02 INFO - 'TMOUT': '86400', 13:53:02 INFO - 'USER': 'cltbld', 13:53:02 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', 13:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:02 INFO - '_': '/tools/buildbot/bin/python'} 13:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:02 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)) 13:53:02 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)) 13:53:02 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)) 13:53:02 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)) 13:53:02 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)) 13:53:02 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)) 13:53:02 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)) 13:53:02 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)) 13:53:02 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)) 13:53:02 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)) 13:53:02 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)) 13:53:02 INFO - Cleaning up... 13:53:02 INFO - Return code: 0 13:53:02 INFO - Running post-action listener: _resource_record_post_action 13:53:02 INFO - Running post-action listener: _start_resource_monitoring 13:53:02 INFO - Starting resource monitoring. 13:53:02 INFO - ##### 13:53:02 INFO - ##### Running install step. 13:53:02 INFO - ##### 13:53:02 INFO - Running pre-action listener: _resource_record_pre_action 13:53:02 INFO - Running main action method: install 13:53:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:53:02 INFO - Reading from file tmpfile_stdout 13:53:02 INFO - Detecting whether we're running mozinstall >=1.0... 13:53:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:53:02 INFO - Reading from file tmpfile_stdout 13:53:02 INFO - Output received: 13:53:02 INFO - Usage: mozinstall [options] installer 13:53:02 INFO - Options: 13:53:02 INFO - -h, --help show this help message and exit 13:53:02 INFO - -d DEST, --destination=DEST 13:53:02 INFO - Directory to install application into. [default: 13:53:02 INFO - "/builds/slave/test-pgo"] 13:53:02 INFO - --app=APP Application being installed. [default: firefox] 13:53:02 INFO - mkdir: /builds/slave/test-pgo/build/application 13:53:02 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'] 13:53:02 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 13:53:17 INFO - Reading from file tmpfile_stdout 13:53:17 INFO - Output received: 13:53:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:53:17 INFO - Running post-action listener: _resource_record_post_action 13:53:17 INFO - ##### 13:53:17 INFO - ##### Running run-tests step. 13:53:17 INFO - ##### 13:53:17 INFO - Running pre-action listener: _resource_record_pre_action 13:53:17 INFO - Running main action method: run_tests 13:53:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:53:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:53:17 INFO - Python 2.7.3 13:53:17 INFO - Return code: 0 13:53:17 INFO - grabbing minidump binary from tooltool 13:53: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')]} 13:53:17 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 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:53:17 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 13:53:17 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 13:53:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:53:17 INFO - Return code: 0 13:53:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:53:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:53:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:53:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:53:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:53:17 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/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:53:17 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/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 13:53:17 INFO - Using env: {'DISPLAY': ':0', 13:53:17 INFO - 'HOME': '/home/cltbld', 13:53:17 INFO - 'LANG': 'en_US.UTF-8', 13:53:17 INFO - 'LANGUAGE': 'en_US:en', 13:53:17 INFO - 'LOGNAME': 'cltbld', 13:53:17 INFO - 'MAIL': '/var/mail/cltbld', 13:53:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:53:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:17 INFO - 'MOZ_NO_REMOTE': '1', 13:53:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:17 INFO - 'NO_EM_RESTART': '1', 13:53:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:17 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:53:17 INFO - 'SHELL': '/bin/bash', 13:53:17 INFO - 'SHLVL': '1', 13:53:17 INFO - 'TERM': 'linux', 13:53:17 INFO - 'TMOUT': '86400', 13:53:17 INFO - 'USER': 'cltbld', 13:53:17 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219', 13:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:17 INFO - '_': '/tools/buildbot/bin/python'} 13:53:17 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/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 13:53:17 INFO - mozversion INFO | application_buildid: 20151123113016 13:53:17 INFO - mozversion INFO | application_changeset: 59a93569ae301becc903aa1cb0cc35f119da945f 13:53:17 INFO - mozversion INFO | application_display_name: Nightly 13:53:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:53:17 INFO - mozversion INFO | application_name: Firefox 13:53:17 INFO - mozversion INFO | application_remotingname: firefox 13:53:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 13:53:17 INFO - mozversion INFO | application_vendor: Mozilla 13:53:17 INFO - mozversion INFO | application_version: 45.0a1 13:53:17 INFO - mozversion INFO | platform_buildid: 20151123113016 13:53:17 INFO - mozversion INFO | platform_changeset: 59a93569ae301becc903aa1cb0cc35f119da945f 13:53:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 13:53:17 INFO - mozversion INFO | platform_version: 45.0a1 13:53:17 INFO - 2015-11-23 13:53:17,435 DEBUG : using testdate: 1448315597 13:53:17 INFO - 2015-11-23 13:53:17,435 DEBUG : actual date: 1448315597 13:53:17 INFO - 2015-11-23 13:53:17,442 INFO : starting webserver on 'localhost:42720' 13:53:17 INFO - 2015-11-23 13:53:17,442 INFO : Starting test suite talos-linux64-ix-033 13:53:17 INFO - 2015-11-23 13:53:17,443 INFO : Starting test dromaeo_css 13:53:17 INFO - 2015-11-23 13:53:17,443 DEBUG : operating with platform_type : linux_ 13:53:17 INFO - 2015-11-23 13:53:17,443 INFO : Initialising browser for dromaeo_css test... 13:53:17 INFO - 2015-11-23 13:53:17,450 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7oF7rh/profile http://localhost:42720/getInfo.html 13:53:27 INFO - 2015-11-23 13:53:27,041 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:53:27 INFO - 2015-11-23 13:53:27,041 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:53:27 INFO - 2015-11-23 13:53:27,041 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:53:27 INFO - 2015-11-23 13:53:27,041 DEBUG : BROWSER_OUTPUT: __metrics 13:53:27 INFO - 2015-11-23 13:53:27,351 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:53:28 INFO - 2015-11-23 13:53:28,970 INFO : Browser initialized. 13:53:28 INFO - 2015-11-23 13:53:28,970 INFO : Running cycle 1/1 for dromaeo_css test... 13:53:28 INFO - 2015-11-23 13:53:28,970 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7oF7rh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:53:40 INFO - 2015-11-23 13:53:40,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 139513856 13:53:40 INFO - 2015-11-23 13:53:40,705 DEBUG : BROWSER_OUTPUT: 13:54:32 INFO - 2015-11-23 13:54:32,317 DEBUG : BROWSER_OUTPUT: 1448315672313 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] 13:56:41 INFO - 2015-11-23 13:56:41,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42720/tests/dromaeo/cssquery-ext.html) 13:56:42 INFO - 2015-11-23 13:56:42,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 260116480 13:56:42 INFO - 2015-11-23 13:56:42,774 DEBUG : BROWSER_OUTPUT: 13:59:45 INFO - 2015-11-23 13:59:45,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/dromaeo/cssquery-ext.html (next: http://localhost:42720/tests/dromaeo/cssquery-jquery.html) 13:59:45 INFO - 2015-11-23 13:59:45,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 226119680 13:59:45 INFO - 2015-11-23 13:59:45,774 DEBUG : BROWSER_OUTPUT: 14:02:47 INFO - 2015-11-23 14:02:47,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42720/tests/dromaeo/cssquery-mootools.html) 14:02:48 INFO - 2015-11-23 14:02:48,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 211169280 14:02:48 INFO - 2015-11-23 14:02:48,166 DEBUG : BROWSER_OUTPUT: 14:05:50 INFO - 2015-11-23 14:05:50,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42720/tests/dromaeo/cssquery-prototype.html) 14:05:50 INFO - 2015-11-23 14:05:50,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 199421952 14:05:50 INFO - 2015-11-23 14:05:50,629 DEBUG : BROWSER_OUTPUT: 14:08:53 INFO - 2015-11-23 14:08:53,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42720/tests/dromaeo/cssquery-yui.html) 14:08:53 INFO - 2015-11-23 14:08:53,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 203550720 14:08:53 INFO - 2015-11-23 14:08:53,721 DEBUG : BROWSER_OUTPUT: 14:11:56 INFO - 2015-11-23 14:11:56,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/dromaeo/cssquery-yui.html (next: http://localhost:42720/tests/dromaeo/cssquery-dojo.html) 14:11:56 INFO - 2015-11-23 14:11:56,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 224202752 14:11:56 INFO - 2015-11-23 14:11:56,548 DEBUG : BROWSER_OUTPUT: 14:11:56 INFO - 2015-11-23 14:11:56,549 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:11:56 INFO - 2015-11-23 14:11:56,549 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:11:56 INFO - 2015-11-23 14:11:56,549 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:11:56 INFO - 2015-11-23 14:11:56,550 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:11:56 INFO - 2015-11-23 14:11:56,553 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3216.614006319242;3248.382807266618;3295.6704329567046;3304.1574398528387;3322.385358708639;5329.333833270841;5438.129899216126;5466.125419932811;5491.670499770016;5504.504594586487;5379.058664733666;5494.642848214873;5497.725113744316;5581.7209139543065;5590.245316882219;4972.080165169437;4976.626752993522;5004.599632029447;5056.241563765428;5095.108356037697;4833.226683730604;5037.949620503803;5060.6963582185;5092.312537807404;5105.3873535175835;4855.417349918032;4938.950610493885;4952.306677065214;4964.131277026506;5010.7995680172935;5000.299958005882;5009.874753131165;5016.8996620067755;5026.47222041684;5066.569341605968;4953.083679519301;4984.27727979441;5000.474950130257;5014.047331007097;5071.7210553419545;5122.897542049175;5228.398734145584;5228.581713462914;5340.759665815048;5356.785728570852;5937.495312898409;5946.137810017566;5959.970200149015;5963.493103086243;5986.132010858401;5983.521318294526;5997.5501837361935;6000.669963152025;6017.729202185868;6038.57729958903;5435.456454354572;5471.972640136773;5559.527440167591;5569.498745112919;5590.245316882209;6054.848628784315;6073.301570319381;6094.238220222473;6113.266408030976;6114.2357205349335;5816.41835816415;5825.970870145622;5861.912071318849;5879.882402352015;5896.761859242364;5688.658680479184;5796.536277097906;5805.88388232233;5843.678597677083;6022.5483088768515;5873.4126587340925;5945.672987985702;5950.583459157818;5960.0761881908375;5972.193753843176;5934.347221805598;5943.049112142036;5949.732262048218;5951.4048595141;5955.225820643289;4412.514623391425;4469.9553004469535;4498.167838949805;4555.931661025087;4558.635309175258;4043.433919251307;4055.330870406409;4059.0313946939837;4074.2258970795456;4081.7959102045374;5546.278983732089;5555.3333599967455;5611.3266408031295;5623.803166889139;5626.240457538262;5689.004424225744;5773.797917072882;5774.711264436762;5876.294844618673;5892.970535147382;5455.890882182334;5546.91679624806;5549.6115271931385;5560.471755183251;5605.355384130796;5160.354955630546;5166.844994650167;5173.991071741049;5175.767090480862;5224.425313215544;5942.227510423617;6057.4851137653795;6057.515398768088;6191.25704915413;6193.287771906288;5831.183634291117;5884.146798714248;5892.234009578728;5895.174675545512;5901.350851406256;5969.224000879858;6158.414950579688;6182.474489668429;6196.938030619816;6217.160683307877;5612.186232996274;5801.071828507587;5804.796832110856;5853.560982926212;5878;5827.358990510956;5966.224390829165;5980.37206093354;5984.281886173687;6036.8188954331445;5766.971165144148;5767.567432442667;5768.307803063659;5768.625039372428;5773.191753154478;5607.5513958882375;5699.0311647020935;5723.484886360247;5764.942350576441;5768.365479797303;5521.503064724194;5592.356878958972;5605.075162598126;5609.579281553818;5647.407022262603;5799.391063938226;5826.621269617631;5846.736896839568;5854.765809367748;5859.824205273849;5475.589330800126;5590.748416321357;5602.747876345656;5660.320761508646;5721.22763426932 14:11:56 INFO - 2015-11-23 14:11:56,555 DEBUG : BROWSER_OUTPUT: |1;ext.html;585.9560532960028;593.3413910559279;593.5963544789544;602.8432607522043;618.193257798573;31413.214669633242;40147.99630009251;40845.59154408455;40900.38649420254;40919.38620920685;43560.56439435605;43658.781706091504;43760.562394376044;44079;44112.77943610286;7621.923780762177;7764.262395072459;8655.653773849053;8777.2100510954;8803.911960880405;10341.276110672256;10613.257072004963;10621.044106030457;10625.20310976676;10629.36223826569;10251.84622230667;10287.331323463988;10291.742706432324;10400.21998350123;10419.166466682685;7822.608869556528;7989.96005019977;10342.586296548128;10501.789964200672;10690.839637405445;10137.695869123938;10257.743556411075;10274.537645805956;10274.537645805956;10281.691549253534;41047.794761026;41058.1788364231;41363.37954930678;41416.378754318706;41554.37668434976;3148.8740450381956;3191.5372271020574;3202.295494991098;3239.562659041023;3601.621829707869;30603.69396306031;31233;31255.531167032514;31263;31302.686973130203;3539.185987222953;3804.1630841214887;3805.980970095132;3876.205377897524;3972.324704800191;269263;270388.96110389003;271099;271267;272383;56810;59976.40023599796;60279;60368.69815650894;60369;52184.82521398279;67871.32128678748;69178.65410673014;69642;69795;15709.921450392674;16108.597285067966;16133.677326453406;16141.03153810775;16148.434804781777;11357.20499565039;11530.250533715282;11542.769144617061;11549.36478493691;11553.364564949008;19441.319553815832;19610.21559137647;19617.411477655693;19621.60756784856;19691.60616787656;7712.575808330484;7930.206979302139;8064.314533264621;8084.636191371284;8104.432689711663;938.6010945348336;953.609020301673;1028.9588416463257;1048.627737153315;1078.6332646900091;28793.568096478568;29058.82058845595;29176.416471670447;29234.415311694072;29317.706822931497;978.6917121106828;1006.3911333643186;1027.085893554737;1028.5577201803296;1031.8194315994672;13967.580972570839;13967.650808729863;14407.135571865721;14410.135391876522;14694.706105878036;319279;322851;324361;324490;325411;51728.22407663888;52470.737646312286;53407.46592534103;53541;53563.73218133963;1311.672081979505;1336.7527007503643;1339.5512503311304;1346.7912473566612;1353.6751179716798;25808.354791130372;26806;28021;28861.27846803847;29646.851765741034;44452.777736111115;44548;44644;44844.10311793681;44849.327260090475;267370;268279;269053;269481;270198;28268.575971360857;28440.715592843808;28534.57198142071;33000.504992424656;33105.83447082749;38806.80596597112;39019.2196156081;39042.609573903894;39934.800325998185;40218.19563608653;33418.665813341555;33471.330573388885;33559.66440335663;33760.49359259564;33890.49164262489;28885.42229155447;33437.665623343455;34058.14854628654;34112.65887341194;34346;33075.66924330726;33354.4996825043;33598.3280334387;33755.15612109717;33874;29617.111486655434;30880;30973.91591294294;31001.8449907749;31011;23237.65143522815;23860.403489912893;24092.92586868779;24866.751332486445;25059 14:11:56 INFO - 2015-11-23 14:11:56,556 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.5869870299804;359.3782755832409;361.20534823388533;361.30989809463927;362.994555081674;14176.50382236622;14251.572452826405;16725.163741812907;17699.734503982436;18789.718154227696;10826.1880358973;11107.278026928245;17155.828441715577;17612.911935440337;17750.289988400447;4763.952360476385;4884.780184891671;4892.094962431944;4892.266160075999;4914.4839791821705;3696.519452471175;3777.112378591029;4881.463039065718;4922.950770492303;5195;5268.367795864482;5288.92066619001;5329.067413202693;5341.359036915575;5349.5720342372515;5101.056304583645;5240;5245.370555533361;5309.787608495655;5313.654612450197;4969.981153863449;5080.13637681595;5082.08522465956;5086.949130508721;5228.320318358589;11916.702082447922;12028;12083.516659333616;12162.331071791048;18113.54716132094;1989.4131231286806;2006.8695534790193;2062.7730949595534;2072.2229164063474;2179.6294629912954;9355.251579873593;9453.149216570473;9471.573779179884;9591.952040239754;10331;1648.7856578644698;1694.3561446650317;1823.4073925973978;1842.0697547738441;1888.4617883903022;58865.41134588685;62567.687161564354;62786.05820912735;62861;63278.36721632771;9935.552900119368;10193.490325483695;10363.844542331872;10371.896281037243;10406.895931040744;13726.107802992774;13731.313434328244;13742.725145497034;13754.862451375559;13761.931190344185;7137.4290056795335;7161.355478007004;7197.028401165776;7716.186696126406;7864.72473463426;6600.339966003361;6994.895076573754;7181.928180718231;7244.855102897913;7246.1666908306215;4287.892802679896;4394.428724265825;4417.8232870684815;4496.39298694672;4505.639548836085;1705.914704264782;1725.0943254791334;1764.1267572551412;1794.228481752859;1847.0856925821804;819.4714409206028;930.7347405989397;936.5457752989795;973.5667627905514;973.8247115519133;16396.344146234016;16449.424270150488;17017.659646806995;17378.65242695139;17452.825471745375;808.983820323602;850.2305413600701;870.3863776037878;874.8906386701663;881.7839629290864;9333.579988900516;9725.124738773544;9732.270079743907;9751.073648003428;9806.31355805101;513012;522463;534790;535325;538075;78490;78883.60558197173;80331.99999999884;82903.17096829075;83083.5845820779;1128.542940109257;1143.8455808465917;1154.4574050196395;1154.6189757380212;1155.3356819828632;15487.53537393835;15621.062736235863;15821.129837859029;15885.2851621675;15933.521994340188;34315.313693726486;34479.13802154866;34621.307573848884;35405.46891796677;35544;45844;46360.53639463697;46974.29538556856;47669.52330476651;48905.266421004424;9376.437413755197;9554.570044347882;9592.184664303611;9681;9683.806323873343;14799.852001479847;17379.304827806747;17679.204435800162;17842.55393615118;17863.821361786217;14500.202488863213;14813.555593332218;14851.257437128317;14960.251987400805;14993.2503374833;13249;14026.158430494203;14421.42314307416;14657.413703452168;15018;11488.597899073493;14122.293885305899;14386.856131438552;14654.487092951695;14713.411463541339;9108.132832769134;9177.632894684139;9196.218321442751;9274.721758347261;9453;13854.792178117135;13911.652208694864;13920.443182273;13986;14101.083429577046 14:11:56 INFO - 2015-11-23 14:11:56,557 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1328.5748560460656;1706.1042952449964;1715.7083295839707;1774.2104763380296;1779.6974514332562;6805.625690587022;7314.670839812208;7558.055243094614;7579.052618422697;7582.507137036103;7492.550446973185;7730.536167829934;7731.11092224393;7732.072151341833;7747.845043099134;1988.4929343017511;2008.2469074097214;2011.5172358633895;2213.2917466410713;2245.517213799033;2029.1984666056899;2208.2712704807454;2231.7656646052174;2232.955340893181;2233.765454627265;2146.4633841539617;2168.251953076186;2174.9021294041727;2211.369759618509;2211.900464479102;1963.2834015584208;2003.0485519378324;2249.8875056247202;2276.738175109867;2277.7038984931937;1907.1799126375654;1918.8464922806143;1920.3278852401688;2237.485378362969;2271.250487339174;7704.036995375578;7828.647710853025;7857.528548287064;7860.882086768645;7866.331361834251;4679.789409476582;4704.364910737041;4733.763311834429;4756.643251756098;4757;2958.082994271783;2987.760979121665;3013.4274487847238;3024.2741741981986;3045.4974929136665;901.7384958362068;919.3334832246635;922.2161163011453;934.6588495199203;944.655200851691;10657.253992220547;10659;10681.679549613524;10697.83953240702;10714.196435267308;4141.088960428701;4226.34491653788;4234.597713217239;4252.87241382759;4290.184864875726;9267.351285410092;9282.535873206312;9289.674861379819;9295.72112836616;9299.302552308603;4765.213739732905;4783.067301876101;4784.712917224978;4795.568398844051;4795.95204047962;4355.346697995263;4371.890702732457;4376.124775045004;4376.737395756265;4393.802278897393;3708.7589306694977;3748.4377343398164;3749.2876353492748;3771.641694039062;3778.3954567269657;1193.8686744458103;1194.988050119505;1198.9340586267665;1223.406647775828;1229.858566264891;1029.4749677664445;1041.656253436364;1048.444324508012;1199.5681554640323;1364.6861221919014;7415.147258065392;7461.36578390832;7475.289847464483;7478.551286922802;7556.65995030214;1095.780843831237;1117.1118960426481;1132.4054871192525;1147.862256529205;1156.5142640091183;5476.507114359727;5542.722863856791;5898.793542226002;5963.910541341883;5964.254468191476;9071.682491112779;9242.21441177494;9290.256779457763;9316.720498385059;9372.203362714246;9128.497932613636;9234.722958311262;9239.029901860207;9372.5313734313;9381.812363752686;7143.571385716769;7206.126407134183;7233.819154521074;7243.311885370881;7249.166345870187;7009.158900931717;7225.24134965821;7248.637568121679;7382.926170738224;7390.741324053847;8180;8200.753977380688;8255.25702686761;8312.5428101455;8439.282660973886;8339.749807505785;8519.977602687717;8533.189347012023;8533.74398768038;8535.658573657232;6997.930020699931;7075.82310442243;7078.8938165928585;7093.32613401726;7097.858042839011;7422.703091876265;7458.552486850806;7567.735129270449;7570.318671319607;7583.734569290048;6859;6930.826729331807;6931.618760968196;6986.930130698831;7029.859402811813;6926.515143939876;6972.198197207386;6986.650667466708;7107.822304442224;7116.181639111568;7067.82330441743;7117.217106118426;7134.607596582237;7136.179339375831;7146.785596432115;6375.330590287953;6400.135981642605;6404.359564043744;6404.71178796946;6574.868502630016;6623.470122390101;6657.866842663023;6667.699953502201;6675.8664826702225;6698.162729658793 14:11:56 INFO - 2015-11-23 14:11:56,557 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.2974434709721;330.5355974855328;331.842374871936;333.1105947121186;340.18186262039774;5901.852453688649;6003.309619393765;6090.969545152279;6101.054336577838;6133.141360209569;5752.5110365618975;5947.4052594740615;5985.790497332594;5994.040953447449;5996.2504686914135;4610.631149508032;4611.700239484439;4615.538446155383;4616.8614941551805;4618.722876627413;4380.912381752363;4440.067585806984;4526.841560545382;4618.330342100394;4650.116477869211;4565.977170114162;4583.656225783063;4585.358049873003;4602.838900638479;4607.792649330771;4588.701734387288;4601.4248218972625;4613.7001094929055;4616.792244348995;4619.976900115478;4048.595140485928;4053.4730485036757;4059.0867054912705;4059.878203653895;4074;5588.497035266845;5658.886822263573;5679.318481782171;5679.687617181054;5687.687177205252;5358.410574836765;5360.731963401814;5370.462953704638;5374.220737992969;5375.9840059977505;6014.2181516403025;6362.459190968773;6366.236051673783;6369;6371;4331.350297455376;4354.912901741979;4432.756198409086;4437.955620443787;4481.596656300916;6574.704138313788;6581.80254592363;6588.242352129519;6588.374104460068;6607.471402287805;4582.495925448198;4587.128445595326;4588.036512332447;4590.403247577793;4593.540645935446;4413;4547.454305483363;4558.475775285819;4623.56076172763;4653;5284;5288.65623734456;5289.841304760864;5292.5236728693835;5294.867628309323;6428.614283143026;6430.324815894357;6446.419822216023;6455.774047908395;6458.644774537352;1585.7938467999086;1609.2195285286627;1609.5654173373123;1610.846969537892;1611.6373815891566;1060.4697651174413;1061.135174832509;1071.0467683761303;1071.6088627650852;1092.3500517192258;6220.346863579259;6222.222222222223;6223.813285601439;6230.345813689497;6233.407826256498;6581.3418658133805;6585.078089067534;6591.209054913441;6592.505562082767;6595.835104122435;6071.483923866433;6223.564350495512;6225.8132256032395;6230.501559875199;6232.968835155795;3548.875789347412;3576.213233088716;3578.7137029037613;3582.802945837952;3583.408737558326;6825.658717064127;6843.555168914005;6856.897146542806;6860.5540639858245;6865.141857267841;6648.7340506379205;6763.898541521881;6775.3902148805855;6780.525363224626;6782.525223234425;6768.086308348408;6768.120144381297;6771.492138089663;6780.186377634715;6785.9321406786285;6321.49428045746;6498.480121590167;6571.408573228432;6594.835129121619;6604.042413850061;6586.604803711793;6608.900866487103;6613.636250006296;6618.305077966744;6637.535372523877;6909.930900690929;6916.896246556205;6926.757563485254;6927;6929.792106236821;4326.502452217909;4460.1971645104195;4492.079123779683;4521.751303678329;4529.524399937959;6571.145751052332;6571.901421478586;6578.04618330349;6578.276389597045;6585.901211481927;6395.104685343963;6398.328175541501;6403.29563747978;6403.8719225614295;6410.294867564471;6213.37866213375;6374.394432528902;6404.679766011774;6423.100765892872;6472.676366181578;6273.62358258506;6293.181886354744;6295.338989406229;6300.621962682254;6301.275353334242;6448.5163612730175;6496.577722448026;6510.869782604416;6512.967435162984;6517.576357536745;6140.785072522441;6297.496200304056;6305.527085468517;6314.273858506331;6369.649669268235 14:11:56 INFO - 2015-11-23 14:11:56,558 DEBUG : BROWSER_OUTPUT: |5;yui.html;859.3297228162033;859.3640705877652;860.6901515454435;871.27248747296;875.816078623489;12983.09118361715;13264.801027984564;13268.867311326896;13294.601161965144;13299.534516291931;12610.936945315261;12698.873011269885;12701.872981270184;12712.618621441348;12723.554675586356;657.4181849063577;679.480197648799;810.0320117459638;824.4352618456346;826.3595713322163;810.0360570920615;816.5794615772882;817.6034623207739;823.0493779684444;823.7322870067222;686.800827759949;857.9571021448934;862.810181760015;863.5336918064238;863.7063398444527;697.6825544377297;826.6280173921729;834.5660256666561;840.0465471689677;841.7264389073514;626.2797782550058;626.3423405424331;626.3861415812484;626.5989766549412;628.0453710360273;13028.544000960015;13149.276789776559;13184.34078296091;13211.603651890458;13285;12035.338056406894;12488.188267762567;12933.935330323382;13047.739045219138;13082.86917130826;10377.377357358582;10504.947475262576;10513.316634418738;10544.10375118116;10632.936706329305;3493.615702272748;3508.438649816043;3514.226870088602;3613.060604242916;3652.5069115669576;48162;48329.51670483285;48496;48558.51441485575;48702;9899.208063354914;10130.645427410005;10337.793244135075;10409.115225205942;10578.629747958785;18992.90503547501;19003.42989710311;19047.42857714271;19052.904735476233;19078.427647170607;7455.739049133254;7507.737229196952;7536.171021187665;7537.886931696029;7717.729879454305;4344.587264209895;4354.9782251088545;4376.081022985145;4386.561343865588;4403.515613282536;3006.5941097951495;3036.089173248061;3037.2862377341307;3049.9847500762353;3050.2984313607994;506.52639781803396;519.7764961066702;531.3517508639453;541.6641682157009;543.1093007467678;521.8669239344019;582.9183914252009;585.6749504025307;665.2050799294797;702.1574111066741;7964.482308649919;8132.349412047022;8161.183881611792;8177.9591102044105;8280.130586288353;487.45892059813576;508.40557260170243;533.7091285249548;541.3125330829824;559.4964531921304;3624.1664417184197;3723.72072094594;3726.9440958385644;3869.110104675884;3952.7628342299554;58570.41429585735;58596.41403585995;58657.120143197884;58701.412985869596;58761;51789.48210517847;52197.21704174441;52574;53364;53402.99999999922;47109.52890471051;47190.76404617955;47482.28776568354;47552.99999999931;47743.283850742264;7616.7334143304715;7672.961635192011;7685;7732.536047837148;7808.492447990862;35986.4602030975;36372.45441318435;36721.44917826288;36808.26383472369;37232;45998.54001459943;46192;46333.768331159474;46584;46590.534094659975;9363.344565880596;9928.950355248178;10370.585176592851;10573.101286390744;11009.61466348674;11580.189386742848;11768.882311177122;11868.406579671155;12406.875931240573;12968.09223354356;11162.665120046411;11440.485178166837;11450.484728187084;11708.180427370002;11937.164398492023;11454.713632159262;11606.30362178272;11626.01178899803;11907.642770716893;12272.938635306766;11285.774284514428;11426.485808138488;11506.252093614223;11519.13606479534;11869.821952670889;9931.503424828585;9934.304598678023;10066.798664026532;10113;10609.257351985287;8820.823583528421;9238.353315267866;9466;9703.66037188695;9816.509174541387 14:11:56 INFO - 2015-11-23 14:11:56,558 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:11:56 INFO - 2015-11-23 14:11:56,558 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:11:56 INFO - 2015-11-23 14:11:56,559 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,903 14:11:56 INFO - 2015-11-23 14:11:56,559 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:11:56 INFO - 2015-11-23 14:11:56,559 DEBUG : BROWSER_OUTPUT: __startTimestamp1448316716548__endTimestamp 14:11:56 INFO - 2015-11-23 14:11:56,559 DEBUG : BROWSER_OUTPUT: 14:11:56 INFO - 2015-11-23 14:11:56,559 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:11:56 INFO - 2015-11-23 14:11:56,559 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:11:56 INFO - 2015-11-23 14:11:56,559 DEBUG : BROWSER_OUTPUT: 14:11:56 INFO - 2015-11-23 14:11:56,559 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5476.69 Median:5623.80 stddev:617.40 (11.0%) stddev-sans-first:593.29 14:11:56 INFO - 2015-11-23 14:11:56,559 DEBUG : BROWSER_OUTPUT: Values: 3216.6 3248.4 3295.7 3304.2 3322.4 5329.3 5438.1 5466.1 5491.7 5504.5 5379.1 5494.6 5497.7 5581.7 5590.2 4972.1 4976.6 5004.6 5056.2 5095.1 4833.2 5037.9 5060.7 5092.3 5105.4 4855.4 4939.0 4952.3 4964.1 5010.8 5000.3 5009.9 5016.9 5026.5 5066.6 4953.1 4984.3 5000.5 5014.0 5071.7 5122.9 5228.4 5228.6 5340.8 5356.8 5937.5 5946.1 5960.0 5963.5 5986.1 5983.5 5997.6 6000.7 6017.7 6038.6 5435.5 5472.0 5559.5 5569.5 5590.2 6054.8 6073.3 6094.2 6113.3 6114.2 5816.4 5826.0 5861.9 5879.9 5896.8 5688.7 5796.5 5805.9 5843.7 6022.5 5873.4 5945.7 5950.6 5960.1 5972.2 5934.3 5943.0 5949.7 5951.4 5955.2 4412.5 4470.0 4498.2 4555.9 4558.6 4043.4 4055.3 4059.0 4074.2 4081.8 5546.3 5555.3 5611.3 5623.8 5626.2 5689.0 5773.8 5774.7 5876.3 5893.0 5455.9 5546.9 5549.6 5560.5 5605.4 5160.4 5166.8 5174.0 5175.8 5224.4 5942.2 6057.5 6057.5 6191.3 6193.3 5831.2 5884.1 5892.2 5895.2 5901.4 5969.2 6158.4 6182.5 6196.9 6217.2 5612.2 5801.1 5804.8 5853.6 5878.0 5827.4 5966.2 5980.4 5984.3 6036.8 5767.0 5767.6 5768.3 5768.6 5773.2 5607.6 5699.0 5723.5 5764.9 5768.4 5521.5 5592.4 5605.1 5609.6 5647.4 5799.4 5826.6 5846.7 5854.8 5859.8 5475.6 5590.7 5602.7 5660.3 5721.2 14:11:56 INFO - 2015-11-23 14:11:56,559 DEBUG : BROWSER_OUTPUT: 14:11:56 INFO - 2015-11-23 14:11:56,559 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45891.40 Median:3170.21 stddev:75437.83 (2379.6%) stddev-sans-first:75572.76 14:11:56 INFO - 2015-11-23 14:11:56,559 DEBUG : BROWSER_OUTPUT: Values: 586.0 593.3 593.6 602.8 618.2 31413.2 40148.0 40845.6 40900.4 40919.4 43560.6 43658.8 43760.6 44079.0 44112.8 7621.9 7764.3 8655.7 8777.2 8803.9 10341.3 10613.3 10621.0 10625.2 10629.4 10251.8 10287.3 10291.7 10400.2 10419.2 7822.6 7990.0 10342.6 10501.8 10690.8 10137.7 10257.7 10274.5 10274.5 10281.7 41047.8 41058.2 41363.4 41416.4 41554.4 3148.9 3191.5 3202.3 3239.6 3601.6 30603.7 31233.0 31255.5 31263.0 31302.7 3539.2 3804.2 3806.0 3876.2 3972.3 269263.0 270389.0 271099.0 271267.0 272383.0 56810.0 59976.4 60279.0 60368.7 60369.0 52184.8 67871.3 69178.7 69642.0 69795.0 15709.9 16108.6 16133.7 16141.0 16148.4 11357.2 11530.3 11542.8 11549.4 11553.4 19441.3 19610.2 19617.4 19621.6 19691.6 7712.6 7930.2 8064.3 8084.6 8104.4 938.6 953.6 1029.0 1048.6 1078.6 28793.6 29058.8 29176.4 29234.4 29317.7 978.7 1006.4 1027.1 1028.6 1031.8 13967.6 13967.7 14407.1 14410.1 14694.7 319279.0 322851.0 324361.0 324490.0 325411.0 51728.2 52470.7 53407.5 53541.0 53563.7 1311.7 1336.8 1339.6 1346.8 1353.7 25808.4 26806.0 28021.0 28861.3 29646.9 44452.8 44548.0 44644.0 44844.1 44849.3 267370.0 268279.0 269053.0 269481.0 270198.0 28268.6 28440.7 28534.6 33000.5 33105.8 38806.8 39019.2 39042.6 39934.8 40218.2 33418.7 33471.3 33559.7 33760.5 33890.5 28885.4 33437.7 34058.1 34112.7 34346.0 33075.7 33354.5 33598.3 33755.2 33874.0 29617.1 30880.0 30973.9 31001.8 31011.0 23237.7 23860.4 24092.9 24866.8 25059.0 14:11:56 INFO - 2015-11-23 14:11:56,560 DEBUG : BROWSER_OUTPUT: 14:11:56 INFO - 2015-11-23 14:11:56,560 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28325.09 Median:3736.82 stddev:86494.83 (2314.7%) stddev-sans-first:86711.98 14:11:56 INFO - 2015-11-23 14:11:56,561 DEBUG : BROWSER_OUTPUT: Values: 357.6 359.4 361.2 361.3 363.0 14176.5 14251.6 16725.2 17699.7 18789.7 10826.2 11107.3 17155.8 17612.9 17750.3 4764.0 4884.8 4892.1 4892.3 4914.5 3696.5 3777.1 4881.5 4923.0 5195.0 5268.4 5288.9 5329.1 5341.4 5349.6 5101.1 5240.0 5245.4 5309.8 5313.7 4970.0 5080.1 5082.1 5086.9 5228.3 11916.7 12028.0 12083.5 12162.3 18113.5 1989.4 2006.9 2062.8 2072.2 2179.6 9355.3 9453.1 9471.6 9592.0 10331.0 1648.8 1694.4 1823.4 1842.1 1888.5 58865.4 62567.7 62786.1 62861.0 63278.4 9935.6 10193.5 10363.8 10371.9 10406.9 13726.1 13731.3 13742.7 13754.9 13761.9 7137.4 7161.4 7197.0 7716.2 7864.7 6600.3 6994.9 7181.9 7244.9 7246.2 4287.9 4394.4 4417.8 4496.4 4505.6 1705.9 1725.1 1764.1 1794.2 1847.1 819.5 930.7 936.5 973.6 973.8 16396.3 16449.4 17017.7 17378.7 17452.8 809.0 850.2 870.4 874.9 881.8 9333.6 9725.1 9732.3 9751.1 9806.3 513012.0 522463.0 534790.0 535325.0 538075.0 78490.0 78883.6 80332.0 82903.2 83083.6 1128.5 1143.8 1154.5 1154.6 1155.3 15487.5 15621.1 15821.1 15885.3 15933.5 34315.3 34479.1 34621.3 35405.5 35544.0 45844.0 46360.5 46974.3 47669.5 48905.3 9376.4 9554.6 9592.2 9681.0 9683.8 14799.9 17379.3 17679.2 17842.6 17863.8 14500.2 14813.6 14851.3 14960.3 14993.3 13249.0 14026.2 14421.4 14657.4 15018.0 11488.6 14122.3 14386.9 14654.5 14713.4 9108.1 9177.6 9196.2 9274.7 9453.0 13854.8 13911.7 13920.4 13986.0 14101.1 14:11:56 INFO - 2015-11-23 14:11:56,561 DEBUG : BROWSER_OUTPUT: 14:11:56 INFO - 2015-11-23 14:11:56,561 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5451.03 Median:6640.67 stddev:2836.89 (42.7%) stddev-sans-first:2827.92 14:11:56 INFO - 2015-11-23 14:11:56,562 DEBUG : BROWSER_OUTPUT: Values: 1328.6 1706.1 1715.7 1774.2 1779.7 6805.6 7314.7 7558.1 7579.1 7582.5 7492.6 7730.5 7731.1 7732.1 7747.8 1988.5 2008.2 2011.5 2213.3 2245.5 2029.2 2208.3 2231.8 2233.0 2233.8 2146.5 2168.3 2174.9 2211.4 2211.9 1963.3 2003.0 2249.9 2276.7 2277.7 1907.2 1918.8 1920.3 2237.5 2271.3 7704.0 7828.6 7857.5 7860.9 7866.3 4679.8 4704.4 4733.8 4756.6 4757.0 2958.1 2987.8 3013.4 3024.3 3045.5 901.7 919.3 922.2 934.7 944.7 10657.3 10659.0 10681.7 10697.8 10714.2 4141.1 4226.3 4234.6 4252.9 4290.2 9267.4 9282.5 9289.7 9295.7 9299.3 4765.2 4783.1 4784.7 4795.6 4796.0 4355.3 4371.9 4376.1 4376.7 4393.8 3708.8 3748.4 3749.3 3771.6 3778.4 1193.9 1195.0 1198.9 1223.4 1229.9 1029.5 1041.7 1048.4 1199.6 1364.7 7415.1 7461.4 7475.3 7478.6 7556.7 1095.8 1117.1 1132.4 1147.9 1156.5 5476.5 5542.7 5898.8 5963.9 5964.3 9071.7 9242.2 9290.3 9316.7 9372.2 9128.5 9234.7 9239.0 9372.5 9381.8 7143.6 7206.1 7233.8 7243.3 7249.2 7009.2 7225.2 7248.6 7382.9 7390.7 8180.0 8200.8 8255.3 8312.5 8439.3 8339.7 8520.0 8533.2 8533.7 8535.7 6997.9 7075.8 7078.9 7093.3 7097.9 7422.7 7458.6 7567.7 7570.3 7583.7 6859.0 6930.8 6931.6 6986.9 7029.9 6926.5 6972.2 6986.7 7107.8 7116.2 7067.8 7117.2 7134.6 7136.2 7146.8 6375.3 6400.1 6404.4 6404.7 6574.9 6623.5 6657.9 6667.7 6675.9 6698.2 14:11:56 INFO - 2015-11-23 14:11:56,563 DEBUG : BROWSER_OUTPUT: 14:11:56 INFO - 2015-11-23 14:11:56,563 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5347.18 Median:6117.10 stddev:1617.31 (26.4%) stddev-sans-first:1577.36 14:11:56 INFO - 2015-11-23 14:11:56,563 DEBUG : BROWSER_OUTPUT: Values: 328.3 330.5 331.8 333.1 340.2 5901.9 6003.3 6091.0 6101.1 6133.1 5752.5 5947.4 5985.8 5994.0 5996.3 4610.6 4611.7 4615.5 4616.9 4618.7 4380.9 4440.1 4526.8 4618.3 4650.1 4566.0 4583.7 4585.4 4602.8 4607.8 4588.7 4601.4 4613.7 4616.8 4620.0 4048.6 4053.5 4059.1 4059.9 4074.0 5588.5 5658.9 5679.3 5679.7 5687.7 5358.4 5360.7 5370.5 5374.2 5376.0 6014.2 6362.5 6366.2 6369.0 6371.0 4331.4 4354.9 4432.8 4438.0 4481.6 6574.7 6581.8 6588.2 6588.4 6607.5 4582.5 4587.1 4588.0 4590.4 4593.5 4413.0 4547.5 4558.5 4623.6 4653.0 5284.0 5288.7 5289.8 5292.5 5294.9 6428.6 6430.3 6446.4 6455.8 6458.6 1585.8 1609.2 1609.6 1610.8 1611.6 1060.5 1061.1 1071.0 1071.6 1092.4 6220.3 6222.2 6223.8 6230.3 6233.4 6581.3 6585.1 6591.2 6592.5 6595.8 6071.5 6223.6 6225.8 6230.5 6233.0 3548.9 3576.2 3578.7 3582.8 3583.4 6825.7 6843.6 6856.9 6860.6 6865.1 6648.7 6763.9 6775.4 6780.5 6782.5 6768.1 6768.1 6771.5 6780.2 6785.9 6321.5 6498.5 6571.4 6594.8 6604.0 6586.6 6608.9 6613.6 6618.3 6637.5 6909.9 6916.9 6926.8 6927.0 6929.8 4326.5 4460.2 4492.1 4521.8 4529.5 6571.1 6571.9 6578.0 6578.3 6585.9 6395.1 6398.3 6403.3 6403.9 6410.3 6213.4 6374.4 6404.7 6423.1 6472.7 6273.6 6293.2 6295.3 6300.6 6301.3 6448.5 6496.6 6510.9 6513.0 6517.6 6140.8 6297.5 6305.5 6314.3 6369.6 14:11:56 INFO - 2015-11-23 14:11:56,563 DEBUG : BROWSER_OUTPUT: 14:11:56 INFO - 2015-11-23 14:11:56,563 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13973.04 Median:47150.15 stddev:16385.24 (34.8%) stddev-sans-first:16401.62 14:11:56 INFO - 2015-11-23 14:11:56,563 DEBUG : BROWSER_OUTPUT: Values: 859.3 859.4 860.7 871.3 875.8 12983.1 13264.8 13268.9 13294.6 13299.5 12610.9 12698.9 12701.9 12712.6 12723.6 657.4 679.5 810.0 824.4 826.4 810.0 816.6 817.6 823.0 823.7 686.8 858.0 862.8 863.5 863.7 697.7 826.6 834.6 840.0 841.7 626.3 626.3 626.4 626.6 628.0 13028.5 13149.3 13184.3 13211.6 13285.0 12035.3 12488.2 12933.9 13047.7 13082.9 10377.4 10504.9 10513.3 10544.1 10632.9 3493.6 3508.4 3514.2 3613.1 3652.5 48162.0 48329.5 48496.0 48558.5 48702.0 9899.2 10130.6 10337.8 10409.1 10578.6 18992.9 19003.4 19047.4 19052.9 19078.4 7455.7 7507.7 7536.2 7537.9 7717.7 4344.6 4355.0 4376.1 4386.6 4403.5 3006.6 3036.1 3037.3 3050.0 3050.3 506.5 519.8 531.4 541.7 543.1 521.9 582.9 585.7 665.2 702.2 7964.5 8132.3 8161.2 8178.0 8280.1 487.5 508.4 533.7 541.3 559.5 3624.2 3723.7 3726.9 3869.1 3952.8 58570.4 58596.4 58657.1 58701.4 58761.0 51789.5 52197.2 52574.0 53364.0 53403.0 47109.5 47190.8 47482.3 47553.0 47743.3 7616.7 7673.0 7685.0 7732.5 7808.5 35986.5 36372.5 36721.4 36808.3 37232.0 45998.5 46192.0 46333.8 46584.0 46590.5 9363.3 9929.0 10370.6 10573.1 11009.6 11580.2 11768.9 11868.4 12406.9 12968.1 11162.7 11440.5 11450.5 11708.2 11937.2 11454.7 11606.3 11626.0 11907.6 12272.9 11285.8 11426.5 11506.3 11519.1 11869.8 9931.5 9934.3 10066.8 10113.0 10609.3 8820.8 9238.4 9466.0 9703.7 9816.5 14:11:56 INFO - 2015-11-23 14:11:56,563 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:11:56 INFO - 2015-11-23 14:11:56,563 DEBUG : BROWSER_OUTPUT: 14:11:57 INFO - 2015-11-23 14:11:57,371 INFO : Browser exited with error code: 0 14:11:57 INFO - 2015-11-23 14:11:57,390 INFO : Completed test dromaeo_css (00:18:39) 14:11:57 INFO - 2015-11-23 14:11:57,390 INFO : Starting test kraken 14:11:57 INFO - 2015-11-23 14:11:57,390 DEBUG : operating with platform_type : linux_ 14:11:57 INFO - 2015-11-23 14:11:57,391 INFO : Initialising browser for kraken test... 14:11:57 INFO - 2015-11-23 14:11:57,397 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptqvVDL/profile http://localhost:42720/getInfo.html 14:12:02 INFO - 2015-11-23 14:12:02,191 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:12:02 INFO - 2015-11-23 14:12:02,191 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:12:02 INFO - 2015-11-23 14:12:02,191 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:12:02 INFO - 2015-11-23 14:12:02,192 DEBUG : BROWSER_OUTPUT: __metrics 14:12:02 INFO - 2015-11-23 14:12:02,336 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:12:03 INFO - 2015-11-23 14:12:03,816 INFO : Browser initialized. 14:12:03 INFO - 2015-11-23 14:12:03,817 INFO : Running cycle 1/1 for kraken test... 14:12:03 INFO - 2015-11-23 14:12:03,817 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptqvVDL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:12:15 INFO - 2015-11-23 14:12:15,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 140120064 14:12:15 INFO - 2015-11-23 14:12:15,639 DEBUG : BROWSER_OUTPUT: 14:12:18 INFO - 2015-11-23 14:12:18,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42720/tests/kraken/driver.html?testName=audio-beat-detection) 14:12:18 INFO - 2015-11-23 14:12:18,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 179384320 14:12:18 INFO - 2015-11-23 14:12:18,660 DEBUG : BROWSER_OUTPUT: 14:12:21 INFO - 2015-11-23 14:12:21,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42720/tests/kraken/driver.html?testName=audio-dft) 14:12:21 INFO - 2015-11-23 14:12:21,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 168181760 14:12:21 INFO - 2015-11-23 14:12:21,827 DEBUG : BROWSER_OUTPUT: 14:12:24 INFO - 2015-11-23 14:12:24,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42720/tests/kraken/driver.html?testName=audio-fft) 14:12:25 INFO - 2015-11-23 14:12:25,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 150482944 14:12:25 INFO - 2015-11-23 14:12:25,254 DEBUG : BROWSER_OUTPUT: 14:12:27 INFO - 2015-11-23 14:12:27,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42720/tests/kraken/driver.html?testName=audio-oscillator) 14:12:27 INFO - 2015-11-23 14:12:27,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 153657344 14:12:27 INFO - 2015-11-23 14:12:27,808 DEBUG : BROWSER_OUTPUT: 14:12:29 INFO - 2015-11-23 14:12:29,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42720/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:12:30 INFO - 2015-11-23 14:12:30,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 156020736 14:12:30 INFO - 2015-11-23 14:12:30,543 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2015-11-23 14:12:33,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42720/tests/kraken/driver.html?testName=imaging-darkroom) 14:12:33 INFO - 2015-11-23 14:12:33,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 156524544 14:12:33 INFO - 2015-11-23 14:12:33,994 DEBUG : BROWSER_OUTPUT: 14:12:37 INFO - 2015-11-23 14:12:37,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42720/tests/kraken/driver.html?testName=imaging-desaturate) 14:12:37 INFO - 2015-11-23 14:12:37,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 157937664 14:12:37 INFO - 2015-11-23 14:12:37,933 DEBUG : BROWSER_OUTPUT: 14:12:40 INFO - 2015-11-23 14:12:40,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42720/tests/kraken/driver.html?testName=json-parse-financial) 14:12:41 INFO - 2015-11-23 14:12:41,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 156200960 14:12:41 INFO - 2015-11-23 14:12:41,245 DEBUG : BROWSER_OUTPUT: 14:12:42 INFO - 2015-11-23 14:12:42,806 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42720/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:12:43 INFO - 2015-11-23 14:12:43,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 166805504 14:12:43 INFO - 2015-11-23 14:12:43,368 DEBUG : BROWSER_OUTPUT: 14:12:45 INFO - 2015-11-23 14:12:45,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:12:45 INFO - 2015-11-23 14:12:45,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 166199296 14:12:45 INFO - 2015-11-23 14:12:45,792 DEBUG : BROWSER_OUTPUT: 14:12:47 INFO - 2015-11-23 14:12:47,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:12:48 INFO - 2015-11-23 14:12:48,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 172748800 14:12:48 INFO - 2015-11-23 14:12:48,398 DEBUG : BROWSER_OUTPUT: 14:12:50 INFO - 2015-11-23 14:12:50,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:12:51 INFO - 2015-11-23 14:12:51,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 182259712 14:12:51 INFO - 2015-11-23 14:12:51,360 DEBUG : BROWSER_OUTPUT: 14:12:53 INFO - 2015-11-23 14:12:53,907 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:12:54 INFO - 2015-11-23 14:12:54,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 179150848 14:12:54 INFO - 2015-11-23 14:12:54,481 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42720/tests/kraken/driver.html?testName=ai-astar) 14:12:56 INFO - 2015-11-23 14:12:56,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 238882816 14:12:56 INFO - 2015-11-23 14:12:56,377 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,378 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:12:56 INFO - 2015-11-23 14:12:56,380 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:12:56 INFO - 2015-11-23 14:12:56,380 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:12:56 INFO - 2015-11-23 14:12:56,380 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:12:56 INFO - 2015-11-23 14:12:56,380 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;108;105;109;110;112;97;108;108;97 14:12:56 INFO - 2015-11-23 14:12:56,380 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;124;158;164;130;148;149;125;168;123 14:12:56 INFO - 2015-11-23 14:12:56,380 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;162;164;160;160;162;161;163 14:12:56 INFO - 2015-11-23 14:12:56,380 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;85;91;72;71;72;122;96;74 14:12:56 INFO - 2015-11-23 14:12:56,381 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;136;93;94;93;136;94;93;138 14:12:56 INFO - 2015-11-23 14:12:56,381 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;110;109;109;109;109;109 14:12:56 INFO - 2015-11-23 14:12:56,381 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;145;145;145;145;145;145;145 14:12:56 INFO - 2015-11-23 14:12:56,381 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;95;96;95;95;96;95 14:12:56 INFO - 2015-11-23 14:12:56,381 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;62;58;59;58;58;59;60;63;57 14:12:56 INFO - 2015-11-23 14:12:56,381 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;67;68;68;67;68;69 14:12:56 INFO - 2015-11-23 14:12:56,381 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;85;83;84;93;84;85;84;84 14:12:56 INFO - 2015-11-23 14:12:56,381 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;131;123;110;124;113;124;120;117;122 14:12:56 INFO - 2015-11-23 14:12:56,382 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;149;148;146;149;149;152;148;147;138 14:12:56 INFO - 2015-11-23 14:12:56,382 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;66;67;65;67;65;65;65;65 14:12:56 INFO - 2015-11-23 14:12:56,382 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:12:56 INFO - 2015-11-23 14:12:56,382 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:12:56 INFO - 2015-11-23 14:12:56,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,905 14:12:56 INFO - 2015-11-23 14:12:56,382 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:12:56 INFO - 2015-11-23 14:12:56,382 DEBUG : BROWSER_OUTPUT: __startTimestamp1448316776378__endTimestamp 14:12:56 INFO - 2015-11-23 14:12:56,383 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,386 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:12:56 INFO - 2015-11-23 14:12:56,386 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:12:56 INFO - 2015-11-23 14:12:56,386 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,387 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.30 Median:109.50 stddev:5.21 (4.8%) stddev-sans-first:5.43 14:12:56 INFO - 2015-11-23 14:12:56,387 DEBUG : BROWSER_OUTPUT: Values: 109.0 108.0 105.0 109.0 110.0 112.0 97.0 108.0 108.0 97.0 14:12:56 INFO - 2015-11-23 14:12:56,387 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,387 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.90 Median:149.50 stddev:17.15 (11.5%) stddev-sans-first:18.05 14:12:56 INFO - 2015-11-23 14:12:56,387 DEBUG : BROWSER_OUTPUT: Values: 150.0 124.0 158.0 164.0 130.0 148.0 149.0 125.0 168.0 123.0 14:12:56 INFO - 2015-11-23 14:12:56,388 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,388 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 14:12:56 INFO - 2015-11-23 14:12:56,388 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 162.0 164.0 160.0 160.0 162.0 161.0 163.0 14:12:56 INFO - 2015-11-23 14:12:56,388 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,388 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.70 Median:73.00 stddev:16.55 (22.7%) stddev-sans-first:17.10 14:12:56 INFO - 2015-11-23 14:12:56,388 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 85.0 91.0 72.0 71.0 72.0 122.0 96.0 74.0 14:12:56 INFO - 2015-11-23 14:12:56,388 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,388 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:93.00 stddev:21.04 (22.6%) stddev-sans-first:21.77 14:12:56 INFO - 2015-11-23 14:12:56,388 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 136.0 93.0 94.0 93.0 136.0 94.0 93.0 138.0 14:12:56 INFO - 2015-11-23 14:12:56,388 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,389 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:12:56 INFO - 2015-11-23 14:12:56,390 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 14:12:56 INFO - 2015-11-23 14:12:56,390 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,390 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 14:12:56 INFO - 2015-11-23 14:12:56,390 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 14:12:56 INFO - 2015-11-23 14:12:56,390 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,390 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:12:56 INFO - 2015-11-23 14:12:56,390 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 14:12:56 INFO - 2015-11-23 14:12:56,390 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,390 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.00 stddev:1.93 (3.3%) stddev-sans-first:2.00 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: Values: 58.0 62.0 58.0 59.0 58.0 58.0 59.0 60.0 63.0 57.0 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 67.0 68.0 68.0 67.0 68.0 69.0 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:3.17 (3.8%) stddev-sans-first:3.08 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 85.0 83.0 84.0 93.0 84.0 85.0 84.0 84.0 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:122.50 stddev:6.15 (5.0%) stddev-sans-first:6.35 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: Values: 116.0 131.0 123.0 110.0 124.0 113.0 124.0 120.0 117.0 122.0 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:148.50 stddev:4.90 (3.3%) stddev-sans-first:3.87 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: Values: 137.0 149.0 148.0 146.0 149.0 149.0 152.0 148.0 147.0 138.0 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 14:12:56 INFO - 2015-11-23 14:12:56,391 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 66.0 67.0 65.0 67.0 65.0 65.0 65.0 65.0 14:12:56 INFO - 2015-11-23 14:12:56,392 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:12:56 INFO - 2015-11-23 14:12:56,392 DEBUG : BROWSER_OUTPUT: 14:12:57 INFO - 2015-11-23 14:12:57,479 INFO : Browser exited with error code: 0 14:12:57 INFO - 2015-11-23 14:12:57,533 INFO : Completed test kraken (00:01:00) 14:12:57 INFO - 2015-11-23 14:12:57,533 INFO : Starting test v8_7 14:12:57 INFO - 2015-11-23 14:12:57,533 DEBUG : operating with platform_type : linux_ 14:12:57 INFO - 2015-11-23 14:12:57,533 INFO : Initialising browser for v8_7 test... 14:12:57 INFO - 2015-11-23 14:12:57,540 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpySmJ0w/profile http://localhost:42720/getInfo.html 14:13:02 INFO - 2015-11-23 14:13:02,065 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:13:02 INFO - 2015-11-23 14:13:02,065 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:13:02 INFO - 2015-11-23 14:13:02,065 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:13:02 INFO - 2015-11-23 14:13:02,065 DEBUG : BROWSER_OUTPUT: __metrics 14:13:02 INFO - 2015-11-23 14:13:02,208 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:13:03 INFO - 2015-11-23 14:13:03,759 INFO : Browser initialized. 14:13:03 INFO - 2015-11-23 14:13:03,760 INFO : Running cycle 1/1 for v8_7 test... 14:13:03 INFO - 2015-11-23 14:13:03,760 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpySmJ0w/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:13:15 INFO - 2015-11-23 14:13:15,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 140107776 14:13:15 INFO - 2015-11-23 14:13:15,464 DEBUG : BROWSER_OUTPUT: 14:13:36 INFO - 2015-11-23 14:13:36,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42720/tests/v8_7/run.html (next: http://localhost:42720/tests/v8_7/run.html) 14:13:37 INFO - 2015-11-23 14:13:37,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 626864128 14:13:37 INFO - 2015-11-23 14:13:37,140 DEBUG : BROWSER_OUTPUT: 14:13:37 INFO - 2015-11-23 14:13:37,141 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:13:37 INFO - 2015-11-23 14:13:37,141 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:13:37 INFO - 2015-11-23 14:13:37,141 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:13:37 INFO - 2015-11-23 14:13:37,142 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:13:37 INFO - 2015-11-23 14:13:37,142 DEBUG : BROWSER_OUTPUT: |0;Richards;184.9112426035503 14:13:37 INFO - 2015-11-23 14:13:37,142 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.64365214110546 14:13:37 INFO - 2015-11-23 14:13:37,142 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.214848143982 14:13:37 INFO - 2015-11-23 14:13:37,142 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5015 14:13:37 INFO - 2015-11-23 14:13:37,142 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1101.3215859030836 14:13:37 INFO - 2015-11-23 14:13:37,142 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 14:13:37 INFO - 2015-11-23 14:13:37,142 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 14:13:37 INFO - 2015-11-23 14:13:37,143 DEBUG : BROWSER_OUTPUT: |7;RegExp;25692.30769230769 14:13:37 INFO - 2015-11-23 14:13:37,143 DEBUG : BROWSER_OUTPUT: |8;Splay;669.4750486066105 14:13:37 INFO - 2015-11-23 14:13:37,143 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 14:13:37 INFO - 2015-11-23 14:13:37,143 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:13:37 INFO - 2015-11-23 14:13:37,143 DEBUG : BROWSER_OUTPUT: __startTimestamp1448316817140__endTimestamp 14:13:37 INFO - 2015-11-23 14:13:37,144 DEBUG : BROWSER_OUTPUT: 14:13:37 INFO - 2015-11-23 14:13:37,144 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:13:37 INFO - 2015-11-23 14:13:37,144 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:13:37 INFO - 2015-11-23 14:13:37,144 DEBUG : BROWSER_OUTPUT: 14:13:37 INFO - 2015-11-23 14:13:37,144 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:184.91 Median:184.91 stddev:0.00 (0.0%) 14:13:37 INFO - 2015-11-23 14:13:37,144 DEBUG : BROWSER_OUTPUT: Values: 184.9 14:13:37 INFO - 2015-11-23 14:13:37,145 DEBUG : BROWSER_OUTPUT: 14:13:37 INFO - 2015-11-23 14:13:37,146 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.64 Median:188.64 stddev:0.00 (0.0%) 14:13:37 INFO - 2015-11-23 14:13:37,146 DEBUG : BROWSER_OUTPUT: Values: 188.6 14:13:37 INFO - 2015-11-23 14:13:37,146 DEBUG : BROWSER_OUTPUT: 14:13:37 INFO - 2015-11-23 14:13:37,146 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.21 Median:281.21 stddev:0.00 (0.0%) 14:13:37 INFO - 2015-11-23 14:13:37,146 DEBUG : BROWSER_OUTPUT: Values: 281.2 14:13:37 INFO - 2015-11-23 14:13:37,147 DEBUG : BROWSER_OUTPUT: 14:13:37 INFO - 2015-11-23 14:13:37,147 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5015.00 Median:5015.00 stddev:0.00 (0.0%) 14:13:37 INFO - 2015-11-23 14:13:37,147 DEBUG : BROWSER_OUTPUT: Values: 5015.0 14:13:37 INFO - 2015-11-23 14:13:37,147 DEBUG : BROWSER_OUTPUT: 14:13:37 INFO - 2015-11-23 14:13:37,147 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1101.32 Median:1101.32 stddev:0.00 (0.0%) 14:13:37 INFO - 2015-11-23 14:13:37,147 DEBUG : BROWSER_OUTPUT: Values: 1101.3 14:13:37 INFO - 2015-11-23 14:13:37,147 DEBUG : BROWSER_OUTPUT: 14:13:37 INFO - 2015-11-23 14:13:37,148 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 14:13:37 INFO - 2015-11-23 14:13:37,148 DEBUG : BROWSER_OUTPUT: Values: 784.3 14:13:37 INFO - 2015-11-23 14:13:37,148 DEBUG : BROWSER_OUTPUT: 14:13:37 INFO - 2015-11-23 14:13:37,148 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 14:13:37 INFO - 2015-11-23 14:13:37,148 DEBUG : BROWSER_OUTPUT: Values: 12231.7 14:13:37 INFO - 2015-11-23 14:13:37,148 DEBUG : BROWSER_OUTPUT: 14:13:37 INFO - 2015-11-23 14:13:37,148 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25692.31 Median:25692.31 stddev:0.00 (0.0%) 14:13:37 INFO - 2015-11-23 14:13:37,148 DEBUG : BROWSER_OUTPUT: Values: 25692.3 14:13:37 INFO - 2015-11-23 14:13:37,149 DEBUG : BROWSER_OUTPUT: 14:13:37 INFO - 2015-11-23 14:13:37,149 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:669.48 Median:669.48 stddev:0.00 (0.0%) 14:13:37 INFO - 2015-11-23 14:13:37,149 DEBUG : BROWSER_OUTPUT: Values: 669.5 14:13:37 INFO - 2015-11-23 14:13:37,149 DEBUG : BROWSER_OUTPUT: 14:13:37 INFO - 2015-11-23 14:13:37,149 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 14:13:37 INFO - 2015-11-23 14:13:37,149 DEBUG : BROWSER_OUTPUT: Values: 4822.1 14:13:37 INFO - 2015-11-23 14:13:37,149 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:13:37 INFO - 2015-11-23 14:13:37,150 DEBUG : BROWSER_OUTPUT: 14:13:38 INFO - 2015-11-23 14:13:38,051 INFO : Browser exited with error code: 0 14:13:38 INFO - 2015-11-23 14:13:38,066 INFO : Completed test v8_7 (00:00:40) 14:13:38 INFO - 2015-11-23 14:13:38,133 INFO : Completed test suite (00:20:20) 14:13:38 INFO - 2015-11-23 14:13:38,134 DEBUG : Working with test: dromaeo_css 14:13:38 INFO - 2015-11-23 14:13:38,134 DEBUG : Generating results file: dromaeo_css 14:13:38 INFO - 2015-11-23 14:13:38,135 DEBUG : Working with test: kraken 14:13:38 INFO - 2015-11-23 14:13:38,135 DEBUG : Generating results file: kraken 14:13:38 INFO - 2015-11-23 14:13:38,135 INFO : javascript benchmark 14:13:38 INFO - 2015-11-23 14:13:38,135 DEBUG : Working with test: v8_7 14:13:38 INFO - 2015-11-23 14:13:38,136 DEBUG : Generating results file: v8_7 14:13:38 INFO - 2015-11-23 14:13:38,136 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:13:38 INFO - 2015-11-23 14:13:38,185 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 14:13:38 INFO - 2015-11-23 14:13:38,186 DEBUG : process_Request line: dromaeo_css 6989.61 graph.html#tests=[[72,201,35]] 14:13:38 INFO - 2015-11-23 14:13:38,186 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:13:38 INFO - 2015-11-23 14:13:38,215 DEBUG : process_Request line: kraken 1494.50 graph.html#tests=[[232,201,35]] 14:13:38 INFO - 2015-11-23 14:13:38,215 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:13:38 INFO - 2015-11-23 14:13:38,246 DEBUG : process_Request line: v8_7 20701.24 graph.html#tests=[[230,201,35]] 14:13:38 INFO - 2015-11-23 14:13:38,248 INFO : javascript benchmark 14:13:38 INFO - 2015-11-23 14:13:38,251 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3216.614006319242, 3248.382807266618, 3295.6704329567046, 3304.1574398528387, 3322.385358708639, 5329.333833270841, 5438.129899216126, 5466.125419932811, 5491.670499770016, 5504.504594586487, 5379.058664733666, 5494.642848214873, 5497.725113744316, 5581.7209139543065, 5590.245316882219, 4972.080165169437, 4976.626752993522, 5004.599632029447, 5056.241563765428, 5095.108356037697, 4833.226683730604, 5037.949620503803, 5060.6963582185, 5092.312537807404, 5105.3873535175835, 4855.417349918032, 4938.950610493885, 4952.306677065214, 4964.131277026506, 5010.7995680172935, 5000.299958005882, 5009.874753131165, 5016.8996620067755, 5026.47222041684, 5066.569341605968, 4953.083679519301, 4984.27727979441, 5000.474950130257, 5014.047331007097, 5071.7210553419545, 5122.897542049175, 5228.398734145584, 5228.581713462914, 5340.759665815048, 5356.785728570852, 5937.495312898409, 5946.137810017566, 5959.970200149015, 5963.493103086243, 5986.132010858401, 5983.521318294526, 5997.5501837361935, 6000.669963152025, 6017.729202185868, 6038.57729958903, 5435.456454354572, 5471.972640136773, 5559.527440167591, 5569.498745112919, 5590.245316882209, 6054.848628784315, 6073.301570319381, 6094.238220222473, 6113.266408030976, 6114.2357205349335, 5816.41835816415, 5825.970870145622, 5861.912071318849, 5879.882402352015, 5896.761859242364, 5688.658680479184, 5796.536277097906, 5805.88388232233, 5843.678597677083, 6022.5483088768515, 5873.4126587340925, 5945.672987985702, 5950.583459157818, 5960.0761881908375, 5972.193753843176, 5934.347221805598, 5943.049112142036, 5949.732262048218, 5951.4048595141, 5955.225820643289, 4412.514623391425, 4469.9553004469535, 4498.167838949805, 4555.931661025087, 4558.635309175258, 4043.433919251307, 4055.330870406409, 4059.0313946939837, 4074.2258970795456, 4081.7959102045374, 5546.278983732089, 5555.3333599967455, 5611.3266408031295, 5623.803166889139, 5626.240457538262, 5689.004424225744, 5773.797917072882, 5774.711264436762, 5876.294844618673, 5892.970535147382, 5455.890882182334, 5546.91679624806, 5549.6115271931385, 5560.471755183251, 5605.355384130796, 5160.354955630546, 5166.844994650167, 5173.991071741049, 5175.767090480862, 5224.425313215544, 5942.227510423617, 6057.4851137653795, 6057.515398768088, 6191.25704915413, 6193.287771906288, 5831.183634291117, 5884.146798714248, 5892.234009578728, 5895.174675545512, 5901.350851406256, 5969.224000879858, 6158.414950579688, 6182.474489668429, 6196.938030619816, 6217.160683307877, 5612.186232996274, 5801.071828507587, 5804.796832110856, 5853.560982926212, 5878.0, 5827.358990510956, 5966.224390829165, 5980.37206093354, 5984.281886173687, 6036.8188954331445, 5766.971165144148, 5767.567432442667, 5768.307803063659, 5768.625039372428, 5773.191753154478, 5607.5513958882375, 5699.0311647020935, 5723.484886360247, 5764.942350576441, 5768.365479797303, 5521.503064724194, 5592.356878958972, 5605.075162598126, 5609.579281553818, 5647.407022262603, 5799.391063938226, 5826.621269617631, 5846.736896839568, 5854.765809367748, 5859.824205273849, 5475.589330800126, 5590.748416321357, 5602.747876345656, 5660.320761508646, 5721.22763426932], "unit": "ms", "name": "dojo.html", "value": 5436.149795232669}, {"lowerIsBetter": false, "replicates": [585.9560532960028, 593.3413910559279, 593.5963544789544, 602.8432607522043, 618.193257798573, 31413.214669633242, 40147.99630009251, 40845.59154408455, 40900.38649420254, 40919.38620920685, 43560.56439435605, 43658.781706091504, 43760.562394376044, 44079.0, 44112.77943610286, 7621.923780762177, 7764.262395072459, 8655.653773849053, 8777.2100510954, 8803.911960880405, 10341.276110672256, 10613.257072004963, 10621.044106030457, 10625.20310976676, 10629.36223826569, 10251.84622230667, 10287.331323463988, 10291.742706432324, 10400.21998350123, 10419.166466682685, 7822.608869556528, 7989.96005019977, 10342.586296548128, 10501.789964200672, 10690.839637405445, 10137.695869123938, 10257.743556411075, 10274.537645805956, 10274.537645805956, 10281.691549253534, 41047.794761026, 41058.1788364231, 41363.37954930678, 41416.378754318706, 41554.37668434976, 3148.8740450381956, 3191.5372271020574, 3202.295494991098, 3239.562659041023, 3601.621829707869, 30603.69396306031, 31233.0, 31255.531167032514, 31263.0, 31302.686973130203, 3539.185987222953, 3804.1630841214887, 3805.980970095132, 3876.205377897524, 3972.324704800191, 269263.0, 270388.96110389003, 271099.0, 271267.0, 272383.0, 56810.0, 59976.40023599796, 60279.0, 60368.69815650894, 60369.0, 52184.82521398279, 67871.32128678748, 69178.65410673014, 69642.0, 69795.0, 15709.921450392674, 16108.597285067966, 16133.677326453406, 16141.03153810775, 16148.434804781777, 11357.20499565039, 11530.250533715282, 11542.769144617061, 11549.36478493691, 11553.364564949008, 19441.319553815832, 19610.21559137647, 19617.411477655693, 19621.60756784856, 19691.60616787656, 7712.575808330484, 7930.206979302139, 8064.314533264621, 8084.636191371284, 8104.432689711663, 938.6010945348336, 953.609020301673, 1028.9588416463257, 1048.627737153315, 1078.6332646900091, 28793.568096478568, 29058.82058845595, 29176.416471670447, 29234.415311694072, 29317.706822931497, 978.6917121106828, 1006.3911333643186, 1027.085893554737, 1028.5577201803296, 1031.8194315994672, 13967.580972570839, 13967.650808729863, 14407.135571865721, 14410.135391876522, 14694.706105878036, 319279.0, 322851.0, 324361.0, 324490.0, 325411.0, 51728.22407663888, 52470.737646312286, 53407.46592534103, 53541.0, 53563.73218133963, 1311.672081979505, 1336.7527007503643, 1339.5512503311304, 1346.7912473566612, 1353.6751179716798, 25808.354791130372, 26806.0, 28021.0, 28861.27846803847, 29646.851765741034, 44452.777736111115, 44548.0, 44644.0, 44844.10311793681, 44849.327260090475, 267370.0, 268279.0, 269053.0, 269481.0, 270198.0, 28268.575971360857, 28440.715592843808, 28534.57198142071, 33000.504992424656, 33105.83447082749, 38806.80596597112, 39019.2196156081, 39042.609573903894, 39934.800325998185, 40218.19563608653, 33418.665813341555, 33471.330573388885, 33559.66440335663, 33760.49359259564, 33890.49164262489, 28885.42229155447, 33437.665623343455, 34058.14854628654, 34112.65887341194, 34346.0, 33075.66924330726, 33354.4996825043, 33598.3280334387, 33755.15612109717, 33874.0, 29617.111486655434, 30880.0, 30973.91591294294, 31001.8449907749, 31011.0, 23237.65143522815, 23860.403489912893, 24092.92586868779, 24866.751332486445, 25059.0], "unit": "ms", "name": "ext.html", "value": 18569.983018791787}, {"lowerIsBetter": false, "replicates": [357.5869870299804, 359.3782755832409, 361.20534823388533, 361.30989809463927, 362.994555081674, 14176.50382236622, 14251.572452826405, 16725.163741812907, 17699.734503982436, 18789.718154227696, 10826.1880358973, 11107.278026928245, 17155.828441715577, 17612.911935440337, 17750.289988400447, 4763.952360476385, 4884.780184891671, 4892.094962431944, 4892.266160075999, 4914.4839791821705, 3696.519452471175, 3777.112378591029, 4881.463039065718, 4922.950770492303, 5195.0, 5268.367795864482, 5288.92066619001, 5329.067413202693, 5341.359036915575, 5349.5720342372515, 5101.056304583645, 5240.0, 5245.370555533361, 5309.787608495655, 5313.654612450197, 4969.981153863449, 5080.13637681595, 5082.08522465956, 5086.949130508721, 5228.320318358589, 11916.702082447922, 12028.0, 12083.516659333616, 12162.331071791048, 18113.54716132094, 1989.4131231286806, 2006.8695534790193, 2062.7730949595534, 2072.2229164063474, 2179.6294629912954, 9355.251579873593, 9453.149216570473, 9471.573779179884, 9591.952040239754, 10331.0, 1648.7856578644698, 1694.3561446650317, 1823.4073925973978, 1842.0697547738441, 1888.4617883903022, 58865.41134588685, 62567.687161564354, 62786.05820912735, 62861.0, 63278.36721632771, 9935.552900119368, 10193.490325483695, 10363.844542331872, 10371.896281037243, 10406.895931040744, 13726.107802992774, 13731.313434328244, 13742.725145497034, 13754.862451375559, 13761.931190344185, 7137.4290056795335, 7161.355478007004, 7197.028401165776, 7716.186696126406, 7864.72473463426, 6600.339966003361, 6994.895076573754, 7181.928180718231, 7244.855102897913, 7246.1666908306215, 4287.892802679896, 4394.428724265825, 4417.8232870684815, 4496.39298694672, 4505.639548836085, 1705.914704264782, 1725.0943254791334, 1764.1267572551412, 1794.228481752859, 1847.0856925821804, 819.4714409206028, 930.7347405989397, 936.5457752989795, 973.5667627905514, 973.8247115519133, 16396.344146234016, 16449.424270150488, 17017.659646806995, 17378.65242695139, 17452.825471745375, 808.983820323602, 850.2305413600701, 870.3863776037878, 874.8906386701663, 881.7839629290864, 9333.579988900516, 9725.124738773544, 9732.270079743907, 9751.073648003428, 9806.31355805101, 513012.0, 522463.0, 534790.0, 535325.0, 538075.0, 78490.0, 78883.60558197173, 80331.99999999884, 82903.17096829075, 83083.5845820779, 1128.542940109257, 1143.8455808465917, 1154.4574050196395, 1154.6189757380212, 1155.3356819828632, 15487.53537393835, 15621.062736235863, 15821.129837859029, 15885.2851621675, 15933.521994340188, 34315.313693726486, 34479.13802154866, 34621.307573848884, 35405.46891796677, 35544.0, 45844.0, 46360.53639463697, 46974.29538556856, 47669.52330476651, 48905.266421004424, 9376.437413755197, 9554.570044347882, 9592.184664303611, 9681.0, 9683.806323873343, 14799.852001479847, 17379.304827806747, 17679.204435800162, 17842.55393615118, 17863.821361786217, 14500.202488863213, 14813.555593332218, 14851.257437128317, 14960.251987400805, 14993.2503374833, 13249.0, 14026.158430494203, 14421.42314307416, 14657.413703452168, 15018.0, 11488.597899073493, 14122.293885305899, 14386.856131438552, 14654.487092951695, 14713.411463541339, 9108.132832769134, 9177.632894684139, 9196.218321442751, 9274.721758347261, 9453.0, 13854.792178117135, 13911.652208694864, 13920.443182273, 13986.0, 14101.083429577046], "unit": "ms", "name": "jquery.html", "value": 8616.68268322397}, {"lowerIsBetter": false, "replicates": [1328.5748560460656, 1706.1042952449964, 1715.7083295839707, 1774.2104763380296, 1779.6974514332562, 6805.625690587022, 7314.670839812208, 7558.055243094614, 7579.052618422697, 7582.507137036103, 7492.550446973185, 7730.536167829934, 7731.11092224393, 7732.072151341833, 7747.845043099134, 1988.4929343017511, 2008.2469074097214, 2011.5172358633895, 2213.2917466410713, 2245.517213799033, 2029.1984666056899, 2208.2712704807454, 2231.7656646052174, 2232.955340893181, 2233.765454627265, 2146.4633841539617, 2168.251953076186, 2174.9021294041727, 2211.369759618509, 2211.900464479102, 1963.2834015584208, 2003.0485519378324, 2249.8875056247202, 2276.738175109867, 2277.7038984931937, 1907.1799126375654, 1918.8464922806143, 1920.3278852401688, 2237.485378362969, 2271.250487339174, 7704.036995375578, 7828.647710853025, 7857.528548287064, 7860.882086768645, 7866.331361834251, 4679.789409476582, 4704.364910737041, 4733.763311834429, 4756.643251756098, 4757.0, 2958.082994271783, 2987.760979121665, 3013.4274487847238, 3024.2741741981986, 3045.4974929136665, 901.7384958362068, 919.3334832246635, 922.2161163011453, 934.6588495199203, 944.655200851691, 10657.253992220547, 10659.0, 10681.679549613524, 10697.83953240702, 10714.196435267308, 4141.088960428701, 4226.34491653788, 4234.597713217239, 4252.87241382759, 4290.184864875726, 9267.351285410092, 9282.535873206312, 9289.674861379819, 9295.72112836616, 9299.302552308603, 4765.213739732905, 4783.067301876101, 4784.712917224978, 4795.568398844051, 4795.95204047962, 4355.346697995263, 4371.890702732457, 4376.124775045004, 4376.737395756265, 4393.802278897393, 3708.7589306694977, 3748.4377343398164, 3749.2876353492748, 3771.641694039062, 3778.3954567269657, 1193.8686744458103, 1194.988050119505, 1198.9340586267665, 1223.406647775828, 1229.858566264891, 1029.4749677664445, 1041.656253436364, 1048.444324508012, 1199.5681554640323, 1364.6861221919014, 7415.147258065392, 7461.36578390832, 7475.289847464483, 7478.551286922802, 7556.65995030214, 1095.780843831237, 1117.1118960426481, 1132.4054871192525, 1147.862256529205, 1156.5142640091183, 5476.507114359727, 5542.722863856791, 5898.793542226002, 5963.910541341883, 5964.254468191476, 9071.682491112779, 9242.21441177494, 9290.256779457763, 9316.720498385059, 9372.203362714246, 9128.497932613636, 9234.722958311262, 9239.029901860207, 9372.5313734313, 9381.812363752686, 7143.571385716769, 7206.126407134183, 7233.819154521074, 7243.311885370881, 7249.166345870187, 7009.158900931717, 7225.24134965821, 7248.637568121679, 7382.926170738224, 7390.741324053847, 8180.0, 8200.753977380688, 8255.25702686761, 8312.5428101455, 8439.282660973886, 8339.749807505785, 8519.977602687717, 8533.189347012023, 8533.74398768038, 8535.658573657232, 6997.930020699931, 7075.82310442243, 7078.8938165928585, 7093.32613401726, 7097.858042839011, 7422.703091876265, 7458.552486850806, 7567.735129270449, 7570.318671319607, 7583.734569290048, 6859.0, 6930.826729331807, 6931.618760968196, 6986.930130698831, 7029.859402811813, 6926.515143939876, 6972.198197207386, 6986.650667466708, 7107.822304442224, 7116.181639111568, 7067.82330441743, 7117.217106118426, 7134.607596582237, 7136.179339375831, 7146.785596432115, 6375.330590287953, 6400.135981642605, 6404.359564043744, 6404.71178796946, 6574.868502630016, 6623.470122390101, 6657.866842663023, 6667.699953502201, 6675.8664826702225, 6698.162729658793], "unit": "ms", "name": "mootools.html", "value": 4459.030550804536}, {"lowerIsBetter": false, "replicates": [328.2974434709721, 330.5355974855328, 331.842374871936, 333.1105947121186, 340.18186262039774, 5901.852453688649, 6003.309619393765, 6090.969545152279, 6101.054336577838, 6133.141360209569, 5752.5110365618975, 5947.4052594740615, 5985.790497332594, 5994.040953447449, 5996.2504686914135, 4610.631149508032, 4611.700239484439, 4615.538446155383, 4616.8614941551805, 4618.722876627413, 4380.912381752363, 4440.067585806984, 4526.841560545382, 4618.330342100394, 4650.116477869211, 4565.977170114162, 4583.656225783063, 4585.358049873003, 4602.838900638479, 4607.792649330771, 4588.701734387288, 4601.4248218972625, 4613.7001094929055, 4616.792244348995, 4619.976900115478, 4048.595140485928, 4053.4730485036757, 4059.0867054912705, 4059.878203653895, 4074.0, 5588.497035266845, 5658.886822263573, 5679.318481782171, 5679.687617181054, 5687.687177205252, 5358.410574836765, 5360.731963401814, 5370.462953704638, 5374.220737992969, 5375.9840059977505, 6014.2181516403025, 6362.459190968773, 6366.236051673783, 6369.0, 6371.0, 4331.350297455376, 4354.912901741979, 4432.756198409086, 4437.955620443787, 4481.596656300916, 6574.704138313788, 6581.80254592363, 6588.242352129519, 6588.374104460068, 6607.471402287805, 4582.495925448198, 4587.128445595326, 4588.036512332447, 4590.403247577793, 4593.540645935446, 4413.0, 4547.454305483363, 4558.475775285819, 4623.56076172763, 4653.0, 5284.0, 5288.65623734456, 5289.841304760864, 5292.5236728693835, 5294.867628309323, 6428.614283143026, 6430.324815894357, 6446.419822216023, 6455.774047908395, 6458.644774537352, 1585.7938467999086, 1609.2195285286627, 1609.5654173373123, 1610.846969537892, 1611.6373815891566, 1060.4697651174413, 1061.135174832509, 1071.0467683761303, 1071.6088627650852, 1092.3500517192258, 6220.346863579259, 6222.222222222223, 6223.813285601439, 6230.345813689497, 6233.407826256498, 6581.3418658133805, 6585.078089067534, 6591.209054913441, 6592.505562082767, 6595.835104122435, 6071.483923866433, 6223.564350495512, 6225.8132256032395, 6230.501559875199, 6232.968835155795, 3548.875789347412, 3576.213233088716, 3578.7137029037613, 3582.802945837952, 3583.408737558326, 6825.658717064127, 6843.555168914005, 6856.897146542806, 6860.5540639858245, 6865.141857267841, 6648.7340506379205, 6763.898541521881, 6775.3902148805855, 6780.525363224626, 6782.525223234425, 6768.086308348408, 6768.120144381297, 6771.492138089663, 6780.186377634715, 6785.9321406786285, 6321.49428045746, 6498.480121590167, 6571.408573228432, 6594.835129121619, 6604.042413850061, 6586.604803711793, 6608.900866487103, 6613.636250006296, 6618.305077966744, 6637.535372523877, 6909.930900690929, 6916.896246556205, 6926.757563485254, 6927.0, 6929.792106236821, 4326.502452217909, 4460.1971645104195, 4492.079123779683, 4521.751303678329, 4529.524399937959, 6571.145751052332, 6571.901421478586, 6578.04618330349, 6578.276389597045, 6585.901211481927, 6395.104685343963, 6398.328175541501, 6403.29563747978, 6403.8719225614295, 6410.294867564471, 6213.37866213375, 6374.394432528902, 6404.679766011774, 6423.100765892872, 6472.676366181578, 6273.62358258506, 6293.181886354744, 6295.338989406229, 6300.621962682254, 6301.275353334242, 6448.5163612730175, 6496.577722448026, 6510.869782604416, 6512.967435162984, 6517.576357536745, 6140.785072522441, 6297.496200304056, 6305.527085468517, 6314.273858506331, 6369.649669268235], "unit": "ms", "name": "prototype.html", "value": 4817.885161868107}, {"lowerIsBetter": false, "replicates": [859.3297228162033, 859.3640705877652, 860.6901515454435, 871.27248747296, 875.816078623489, 12983.09118361715, 13264.801027984564, 13268.867311326896, 13294.601161965144, 13299.534516291931, 12610.936945315261, 12698.873011269885, 12701.872981270184, 12712.618621441348, 12723.554675586356, 657.4181849063577, 679.480197648799, 810.0320117459638, 824.4352618456346, 826.3595713322163, 810.0360570920615, 816.5794615772882, 817.6034623207739, 823.0493779684444, 823.7322870067222, 686.800827759949, 857.9571021448934, 862.810181760015, 863.5336918064238, 863.7063398444527, 697.6825544377297, 826.6280173921729, 834.5660256666561, 840.0465471689677, 841.7264389073514, 626.2797782550058, 626.3423405424331, 626.3861415812484, 626.5989766549412, 628.0453710360273, 13028.544000960015, 13149.276789776559, 13184.34078296091, 13211.603651890458, 13285.0, 12035.338056406894, 12488.188267762567, 12933.935330323382, 13047.739045219138, 13082.86917130826, 10377.377357358582, 10504.947475262576, 10513.316634418738, 10544.10375118116, 10632.936706329305, 3493.615702272748, 3508.438649816043, 3514.226870088602, 3613.060604242916, 3652.5069115669576, 48162.0, 48329.51670483285, 48496.0, 48558.51441485575, 48702.0, 9899.208063354914, 10130.645427410005, 10337.793244135075, 10409.115225205942, 10578.629747958785, 18992.90503547501, 19003.42989710311, 19047.42857714271, 19052.904735476233, 19078.427647170607, 7455.739049133254, 7507.737229196952, 7536.171021187665, 7537.886931696029, 7717.729879454305, 4344.587264209895, 4354.9782251088545, 4376.081022985145, 4386.561343865588, 4403.515613282536, 3006.5941097951495, 3036.089173248061, 3037.2862377341307, 3049.9847500762353, 3050.2984313607994, 506.52639781803396, 519.7764961066702, 531.3517508639453, 541.6641682157009, 543.1093007467678, 521.8669239344019, 582.9183914252009, 585.6749504025307, 665.2050799294797, 702.1574111066741, 7964.482308649919, 8132.349412047022, 8161.183881611792, 8177.9591102044105, 8280.130586288353, 487.45892059813576, 508.40557260170243, 533.7091285249548, 541.3125330829824, 559.4964531921304, 3624.1664417184197, 3723.72072094594, 3726.9440958385644, 3869.110104675884, 3952.7628342299554, 58570.41429585735, 58596.41403585995, 58657.120143197884, 58701.412985869596, 58761.0, 51789.48210517847, 52197.21704174441, 52574.0, 53364.0, 53402.99999999922, 47109.52890471051, 47190.76404617955, 47482.28776568354, 47552.99999999931, 47743.283850742264, 7616.7334143304715, 7672.961635192011, 7685.0, 7732.536047837148, 7808.492447990862, 35986.4602030975, 36372.45441318435, 36721.44917826288, 36808.26383472369, 37232.0, 45998.54001459943, 46192.0, 46333.768331159474, 46584.0, 46590.534094659975, 9363.344565880596, 9928.950355248178, 10370.585176592851, 10573.101286390744, 11009.61466348674, 11580.189386742848, 11768.882311177122, 11868.406579671155, 12406.875931240573, 12968.09223354356, 11162.665120046411, 11440.485178166837, 11450.484728187084, 11708.180427370002, 11937.164398492023, 11454.713632159262, 11606.30362178272, 11626.01178899803, 11907.642770716893, 12272.938635306766, 11285.774284514428, 11426.485808138488, 11506.252093614223, 11519.13606479534, 11869.821952670889, 9931.503424828585, 9934.304598678023, 10066.798664026532, 10113.0, 10609.257351985287, 8820.823583528421, 9238.353315267866, 9466.0, 9703.66037188695, 9816.509174541387], "unit": "ms", "name": "yui.html", "value": 6239.368530027028}], "name": "dromaeo_css", "value": 6989.612400317987}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 108.0, 105.0, 109.0, 110.0, 112.0, 97.0, 108.0, 108.0, 97.0], "unit": "ms", "name": "ai-astar", "value": 106.3}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 158.0, 164.0, 130.0, 148.0, 149.0, 125.0, 168.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.9}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 162.0, 164.0, 160.0, 160.0, 162.0, 161.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 85.0, 91.0, 72.0, 71.0, 72.0, 122.0, 96.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 82.7}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 136.0, 93.0, 94.0, 93.0, 136.0, 94.0, 93.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [58.0, 62.0, 58.0, 59.0, 58.0, 58.0, 59.0, 60.0, 63.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 67.0, 68.0, 68.0, 67.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 85.0, 83.0, 84.0, 93.0, 84.0, 85.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [116.0, 131.0, 123.0, 110.0, 124.0, 113.0, 124.0, 120.0, 117.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [137.0, 149.0, 148.0, 146.0, 149.0, 149.0, 152.0, 148.0, 147.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 67.0, 65.0, 67.0, 65.0, 65.0, 65.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1494.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [184.9112426035503], "unit": "score", "name": "Richards", "value": 190.91321599999995}, {"lowerIsBetter": false, "replicates": [188.64365214110546], "unit": "score", "name": "DeltaBlue", "value": 350.49151800000004}, {"lowerIsBetter": false, "replicates": [281.214848143982], "unit": "score", "name": "Encrypt", "value": 946.5396360000002}, {"lowerIsBetter": false, "replicates": [5015.0], "unit": "score", "name": "Decrypt", "value": 53.07696909272185}, {"lowerIsBetter": false, "replicates": [1101.3215859030836], "unit": "score", "name": "RayTrace", "value": 671.910012}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [25692.30769230769], "unit": "score", "name": "RegExp", "value": 35.4575}, {"lowerIsBetter": false, "replicates": [669.4750486066105], "unit": "score", "name": "Splay", "value": 121.72372991287514}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20701.236393036404}]} 14:13:38 INFO - RETURN: dromaeo_css: 6989.61 14:13:38 INFO - RETURN: kraken: 1494.50 14:13:38 INFO - RETURN: v8_7: 20701.24 14:13:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20701.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1494.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6989.61"}}} 14:13:38 INFO - Return code: 0 14:13:38 INFO - # TBPL SUCCESS # 14:13:38 INFO - Running post-action listener: _resource_record_post_action 14:13:38 INFO - Running post-run listener: _resource_record_post_run 14:13:39 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 24576; Write bytes: 505081856; Read time: 552; Write time: 1143904 14:13:39 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 126447616; Read time: 0; Write time: 233956 14:13:39 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 24576; Write bytes: 372862976; Read time: 552; Write time: 908484 14:13:39 INFO - Running post-run listener: _upload_blobber_files 14:13:39 INFO - Blob upload gear active. 14:13:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:13:39 INFO - Copying logs to upload dir... 14:13:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.998584 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-23 14:13:39.427000) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 14:13:39.430914) ========= 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=a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/73OLHImqSpyLC9gWSXaxng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010017 build_url: 'https://queue.taskcluster.net/v1/task/73OLHImqSpyLC9gWSXaxng/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-23 14:13:39.482106) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 14:13:39.482449) ========= 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=a194aa7faa1be204aaca7d660000020b-1448315547.992084-1952947219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 14:13:39.532135) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 14:13:39.532501) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 14:13:39.532838) ========= ========= Total master_lag: 0.52 =========