builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1447599050.14 results: success (0) buildid: 20151115043023 builduid: 839761d765c740a5b6e685e0d5757db4 revision: 22360424ed1532c73c93aab85bfd9173899956f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.144163) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.144678) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.145440) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007474 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.167372) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.167693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.181265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.181615) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004661 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.231066) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.231381) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.231760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.232040) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-15 06:50:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-11-15 06:50:50 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160836 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.405230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.405551) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017665 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.455162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.455515) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 22360424ed1532c73c93aab85bfd9173899956f8 --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/mozilla-inbound --rev 22360424ed1532c73c93aab85bfd9173899956f8 --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=d16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-15 06:50:50,662 truncating revision to first 12 chars 2015-11-15 06:50:50,662 Setting DEBUG logging. 2015-11-15 06:50:50,662 attempt 1/10 2015-11-15 06:50:50,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/22360424ed15?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 06:50:50,919 unpacking tar archive at: mozilla-inbound-22360424ed15/testing/mozharness/ program finished with exit code 0 elapsedTime=0.507274 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.975612) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.975927) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.985649) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.985943) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 06:50:50.986355) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-11-15 06:50:50.986644) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=d16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:50:51 INFO - MultiFileLogger online at 20151115 06:50:51 in /builds/slave/test-pgo 06:50:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 06:50:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:50:51 INFO - {'append_to_log': False, 06:50:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:50:51 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:50:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:50:51 INFO - 'branch': 'Mozilla-Inbound', 06:50:51 INFO - 'buildbot_json_path': 'buildprops.json', 06:50:51 INFO - 'config_files': ('talos/linux_config.py',), 06:50:51 INFO - 'default_actions': ('clobber', 06:50:51 INFO - 'read-buildbot-config', 06:50:51 INFO - 'download-and-extract', 06:50:51 INFO - 'populate-webroot', 06:50:51 INFO - 'create-virtualenv', 06:50:51 INFO - 'install', 06:50:51 INFO - 'run-tests'), 06:50:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:50:51 INFO - 'download_minidump_stackwalk': True, 06:50:51 INFO - 'download_symbols': 'ondemand', 06:50:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:50:51 INFO - 'tooltool.py': '/tools/tooltool.py', 06:50:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:50:51 INFO - '/tools/misc-python/virtualenv.py')}, 06:50:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:50:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:50:51 INFO - 'installer_path': 'installer.exe', 06:50:51 INFO - 'log_level': 'info', 06:50:51 INFO - 'log_name': 'talos', 06:50:51 INFO - 'log_to_console': True, 06:50:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:50:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:50:51 INFO - 'opt_config_files': (), 06:50:51 INFO - 'pip_index': False, 06:50:51 INFO - 'sps_profile': False, 06:50:51 INFO - 'sps_profile_interval': 0, 06:50:51 INFO - 'suite': 'dromaeojs-e10s', 06:50:51 INFO - 'system_bits': '64', 06:50:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:50:51 INFO - 'title': 'talos-linux64-ix-034', 06:50:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:50:51 INFO - 'use_talos_json': True, 06:50:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:50:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:50:51 INFO - 'work_dir': 'build'} 06:50:51 INFO - ##### 06:50:51 INFO - ##### Running clobber step. 06:50:51 INFO - ##### 06:50:51 INFO - Running pre-action listener: _resource_record_pre_action 06:50:51 INFO - Running main action method: clobber 06:50:51 INFO - rmtree: /builds/slave/test-pgo/build 06:50:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:50:51 INFO - Running post-action listener: _resource_record_post_action 06:50:51 INFO - ##### 06:50:51 INFO - ##### Running read-buildbot-config step. 06:50:51 INFO - ##### 06:50:51 INFO - Running pre-action listener: _resource_record_pre_action 06:50:51 INFO - Running main action method: read_buildbot_config 06:50:51 INFO - Using buildbot properties: 06:50:51 INFO - { 06:50:51 INFO - "properties": { 06:50:51 INFO - "buildnumber": 189, 06:50:51 INFO - "product": "firefox", 06:50:51 INFO - "script_repo_revision": "production", 06:50:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 06:50:51 INFO - "repository": "", 06:50:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 06:50:51 INFO - "buildid": "20151115043023", 06:50:51 INFO - "slavename": "talos-linux64-ix-034", 06:50:51 INFO - "pgo_build": "True", 06:50:51 INFO - "basedir": "/builds/slave/test-pgo", 06:50:51 INFO - "project": "", 06:50:51 INFO - "platform": "ubuntu64_hw", 06:50:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:50:51 INFO - "slavebuilddir": "test", 06:50:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 06:50:51 INFO - "branch": "mozilla-inbound", 06:50:51 INFO - "repo_path": "integration/mozilla-inbound", 06:50:51 INFO - "stage_platform": "linux64-pgo", 06:50:51 INFO - "builduid": "839761d765c740a5b6e685e0d5757db4", 06:50:51 INFO - "revision": "22360424ed1532c73c93aab85bfd9173899956f8" 06:50:51 INFO - }, 06:50:51 INFO - "sourcestamp": { 06:50:51 INFO - "repository": "", 06:50:51 INFO - "hasPatch": false, 06:50:51 INFO - "project": "", 06:50:51 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 06:50:51 INFO - "changes": [ 06:50:51 INFO - { 06:50:51 INFO - "category": null, 06:50:51 INFO - "files": [ 06:50:51 INFO - { 06:50:51 INFO - "url": null, 06:50:51 INFO - "name": "https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:50:51 INFO - } 06:50:51 INFO - ], 06:50:51 INFO - "repository": "", 06:50:51 INFO - "rev": "22360424ed1532c73c93aab85bfd9173899956f8", 06:50:51 INFO - "who": "sendchange", 06:50:51 INFO - "when": 1447598957, 06:50:51 INFO - "number": 6663512, 06:50:51 INFO - "comments": "", 06:50:51 INFO - "project": "", 06:50:51 INFO - "at": "Sun 15 Nov 2015 06:49:17", 06:50:51 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 06:50:51 INFO - "revlink": "", 06:50:51 INFO - "properties": [ 06:50:51 INFO - [ 06:50:51 INFO - "buildid", 06:50:51 INFO - "20151115043023", 06:50:51 INFO - "Change" 06:50:51 INFO - ], 06:50:51 INFO - [ 06:50:51 INFO - "builduid", 06:50:51 INFO - "839761d765c740a5b6e685e0d5757db4", 06:50:51 INFO - "Change" 06:50:51 INFO - ], 06:50:51 INFO - [ 06:50:51 INFO - "pgo_build", 06:50:51 INFO - "True", 06:50:51 INFO - "Change" 06:50:51 INFO - ] 06:50:51 INFO - ], 06:50:51 INFO - "revision": "22360424ed1532c73c93aab85bfd9173899956f8" 06:50:51 INFO - } 06:50:51 INFO - ], 06:50:51 INFO - "revision": "22360424ed1532c73c93aab85bfd9173899956f8" 06:50:51 INFO - } 06:50:51 INFO - } 06:50:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:50:51 INFO - Running post-action listener: _resource_record_post_action 06:50:51 INFO - ##### 06:50:51 INFO - ##### Running download-and-extract step. 06:50:51 INFO - ##### 06:50:51 INFO - Running pre-action listener: _resource_record_pre_action 06:50:51 INFO - Running main action method: download_and_extract 06:50:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:51 INFO - https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/test_packages.json 06:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/test_packages.json 06:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:50:54 INFO - Downloaded 1302 bytes. 06:50:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:50:54 INFO - Using the following test package requirements: 06:50:54 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:54 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:50:54 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:54 INFO - u'jsshell-linux-x86_64.zip'], 06:50:54 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:50:54 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:54 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:50:54 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:50:54 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:50:54 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:54 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:50:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:54 INFO - https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:50:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:50:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:50:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:51:02 INFO - Downloaded 22462035 bytes. 06:51:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:51:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:51:03 INFO - Return code: 0 06:51:03 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:03 INFO - https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:51:04 INFO - Downloaded 22462035 bytes. 06:51:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:51:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:51:05 INFO - Return code: 0 06:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:05 INFO - https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:51:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:51:06 INFO - Downloaded 11131693 bytes. 06:51:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 06:51:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:51:06 INFO - Return code: 0 06:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:06 INFO - https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:51:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:51:08 INFO - Downloaded 57137319 bytes. 06:51:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:08 INFO - mkdir: /builds/slave/test-pgo/properties 06:51:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:51:08 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:51:08 INFO - Contents: 06:51:08 INFO - build_url:https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:08 INFO - Running post-action listener: _resource_record_post_action 06:51:08 INFO - Running post-action listener: set_extra_try_arguments 06:51:08 INFO - ##### 06:51:08 INFO - ##### Running populate-webroot step. 06:51:08 INFO - ##### 06:51:08 INFO - Running pre-action listener: _resource_record_pre_action 06:51:08 INFO - Running main action method: populate_webroot 06:51:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:51:08 INFO - '../fennec_ids.txt'], 06:51:08 INFO - 'tests': ['tcheck2']}, 06:51:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:08 INFO - '--tppagecycles', 06:51:08 INFO - '7'], 06:51:08 INFO - 'tests': ['tsvgm']}}, 06:51:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:51:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:51:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:51:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:51:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:51:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:08 INFO - 'talos_options': ['--e10s'], 06:51:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:08 INFO - 'tests': ['damp', 'tps']}, 06:51:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:08 INFO - 'talos_options': ['--e10s'], 06:51:08 INFO - 'tests': ['damp', 'tps']}, 06:51:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:51:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:08 INFO - 'other': {'tests': ['a11yr', 06:51:08 INFO - 'ts_paint', 06:51:08 INFO - 'tpaint', 06:51:08 INFO - 'sessionrestore', 06:51:08 INFO - 'sessionrestore_no_auto_restore']}, 06:51:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:51:08 INFO - 'tests': ['a11yr', 06:51:08 INFO - 'ts_paint', 06:51:08 INFO - 'tpaint', 06:51:08 INFO - 'sessionrestore', 06:51:08 INFO - 'sessionrestore_no_auto_restore']}, 06:51:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:51:08 INFO - 'tests': ['a11yr', 06:51:08 INFO - 'ts_paint', 06:51:08 INFO - 'tpaint', 06:51:08 INFO - 'sessionrestore', 06:51:08 INFO - 'sessionrestore_no_auto_restore']}, 06:51:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:51:08 INFO - 'tests': ['a11yr', 06:51:08 INFO - 'ts_paint', 06:51:08 INFO - 'tpaint', 06:51:08 INFO - 'sessionrestore', 06:51:08 INFO - 'sessionrestore_no_auto_restore']}, 06:51:08 INFO - 'other_l64': {'tests': ['a11yr', 06:51:08 INFO - 'ts_paint', 06:51:08 INFO - 'tpaint', 06:51:08 INFO - 'sessionrestore', 06:51:08 INFO - 'sessionrestore_no_auto_restore']}, 06:51:08 INFO - 'other_nol64': {'tests': ['a11yr', 06:51:08 INFO - 'ts_paint', 06:51:08 INFO - 'tpaint', 06:51:08 INFO - 'sessionrestore', 06:51:08 INFO - 'sessionrestore_no_auto_restore']}, 06:51:08 INFO - 'svgr': {'tests': ['tsvgx', 06:51:08 INFO - 'tsvgr_opacity', 06:51:08 INFO - 'tart', 06:51:08 INFO - 'tscrollx', 06:51:08 INFO - 'cart']}, 06:51:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:51:08 INFO - 'tests': ['tsvgx', 06:51:08 INFO - 'tsvgr_opacity', 06:51:08 INFO - 'tart', 06:51:08 INFO - 'tscrollx', 06:51:08 INFO - 'cart']}, 06:51:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:08 INFO - 'tests': ['tp5o']}, 06:51:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:08 INFO - 'talos_options': ['--e10s'], 06:51:08 INFO - 'tests': ['tp5o']}, 06:51:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:08 INFO - 'talos_options': ['--xperf_path', 06:51:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:08 INFO - 'tests': ['tp5n']}, 06:51:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:08 INFO - 'talos_options': ['--e10s', 06:51:08 INFO - '--xperf_path', 06:51:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:08 INFO - 'tests': ['tp5n']}}, 06:51:08 INFO - 'talos.zip': {'path': '', 06:51:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:08 INFO - Running post-action listener: _resource_record_post_action 06:51:08 INFO - ##### 06:51:08 INFO - ##### Running create-virtualenv step. 06:51:08 INFO - ##### 06:51:08 INFO - Running pre-action listener: _resource_record_pre_action 06:51:08 INFO - Running main action method: create_virtualenv 06:51:08 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:51:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 06:51:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:51:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:08 INFO - Using real prefix '/usr' 06:51:08 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:51:09 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:11 INFO - Installing pip.................done. 06:51:11 INFO - Return code: 0 06:51:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9032194c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26736c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27343d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8c0>, '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 0x276a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a8b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:51:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:51:11 INFO - Using env: {'DISPLAY': ':0', 06:51:11 INFO - 'HOME': '/home/cltbld', 06:51:11 INFO - 'LANG': 'en_US.UTF-8', 06:51:11 INFO - 'LANGUAGE': 'en_US:en', 06:51:11 INFO - 'LOGNAME': 'cltbld', 06:51:11 INFO - 'MAIL': '/var/mail/cltbld', 06:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:11 INFO - 'MOZ_NO_REMOTE': '1', 06:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:11 INFO - 'NO_EM_RESTART': '1', 06:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:11 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:11 INFO - 'SHELL': '/bin/bash', 06:51:11 INFO - 'SHLVL': '1', 06:51:11 INFO - 'TERM': 'linux', 06:51:11 INFO - 'TMOUT': '86400', 06:51:11 INFO - 'USER': 'cltbld', 06:51:11 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 06:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:11 INFO - '_': '/tools/buildbot/bin/python'} 06:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:51:11 INFO - Cleaning up... 06:51:11 INFO - Return code: 0 06:51:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9032194c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26736c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27343d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8c0>, '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 0x276a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a8b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:51:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:51:11 INFO - Using env: {'DISPLAY': ':0', 06:51:11 INFO - 'HOME': '/home/cltbld', 06:51:11 INFO - 'LANG': 'en_US.UTF-8', 06:51:11 INFO - 'LANGUAGE': 'en_US:en', 06:51:11 INFO - 'LOGNAME': 'cltbld', 06:51:11 INFO - 'MAIL': '/var/mail/cltbld', 06:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:11 INFO - 'MOZ_NO_REMOTE': '1', 06:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:11 INFO - 'NO_EM_RESTART': '1', 06:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:11 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:11 INFO - 'SHELL': '/bin/bash', 06:51:11 INFO - 'SHLVL': '1', 06:51:11 INFO - 'TERM': 'linux', 06:51:11 INFO - 'TMOUT': '86400', 06:51:11 INFO - 'USER': 'cltbld', 06:51:11 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 06:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:11 INFO - '_': '/tools/buildbot/bin/python'} 06:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:11 INFO - Downloading/unpacking psutil>=0.7.1 06:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:13 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:51:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:51:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:51:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:13 INFO - Installing collected packages: psutil 06:51:13 INFO - Running setup.py install for psutil 06:51:13 INFO - building 'psutil._psutil_linux' extension 06:51:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:51:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:51:13 INFO - building 'psutil._psutil_posix' extension 06:51:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:51:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:51:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:13 INFO - Successfully installed psutil 06:51:13 INFO - Cleaning up... 06:51:13 INFO - Return code: 0 06:51:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f9032194c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26736c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27343d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8c0>, '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 0x276a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a8b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:51:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:51:14 INFO - Using env: {'DISPLAY': ':0', 06:51:14 INFO - 'HOME': '/home/cltbld', 06:51:14 INFO - 'LANG': 'en_US.UTF-8', 06:51:14 INFO - 'LANGUAGE': 'en_US:en', 06:51:14 INFO - 'LOGNAME': 'cltbld', 06:51:14 INFO - 'MAIL': '/var/mail/cltbld', 06:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:14 INFO - 'MOZ_NO_REMOTE': '1', 06:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:14 INFO - 'NO_EM_RESTART': '1', 06:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:14 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:14 INFO - 'SHELL': '/bin/bash', 06:51:14 INFO - 'SHLVL': '1', 06:51:14 INFO - 'TERM': 'linux', 06:51:14 INFO - 'TMOUT': '86400', 06:51:14 INFO - 'USER': 'cltbld', 06:51:14 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 06:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:14 INFO - '_': '/tools/buildbot/bin/python'} 06:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:51:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:51:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:51:15 INFO - Installing collected packages: mozsystemmonitor 06:51:15 INFO - Running setup.py install for mozsystemmonitor 06:51:16 INFO - Successfully installed mozsystemmonitor 06:51:16 INFO - Cleaning up... 06:51:17 INFO - Return code: 0 06:51:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:51: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')]} 06:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:17 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 0x7f9032194c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26736c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27343d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8c0>, '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 0x276a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a8b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:51:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:51:17 INFO - Using env: {'DISPLAY': ':0', 06:51:17 INFO - 'HOME': '/home/cltbld', 06:51:17 INFO - 'LANG': 'en_US.UTF-8', 06:51:17 INFO - 'LANGUAGE': 'en_US:en', 06:51:17 INFO - 'LOGNAME': 'cltbld', 06:51:17 INFO - 'MAIL': '/var/mail/cltbld', 06:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:17 INFO - 'MOZ_NO_REMOTE': '1', 06:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:17 INFO - 'NO_EM_RESTART': '1', 06:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:17 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:17 INFO - 'SHELL': '/bin/bash', 06:51:17 INFO - 'SHLVL': '1', 06:51:17 INFO - 'TERM': 'linux', 06:51:17 INFO - 'TMOUT': '86400', 06:51:17 INFO - 'USER': 'cltbld', 06:51:17 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 06:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:17 INFO - '_': '/tools/buildbot/bin/python'} 06:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:17 INFO - Downloading/unpacking blobuploader==1.2.4 06:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:19 INFO - Downloading blobuploader-1.2.4.tar.gz 06:51:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:51:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:51:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:51:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:51:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:19 INFO - Downloading docopt-0.6.1.tar.gz 06:51:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:51:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:19 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:19 INFO - Running setup.py install for blobuploader 06:51:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:20 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:51:20 INFO - Running setup.py install for requests 06:51:20 INFO - Running setup.py install for docopt 06:51:20 INFO - Successfully installed blobuploader requests docopt 06:51:20 INFO - Cleaning up... 06:51:20 INFO - Return code: 0 06:51:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:20 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 0x7f9032194c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26736c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27343d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8c0>, '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 0x276a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a8b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:51:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:20 INFO - Using env: {'DISPLAY': ':0', 06:51:20 INFO - 'HOME': '/home/cltbld', 06:51:20 INFO - 'LANG': 'en_US.UTF-8', 06:51:20 INFO - 'LANGUAGE': 'en_US:en', 06:51:20 INFO - 'LOGNAME': 'cltbld', 06:51:20 INFO - 'MAIL': '/var/mail/cltbld', 06:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:20 INFO - 'MOZ_NO_REMOTE': '1', 06:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:20 INFO - 'NO_EM_RESTART': '1', 06:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:20 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:20 INFO - 'SHELL': '/bin/bash', 06:51:20 INFO - 'SHLVL': '1', 06:51:20 INFO - 'TERM': 'linux', 06:51:20 INFO - 'TMOUT': '86400', 06:51:20 INFO - 'USER': 'cltbld', 06:51:20 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 06:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:20 INFO - '_': '/tools/buildbot/bin/python'} 06:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:20 INFO - Running setup.py (path:/tmp/pip-4qigeu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:20 INFO - Running setup.py (path:/tmp/pip-aZKmOO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:20 INFO - Running setup.py (path:/tmp/pip-Ed_Gmg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:21 INFO - Running setup.py (path:/tmp/pip-YbDBni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:21 INFO - Running setup.py (path:/tmp/pip-IMvTro-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:21 INFO - Running setup.py (path:/tmp/pip-REEb8C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:21 INFO - Running setup.py (path:/tmp/pip-H55F7H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:21 INFO - Running setup.py (path:/tmp/pip-ByN9Mt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:21 INFO - Running setup.py (path:/tmp/pip-iOTdVA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:21 INFO - Running setup.py (path:/tmp/pip-LH3aaU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:21 INFO - Running setup.py (path:/tmp/pip-9kw5nL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:21 INFO - Running setup.py (path:/tmp/pip-XNDd0O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:21 INFO - Running setup.py (path:/tmp/pip-TXKWJp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:21 INFO - Running setup.py (path:/tmp/pip-QHPoOj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:21 INFO - Running setup.py (path:/tmp/pip-oQY1cf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:21 INFO - Running setup.py (path:/tmp/pip-v1klpS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:21 INFO - Running setup.py (path:/tmp/pip-rEAHjv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:51:21 INFO - Running setup.py install for manifestparser 06:51:22 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:51:22 INFO - Running setup.py install for mozcrash 06:51:22 INFO - Running setup.py install for mozdebug 06:51:22 INFO - Running setup.py install for mozdevice 06:51:22 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:51:22 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:51:22 INFO - Running setup.py install for mozfile 06:51:22 INFO - Running setup.py install for mozhttpd 06:51:22 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:51:22 INFO - Running setup.py install for mozinfo 06:51:22 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:51:22 INFO - Running setup.py install for mozInstall 06:51:22 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:51:22 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:51:22 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:51:22 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:51:22 INFO - Running setup.py install for mozleak 06:51:22 INFO - Running setup.py install for mozlog 06:51:23 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:51:23 INFO - Running setup.py install for moznetwork 06:51:23 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:51:23 INFO - Running setup.py install for mozprocess 06:51:23 INFO - Running setup.py install for mozprofile 06:51:23 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:51:23 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:51:23 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:51:23 INFO - Running setup.py install for mozrunner 06:51:23 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:51:23 INFO - Running setup.py install for mozscreenshot 06:51:23 INFO - Running setup.py install for moztest 06:51:23 INFO - Running setup.py install for mozversion 06:51:23 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:51:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:51:23 INFO - Cleaning up... 06:51:23 INFO - Return code: 0 06:51:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f9032194c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26736c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27343d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8c0>, '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 0x276a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a8b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:51:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:23 INFO - Using env: {'DISPLAY': ':0', 06:51:23 INFO - 'HOME': '/home/cltbld', 06:51:23 INFO - 'LANG': 'en_US.UTF-8', 06:51:23 INFO - 'LANGUAGE': 'en_US:en', 06:51:23 INFO - 'LOGNAME': 'cltbld', 06:51:23 INFO - 'MAIL': '/var/mail/cltbld', 06:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:23 INFO - 'MOZ_NO_REMOTE': '1', 06:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:23 INFO - 'NO_EM_RESTART': '1', 06:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:23 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:23 INFO - 'SHELL': '/bin/bash', 06:51:23 INFO - 'SHLVL': '1', 06:51:23 INFO - 'TERM': 'linux', 06:51:23 INFO - 'TMOUT': '86400', 06:51:23 INFO - 'USER': 'cltbld', 06:51:23 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 06:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:23 INFO - '_': '/tools/buildbot/bin/python'} 06:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:23 INFO - Running setup.py (path:/tmp/pip-HiXJLu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:24 INFO - Running setup.py (path:/tmp/pip-0btwr8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:24 INFO - Running setup.py (path:/tmp/pip-iwt1v7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:24 INFO - Running setup.py (path:/tmp/pip-FJwN9t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:24 INFO - Running setup.py (path:/tmp/pip-zoQJSl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:24 INFO - Running setup.py (path:/tmp/pip-MhTK0P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:24 INFO - Running setup.py (path:/tmp/pip-3v5jhg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:24 INFO - Running setup.py (path:/tmp/pip-z7Gz2l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:24 INFO - Running setup.py (path:/tmp/pip-iRK4Zj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:24 INFO - Running setup.py (path:/tmp/pip-jmQQd9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:24 INFO - Running setup.py (path:/tmp/pip-YLoKI3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:24 INFO - Running setup.py (path:/tmp/pip-FLTWIz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:24 INFO - Running setup.py (path:/tmp/pip-fhsab1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 06:51:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:24 INFO - Running setup.py (path:/tmp/pip-hzv7Dk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 06:51:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:25 INFO - Running setup.py (path:/tmp/pip-d5qFkt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 06:51:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:25 INFO - Running setup.py (path:/tmp/pip-5m51Va-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 06:51:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:25 INFO - Running setup.py (path:/tmp/pip-3BpHjv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 06:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:26 INFO - Downloading blessings-1.5.1.tar.gz 06:51:26 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 06:51:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:26 INFO - Installing collected packages: blessings 06:51:26 INFO - Running setup.py install for blessings 06:51:27 INFO - Successfully installed blessings 06:51:27 INFO - Cleaning up... 06:51:27 INFO - Return code: 0 06:51:27 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:51:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:51:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:51:27 INFO - Reading from file tmpfile_stdout 06:51:27 INFO - Current package versions: 06:51:27 INFO - argparse == 1.2.1 06:51:27 INFO - blessings == 1.5.1 06:51:27 INFO - blobuploader == 1.2.4 06:51:27 INFO - docopt == 0.6.1 06:51:27 INFO - manifestparser == 1.1 06:51:27 INFO - mozInstall == 1.12 06:51:27 INFO - mozcrash == 0.16 06:51:27 INFO - mozdebug == 0.1 06:51:27 INFO - mozdevice == 0.47 06:51:27 INFO - mozfile == 1.2 06:51:27 INFO - mozhttpd == 0.7 06:51:27 INFO - mozinfo == 0.9 06:51:27 INFO - mozleak == 0.1 06:51:27 INFO - mozlog == 3.0 06:51:27 INFO - moznetwork == 0.27 06:51:27 INFO - mozprocess == 0.22 06:51:27 INFO - mozprofile == 0.27 06:51:27 INFO - mozrunner == 6.11 06:51:27 INFO - mozscreenshot == 0.1 06:51:27 INFO - mozsystemmonitor == 0.0 06:51:27 INFO - moztest == 0.7 06:51:27 INFO - mozversion == 1.4 06:51:27 INFO - psutil == 3.1.1 06:51:27 INFO - requests == 1.2.3 06:51:27 INFO - wsgiref == 0.1.2 06:51:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:27 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 0x7f9032194c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26736c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27343d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8c0>, '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 0x276a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a8b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 06:51:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:27 INFO - Using env: {'DISPLAY': ':0', 06:51:27 INFO - 'HOME': '/home/cltbld', 06:51:27 INFO - 'LANG': 'en_US.UTF-8', 06:51:27 INFO - 'LANGUAGE': 'en_US:en', 06:51:27 INFO - 'LOGNAME': 'cltbld', 06:51:27 INFO - 'MAIL': '/var/mail/cltbld', 06:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:27 INFO - 'MOZ_NO_REMOTE': '1', 06:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:27 INFO - 'NO_EM_RESTART': '1', 06:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:27 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:27 INFO - 'SHELL': '/bin/bash', 06:51:27 INFO - 'SHLVL': '1', 06:51:27 INFO - 'TERM': 'linux', 06:51:27 INFO - 'TMOUT': '86400', 06:51:27 INFO - 'USER': 'cltbld', 06:51:27 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 06:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:27 INFO - '_': '/tools/buildbot/bin/python'} 06:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 06:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 06:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 06:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 06:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 06:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:51:27 INFO - Cleaning up... 06:51:27 INFO - Return code: 0 06:51:27 INFO - Running post-action listener: _resource_record_post_action 06:51:27 INFO - Running post-action listener: _start_resource_monitoring 06:51:27 INFO - Starting resource monitoring. 06:51:27 INFO - ##### 06:51:27 INFO - ##### Running install step. 06:51:27 INFO - ##### 06:51:27 INFO - Running pre-action listener: _resource_record_pre_action 06:51:27 INFO - Running main action method: install 06:51:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:51:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:51:27 INFO - Reading from file tmpfile_stdout 06:51:27 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:51:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:51:27 INFO - Reading from file tmpfile_stdout 06:51:27 INFO - Output received: 06:51:27 INFO - Usage: mozinstall [options] installer 06:51:27 INFO - Options: 06:51:27 INFO - -h, --help show this help message and exit 06:51:27 INFO - -d DEST, --destination=DEST 06:51:27 INFO - Directory to install application into. [default: 06:51:27 INFO - "/builds/slave/test-pgo"] 06:51:27 INFO - --app=APP Application being installed. [default: firefox] 06:51:27 INFO - mkdir: /builds/slave/test-pgo/build/application 06:51:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:51:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:51:42 INFO - Reading from file tmpfile_stdout 06:51:42 INFO - Output received: 06:51:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:51:42 INFO - Running post-action listener: _resource_record_post_action 06:51:42 INFO - ##### 06:51:42 INFO - ##### Running run-tests step. 06:51:42 INFO - ##### 06:51:42 INFO - Running pre-action listener: _resource_record_pre_action 06:51:42 INFO - Running main action method: run_tests 06:51:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:51:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:51:42 INFO - Python 2.7.3 06:51:42 INFO - Return code: 0 06:51:42 INFO - grabbing minidump binary from tooltool 06:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:42 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 0x27bd8c0>, '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 0x276a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:51:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 06:51:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:51:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:51:42 INFO - Return code: 0 06:51:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:51:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:51:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:51:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:51:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:51:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:51:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost 06:51:42 INFO - Using env: {'DISPLAY': ':0', 06:51:42 INFO - 'HOME': '/home/cltbld', 06:51:42 INFO - 'LANG': 'en_US.UTF-8', 06:51:42 INFO - 'LANGUAGE': 'en_US:en', 06:51:42 INFO - 'LOGNAME': 'cltbld', 06:51:42 INFO - 'MAIL': '/var/mail/cltbld', 06:51:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:51:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:42 INFO - 'MOZ_NO_REMOTE': '1', 06:51:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:42 INFO - 'NO_EM_RESTART': '1', 06:51:42 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:42 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:42 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:51:42 INFO - 'SHELL': '/bin/bash', 06:51:42 INFO - 'SHLVL': '1', 06:51:42 INFO - 'TERM': 'linux', 06:51:42 INFO - 'TMOUT': '86400', 06:51:42 INFO - 'USER': 'cltbld', 06:51:42 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539', 06:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:42 INFO - '_': '/tools/buildbot/bin/python'} 06:51:42 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] with output_timeout 3600 06:51:42 INFO - mozversion INFO | application_buildid: 20151115043023 06:51:42 INFO - mozversion INFO | application_changeset: 22360424ed1532c73c93aab85bfd9173899956f8 06:51:42 INFO - mozversion INFO | application_display_name: Nightly 06:51:42 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:51:42 INFO - mozversion INFO | application_name: Firefox 06:51:42 INFO - mozversion INFO | application_remotingname: firefox 06:51:42 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:51:42 INFO - mozversion INFO | application_vendor: Mozilla 06:51:42 INFO - mozversion INFO | application_version: 45.0a1 06:51:42 INFO - mozversion INFO | platform_buildid: 20151115043023 06:51:42 INFO - mozversion INFO | platform_changeset: 22360424ed1532c73c93aab85bfd9173899956f8 06:51:42 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:51:42 INFO - mozversion INFO | platform_version: 45.0a1 06:51:42 INFO - 2015-11-15 06:51:42,446 DEBUG : using testdate: 1447599102 06:51:42 INFO - 2015-11-15 06:51:42,447 DEBUG : actual date: 1447599102 06:51:42 INFO - 2015-11-15 06:51:42,455 INFO : starting webserver on 'localhost:32830' 06:51:42 INFO - 2015-11-15 06:51:42,456 INFO : Starting test suite talos-linux64-ix-034.e 06:51:42 INFO - 2015-11-15 06:51:42,456 INFO : Starting test dromaeo_css 06:51:42 INFO - 2015-11-15 06:51:42,456 DEBUG : operating with platform_type : linux_ 06:51:42 INFO - 2015-11-15 06:51:42,457 INFO : Initialising browser for dromaeo_css test... 06:51:42 INFO - 2015-11-15 06:51:42,469 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Ea3wX/profile http://localhost:32830/getInfo.html 06:51:47 INFO - 2015-11-15 06:51:47,696 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:51:47 INFO - 2015-11-15 06:51:47,696 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:51:47 INFO - 2015-11-15 06:51:47,697 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:51:47 INFO - 2015-11-15 06:51:47,697 DEBUG : BROWSER_OUTPUT: __metrics 06:51:48 INFO - 2015-11-15 06:51:48,771 INFO : Browser initialized. 06:51:48 INFO - 2015-11-15 06:51:48,772 INFO : Running cycle 1/1 for dromaeo_css test... 06:51:48 INFO - 2015-11-15 06:51:48,772 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Ea3wX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:52:00 INFO - 2015-11-15 06:52:00,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 141250560 06:52:00 INFO - 2015-11-15 06:52:00,523 DEBUG : BROWSER_OUTPUT: 06:52:50 INFO - 2015-11-15 06:52:50,139 DEBUG : BROWSER_OUTPUT: 1447599170136 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:54:58 INFO - 2015-11-15 06:54:58,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32830/tests/dromaeo/cssquery-ext.html) 06:54:59 INFO - 2015-11-15 06:54:59,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 147939328 06:54:59 INFO - 2015-11-15 06:54:59,601 DEBUG : BROWSER_OUTPUT: 06:58:01 INFO - 2015-11-15 06:58:01,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/dromaeo/cssquery-ext.html (next: http://localhost:32830/tests/dromaeo/cssquery-jquery.html) 06:58:02 INFO - 2015-11-15 06:58:02,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 140378112 06:58:02 INFO - 2015-11-15 06:58:02,103 DEBUG : BROWSER_OUTPUT: 07:01:03 INFO - 2015-11-15 07:01:03,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32830/tests/dromaeo/cssquery-mootools.html) 07:01:04 INFO - 2015-11-15 07:01:04,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 142024704 07:01:04 INFO - 2015-11-15 07:01:04,307 DEBUG : BROWSER_OUTPUT: 07:04:05 INFO - 2015-11-15 07:04:05,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32830/tests/dromaeo/cssquery-prototype.html) 07:04:06 INFO - 2015-11-15 07:04:06,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 140812288 07:04:06 INFO - 2015-11-15 07:04:06,608 DEBUG : BROWSER_OUTPUT: 07:07:08 INFO - 2015-11-15 07:07:08,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32830/tests/dromaeo/cssquery-yui.html) 07:07:09 INFO - 2015-11-15 07:07:09,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 141078528 07:07:09 INFO - 2015-11-15 07:07:09,571 DEBUG : BROWSER_OUTPUT: 07:10:11 INFO - 2015-11-15 07:10:11,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/dromaeo/cssquery-yui.html (next: http://localhost:32830/tests/dromaeo/cssquery-dojo.html) 07:10:12 INFO - 2015-11-15 07:10:12,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 144056320 07:10:12 INFO - 2015-11-15 07:10:12,158 DEBUG : BROWSER_OUTPUT: 07:10:12 INFO - 2015-11-15 07:10:12,160 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:10:12 INFO - 2015-11-15 07:10:12,160 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:10:12 INFO - 2015-11-15 07:10:12,160 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:10:12 INFO - 2015-11-15 07:10:12,160 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:10:12 INFO - 2015-11-15 07:10:12,162 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3199.1522246604654;3247.8376081195934;3255.365203785263;3272.999999999999;3284.1625385526686;5217.739113044351;5445.128779395298;5447.264619276401;5464.207689884975;5469.206964990074;5442.619016668835;5475.288212532375;5484.945150548493;5553.194786755918;5557.3331200255925;4674.7428891410955;4916;5099.36257967754;5111.744412779365;5149.0474262261605;4890.779914903838;5049.419316778581;5088.720120393377;5113.309703190059;5115.718635475047;4770.0459908018365;4887.315775791392;4915.827946021872;4921.138800709861;4977.377827771528;5003.199488081926;5025.773840177201;5031.723255220962;5053.67151135175;5097.847064588032;4872.293517439987;4894.804207831682;5014.623903207237;5047.9495205048215;5073.746312684388;5134.614903882187;5178.818741344035;5224.529792318672;5248.947510524884;5273.024490469237;5919.644821310735;5938.198343223653;5941.851453713649;5948.405159484017;5948.40515948406;5789.131630255453;5855.795047173371;5964.045752679551;5965.433283838029;6027.397260273981;5462.453754624546;5484.2596249505805;5498.5876059295715;5499.257600223958;5500.064988951848;5954.880902382015;5955.28536575605;5970.462658360681;5970.58205925581;5977.193078934288;5689.231953686282;5727.4845263926445;5752.884942301131;5900.350961394243;5938.317093534212;5841.182234487175;5855.970720146372;5866.73599688015;5878.147668588031;5939.930812453714;5838.38696936824;5845.918505076575;5850.2102216200265;5855.473007429352;5864.882702345929;5663.207150998864;5776.537876969833;5794.536437085023;5857.794977175864;5902.852428689232;4524.321351797257;4528.547145285445;4529.68292219548;4545.886352841206;4561.201789686792;4042.5148982121746;4045.37296719009;4049.271131196354;4055.168690418457;4061.898452538651;5367.329083864517;5528.143137813645;5541.085720856095;5648.74580643872;5727.599068065196;5935;5947.286325640865;5972.58191926561;5985.371535988658;5985.581009329392;5457.536109430664;5659.151127330933;5667.574931880125;5676.091825307931;5689.374168841424;4932.161532539477;4942.777575009133;5026.773795179226;5046.495350464924;5095.821646242363;6227.501799856001;6297.118403423525;6305.274893387227;6306.085617585516;6306.684665766693;5850.824475265749;6036.396360363929;6046.939530604637;6069.575129740876;6076.665783381956;6025.66858822769;6040.36576159497;6109.877802443837;6110.649890384107;6139.1098290746695;5753.798617048383;5843;5851.297844258546;5869.207656966255;5871.031279838779;5759.193712880284;5837.737301821513;5920.644761314163;5937.732802023833;5984.910226346521;5652.095664693629;5841.211436456194;5859.20900678403;5874.17761513397;5875.353711091691;5754.539636829128;5776.682282474504;5785.537157027344;5795.59430839854;5802.100674395476;5400.675959442289;5510.531604813636;5512.3660779010925;5517.034518959086;5628.352739435018;5640.774369025193;5670.262865827416;5684.857878553069;5810.389909059657;5834.94165058344;5659.292588426447;5684.3747187808485;5705.22979397776;5730.312362516524;5760.107183386582 07:10:12 INFO - 2015-11-15 07:10:12,165 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.4525837308622;591.7100620695858;600.1927407636729;600.3996003996004;608.9465225160471;39479;40460.59539404605;40470.7976460118;40493.190136197256;40663.390049149246;42126.36810447846;42805.357919631155;42884.571154288446;42937;43024.78487607565;8620.913790862089;8773.034966153718;8791;8794.736157915273;8805.295576353908;8572.22849943505;8625.525596092213;8646.30829533639;8650.913490865105;8679.392442529026;8628.309735221168;8646.481211127353;8663.696770613029;8694.39139260252;8702.086280940504;8621.827563448727;8658.264047555966;8680.045195028573;8710.912890871074;8717.564121793885;8554.272886804629;8691.39160258782;8692.869606955837;8695;8712.956435217846;39474.21051578981;39946.800265998776;39974.60025399738;40109.598904010876;40170;3227.2697816084524;3239.7732158748895;3462.792232466035;3614.457831325296;4057.4928133983253;28736;29407.70592294071;29418.852905735548;29781.10656680303;29858.253543661365;3327.3345330933666;3363.461846104636;3364.798112113281;3416.8120753358803;3498.7725797823314;280418;281421.59289203625;281607;281850;282704;42331.15337693229;55282.72358638181;55643;55698.16452753212;55915.44084559184;41617.37573936393;41848.790756046634;41958.1608367837;42040.36939445911;42055.36916946248;14440.133591984304;14532.636684082983;14615.707685846437;14662.63343416423;14673.633159170893;11795.646130616095;11869.287842729464;11959.701007474883;12011.279323240633;12033.578824741093;13897.374618142208;13921.443142274196;13977.790333144807;14211.431542738175;14283.714325713427;5849.30254858185;5876.206712093813;5883.7058147092475;5900.76396944126;5907.49786268172;931.902150274225;932.6409332407072;950.410745337881;1019.3374306700704;1122.6247846388274;28099;28240;28249.57625635617;28535.857320713265;28776.71223287782;1024.2267088348249;1038.6624347087077;1107.5016242690822;1132.0231946011181;1170.9180357374903;14578.635534111732;14735.484258050918;14871.033382830297;14884.10695358282;15123.39506419753;306559;312397;313898;314915;315148;51239.48760512422;51426;51541.484585154416;51571;51609.74195129075;1304.8108024336418;1335.779596366608;1340.2092765268537;1353.8713822186876;1358.5448874626913;27225.59161612617;28014.579781303706;28126;31713.524297136024;32769.34461310808;50776.49223507865;51340.74329628328;51373;51478;51526;292715;295758;295897;296068;296601;42112;46230.76884615555;46337.76831115823;47487.76256118697;47669.76165119152;43478.13043739044;43622.781886090364;43905.78047109744;44214.33678494889;44292.33561496516;36740.26519469649;36806;38611.806940965114;42159.78920105503;42813.143737125705;36647;37067.814660926524;37167.442488362154;37171.74533162671;37530.62469375271;37808;40398.19203615852;40962.18075638411;41434.1713165741;41576.376354355314;29290.7070929288;30468.23829404194;33225.833870830495;33279.667203327655;34035.14912127217;25451.74548254494;25703.485930280916;25991.350216243987;26143.065635058556;26233.344166395993 07:10:12 INFO - 2015-11-15 07:10:12,167 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.9014675890751;353.92390636013266;354.26313268401725;354.9716022718182;356.6184182924269;12088.637340879766;12325.938370308137;16557;17018.14909254537;17654.999999999985;11609.825852612217;11641.243319184247;11682.883171168285;11819.704507387298;12081.214721043127;4440.378347031418;4527.52460991596;4534.478534968472;4549.203889319356;4555.863324100283;4372.147431250907;4502.887427814315;4506.031203291292;4508.864734057967;4512.413386259782;4496.910061798762;4499.572540608653;4708.74101924394;4807.927881081787;4816.51834816519;4728.69263497875;4781.976090119562;4788.305695674143;4797.280407938802;4797.904041919177;4292.055747735493;4294.656427485794;4298.78506074695;4313.741175529447;4315.417418648473;13087.803682944763;13173.275469849155;13263.204207747565;13265.27041012744;13406.12860164096;1830.3136323878546;1869.242956602578;1887.160213704902;1974.4570243183239;1990.28349794074;9582.90417095827;9709.223262139012;9824.803503929952;9958.601655933753;10005.748706541042;1618.2151656446615;1623.9431619893246;1643.4823030745397;1679.2443400469838;1693.796744390681;60289.09566356508;61452.999999999556;61557.384426155615;62104;62807;6620;6803.421709154777;6811.489138314646;6827.658617069127;6847.794566163023;8101.149379315205;8115.79710507242;8130.512169269863;8141.1451797561585;8145.918540814635;5486.835394938158;5530.004599172187;5562.610617256753;5577.581681373913;5585.69278689676;5703.572232082611;5704.686242256716;5741.081426971748;5768.509676677446;5777.162311464814;3004.9399012019635;3096.040227529473;3098.024122401436;3100.674429184903;3109.455845227076;1115.966521004371;1119.1941801902617;1119.8040342939953;1126.4987080748988;1171.1860257121389;382.2126419575683;402.4767801857573;406.85759984005955;416.4170161773541;420.886360682614;9302.581383837743;9400.717978460658;9614.615415383307;10092.949535252277;10190.337628054152;400.93184158693094;412.5688655355161;439.9670024748157;444.67760873367195;452.4231604704029;6428.325025872216;6905.343992320722;6911.75808846698;6916.20463646677;7143.678534465961;545986;547791;553548;558923;559627;76568.61715691385;77631.2236877624;77886.2211377879;78625.60687196527;78799.60600196962;556.0491559433414;566.3430420711954;566.7081453051682;567.701956472855;568.6360729133359;9589.280803939593;9637.325387222827;11277.887221128012;11628.709282268012;11779.116566257393;33609.663903360655;33920.15199620029;34389.31221375508;35404.822975884956;35479.82260088683;44149;44976.77511612421;45545;46184.76907615441;46262.768686156356;15148.772768408262;15218.315175816893;15265.084094954338;15567.610809729847;15595.454159104831;19053;19257.22971081141;19325.710114348014;19418.126184322024;19648.115834787182;8238.876416853871;9004.41471304363;9132.406393584395;9214.493202873906;16095.114768687834;8681.652733890574;8927.598258078273;9039.141281578239;9219.44683319003;9330.346875718635;8881.111888811067;9018.053104423941;9172.44965302084;9371.34400591952;9437.19783818383;14139.575812725634;14368.281585920453;14614;14659.706805864036;14728.189949552878;15038.097714137186;15087.698246035237;15226.543203703906;15569.299381527631;15652.217389130727 07:10:12 INFO - 2015-11-15 07:10:12,168 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1530.3648985670948;1691.8815682902198;1744.0930716027665;1758.2878934031721;1758.9208485618146;6824.317568243173;6973.058637083992;7463.365613922816;7609.809754756134;7666.271704188101;6877.518573699843;7047.647617619112;7297.963510182455;7474.588897610629;7526.322630963212;2188.3325585696357;2239.9776002240014;2252.6395776675736;2263.411513006622;2264.62633665445;2247.7752224777473;2270.2848602690183;2277.1574517428576;2287.62254228053;2294.8737819419925;2187.890605469728;2220.200727738013;2231.553689262146;2252.2680128958073;2264.2075273654254;2232.9218477353215;2232.966505502419;2241.1147596699293;2246.539459410817;2268.7844654757773;2234.273860995183;2242.338510139513;2242.798148166673;2246.853954492969;2247.1348530815753;7387.519811212254;7416;7425.220351863085;7435.628218589049;7438.442116841258;4350.499692535367;4369.4319738434115;4384.802683879233;4405.933910991338;4409.801558929824;2841.417509410566;2943.3818898031227;2945.322575807555;2977.8511074446405;2992.132281638322;917.2203626917134;932.9766755831091;938.2259635800424;961.8653388525612;974.3812678948848;9819.165370943478;9886.555105020292;9987.051230133198;10001.649942251986;10010.89989100107;4027.335489644176;4049.595040495986;4054.614811592894;4059.654929330981;4090.284200264942;8248.309096635176;8264;8285.917140828515;8343.415960882801;8395.24442800151;4562.498125206224;4570.702904311209;4572.428446444194;4578.88552786183;4580.312953057001;4123.134141830189;4148.149629325981;4155.646770024582;4217.40956266123;4243.702940794176;3456.2569047654874;3458;3465.6187819339852;3488.5639295088113;3494.5981212160927;1057.5716834681812;1066.2802608239408;1067.1836045425257;1068.8022715797447;1086.0876863434594;1331.2611500617056;1335.118821577754;1348.797680347936;1352.8850047745855;1365.5971488410942;6984.2317345092;7142.5714457132735;7148.892766608505;7154.248803875622;7155.96422017897;1117.3407689463256;1126.2093271697877;1141.4064686363045;1151.9366434845997;1161.1407558406718;5658.321001479849;5699.430056994351;5708.743106560215;5728.398518155617;5734.799282025193;8977.775555611031;9137.725868223964;9395.671151509665;9515.286353523376;9623.133917947418;9292.349535532448;9375.015623359586;9387.90612093884;9437.245020398488;9476.099770521789;7029.718811247493;7118.394936430462;7179.641017949186;7189.964050179716;7246.130464344313;6871.931280687129;6890.31096890307;6908.447324214151;6911.861762764616;6916.412104971134;7974.601269936364;7998.520088794691;8112.59437028158;8116.228958248957;8151.062627797879;8246.917530824854;8336.62485188156;8351.540665263468;8401.663933442594;8455.02767181782;5580.135079062752;5748.051571490657;6187;6463.353664633499;6517.217933847968;7263.673134708845;7272.309130632581;7279;7298.343149116605;7304.379127774198;6710.060591517094;6856.485763567852;6884.862302754017;6905.620190889549;7037.190723066913;6699.9665001674675;6735.4611631070375;6771.187457505131;6827.658617069027;6831.45348372139;6748.966255168889;6801;6824.078749368771;6833.521653484208;6859.691313890987;6323.841903952438;6363.681815909279;6386.616802991835;6392.744290228339;6405.903911441425;6421.068945003042;6431.035344698333;6433.292337842927;6438.8390290243115;6453.322401147811 07:10:12 INFO - 2015-11-15 07:10:12,168 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.3535965354315;309.65009539220677;312.63577931709557;323.3242523126666;325.2551656706143;6253.37466253375;6383.170187875581;6449.451796597289;6513.185851768535;6557.213134423864;6295.559310848243;6322.715477803498;6374.394432528914;6381.872362552746;6385.776497822577;4599.080183963204;4725.716457012573;4726.172919739049;4735.526447355272;4744.027474367746;4700.1539722849875;4710.976445117787;4720.9141897363625;4722.079194557063;4739.857804265877;4656.1153380857695;4659.767011649421;4661.324108004337;4664.76676166192;4667.439907211139;4658.091672123937;4672.299155126741;4672.649551283634;4685.2972054191805;4686.133065382915;3907.1013666856497;4007.078371974433;4012.0772222388723;4014.0566966762785;4026.1947610478023;5919.55603329752;5924.081767326028;5926.555508336849;5934.436228558323;5979.9402005980255;5358.571314294886;5408.648437851527;5409.0534156522845;5420.457954204588;5444.40111587725;6601.075849381091;6624.635645039521;6632.2704502504685;6643.833904152387;6666.333366663343;4360.89097772555;4441;4454.599086082236;4463.821447142111;4468.776561171929;6878.140232470942;6942.132233470817;6949.548279361826;6954.895676564855;6955.617441040741;4483.910321793546;4501.504834468205;4509.255972764523;4511.503734589192;4517.34498497716;4497.145542346943;4548.7725613719185;4560.3354775506705;4560.95439045612;4568.588827005586;5472.288602481652;5473.06957817172;5474.042042642522;5480.671159730429;5486.396496385394;6767.729290828312;6778.457723382117;6790.932090679129;6793.286704896013;6805;1624.5857306386795;1640.5242479680996;1644.6875093732153;1645.7531370294553;1646.703593353208;1051.8211903976342;1067.8344856547249;1080.935143891369;1104.8895110488886;1130.1467392118898;6342.302346741854;6522.119513865662;6523.347665233534;6523.739050437929;6533.379328963741;6964.79105626832;6989.755358562527;7011.649417529103;7029.9648501757165;7032.824179395556;6521.836954076091;6532.444742196872;6533.052707357407;6566;6586.868262634721;3748.6063963283464;3769.0012146781123;3778.7165962552367;3807.961920380816;3820.789856557916;7382.966384706146;7383.9261607384315;7390.630468476662;7392.778216653509;7405.259474052659;7192.4246060315045;7215.098112735908;7238;7242.529235599669;7249.115230040227;7184.353408193183;7336.082989626297;7365.9631701841145;7375.483716139926;7383.520071195355;6974.755883544051;6999.775039367988;7015.579065256101;7017.473689473208;7024.086868707035;6886.173659160932;6930.826729331606;6940.201876784235;6941.375276225164;6947.548409353376;7140;7332.0834895638045;7353.301436363751;7374;7381;4563.247064234364;4572.177008138567;4590.60979816706;4610.985583171697;4618.261078227468;6989.056477375692;7007.124109486314;7009.7897063088185;7012.684429200596;7024.824379390556;6666.466682665472;6732.360425759545;6792.966035169792;6806.693698783468;6810.8637827244165;6770.205895437614;6772.864542709217;6773.085633439423;6789.219239787488;6789.524733268624;6450.54846160783;6500.934990650222;6546.967265163644;6570.342965703582;6579.967100164468;6671.199456065303;6741.056252124608;6830.180378354629;6831.316868313129;6840.760573379908;6623.602583844985;6663.866722665616;6666.733330666719;6682.76610318656;6693.464522838259 07:10:12 INFO - 2015-11-15 07:10:12,169 DEBUG : BROWSER_OUTPUT: |5;yui.html;732.5494820685277;745.8620155271274;756.205983717097;756.5649751392949;775.2751177648895;15308.617284567892;15609.921950390246;15617.765733514007;15654.295556699948;15663.843361566382;14350.569482915504;14426.78359824601;14432.927835360835;14535.418583256656;14587.781183282259;801.3148757812074;803.9115697273324;812.3825892321819;814.3566582399926;815.7022686719334;817.7056259746487;821.0639870547581;822.5681517203486;823.6005537314397;828.159418190537;859.8925134358205;860.6170254236868;862.965481380744;866;866.6966561703416;859.7291853066326;859.8194379180379;860.3805260212637;861.0141388110578;862.3920136303891;618.1099217127322;623.8440389902524;625.4339822460635;625.6058683029707;630.3098107572201;12852.742945141139;13034.869651303461;13068.477260909553;13070.215787052808;13102.148360356547;9625.278104142148;9774.462404567746;10369.688909332732;10534.683959481228;10656.360618362924;9696.127348538665;9983.450910199936;10019.699409017741;10243.846342304796;10319.174466042774;3138.843057847121;3184.5860038194887;3213.550102985584;3245.1400378899375;3253.186703324169;45701.314480282825;46423.30365044527;46597.534024659995;47031.5296847034;47065.76467117677;7098.396636285974;7380.704771809067;7385.335319821242;7423.220561840929;7466.925330746732;12157.574484892986;12164.391780410944;12192.451339689735;12217.511299548096;12238.694032649255;6279.717412716439;6449.193850768654;6600.966995165089;6628.105205797156;6817.352351526597;4233.386159006988;4251.4685664291965;4279.144171165779;4324.783760811947;4352.107817897323;2811.620431241797;2828.1091456191643;2837.6878543360212;2845.9715402845704;2846.146156153146;411.4301692156385;420.3211812922109;421.6437110641503;426.7951383336016;430.38455009336326;485.98542043738746;495.42778091304604;549.9147632116948;552.5634748548601;627.7551754815626;7938.6030698466;8010.599470026592;8226.835463290701;8373.49759014461;8397.538135402612;513.3147248423396;564.9830505084853;581.8719881626035;582.1645938078871;670.0284587348365;4033.4756481657196;4106.328307073292;4250.702450828412;4301;4410.3825464435;53641.46358536365;58411;58493;59014.70492647509;59320;49527.75236123869;49604.50395496071;49735;49924.50075499271;50403;45035.999999999345;45554.316685249745;47863.04273914572;49780.253296200586;50445.74777126091;8574.31405487572;8794.252488538546;9143.77140571491;9249.30630202751;9314.301427392837;35125.824370877985;35326;35326.82336588301;36789;36803.81598091992;42460.78769606256;45974.310385344914;47086.293705595126;47412;48514.27228591644;8171.305439037748;8497.957510212409;8510.659573616986;8749;8877.778055548662;11820.645380638594;12479.87520124787;12521.37393130358;12533.811992820298;12577.308248046445;9948.900510995087;10082.647107351208;10129.59481620727;10292.433916134685;11408.144389171011;10848.186386020921;11055;11073.280236784583;11779.941100294787;11937.754834107187;11119.944400278271;11140.498677559692;11224.438778061227;11226.719332016764;11411.372374519482;10007.949960250153;10013.599456021677;10285.588576456857;10471.109955653856;10620.415877126832;9007.774805629911;9432;10005.699829005142;10066;10113.24150688716 07:10:12 INFO - 2015-11-15 07:10:12,170 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:10:12 INFO - 2015-11-15 07:10:12,170 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:10:12 INFO - 2015-11-15 07:10:12,170 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,289 07:10:12 INFO - 2015-11-15 07:10:12,170 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:10:12 INFO - 2015-11-15 07:10:12,170 DEBUG : BROWSER_OUTPUT: __startTimestamp1447600212159__endTimestamp 07:10:12 INFO - 2015-11-15 07:10:12,170 DEBUG : BROWSER_OUTPUT: 07:10:12 INFO - 2015-11-15 07:10:12,170 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:10:12 INFO - 2015-11-15 07:10:12,170 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:10:12 INFO - 2015-11-15 07:10:12,170 DEBUG : BROWSER_OUTPUT: 07:10:12 INFO - 2015-11-15 07:10:12,170 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5466.69 Median:5676.09 stddev:626.67 (11.0%) stddev-sans-first:602.81 07:10:12 INFO - 2015-11-15 07:10:12,171 DEBUG : BROWSER_OUTPUT: Values: 3199.2 3247.8 3255.4 3273.0 3284.2 5217.7 5445.1 5447.3 5464.2 5469.2 5442.6 5475.3 5484.9 5553.2 5557.3 4674.7 4916.0 5099.4 5111.7 5149.0 4890.8 5049.4 5088.7 5113.3 5115.7 4770.0 4887.3 4915.8 4921.1 4977.4 5003.2 5025.8 5031.7 5053.7 5097.8 4872.3 4894.8 5014.6 5047.9 5073.7 5134.6 5178.8 5224.5 5248.9 5273.0 5919.6 5938.2 5941.9 5948.4 5948.4 5789.1 5855.8 5964.0 5965.4 6027.4 5462.5 5484.3 5498.6 5499.3 5500.1 5954.9 5955.3 5970.5 5970.6 5977.2 5689.2 5727.5 5752.9 5900.4 5938.3 5841.2 5856.0 5866.7 5878.1 5939.9 5838.4 5845.9 5850.2 5855.5 5864.9 5663.2 5776.5 5794.5 5857.8 5902.9 4524.3 4528.5 4529.7 4545.9 4561.2 4042.5 4045.4 4049.3 4055.2 4061.9 5367.3 5528.1 5541.1 5648.7 5727.6 5935.0 5947.3 5972.6 5985.4 5985.6 5457.5 5659.2 5667.6 5676.1 5689.4 4932.2 4942.8 5026.8 5046.5 5095.8 6227.5 6297.1 6305.3 6306.1 6306.7 5850.8 6036.4 6046.9 6069.6 6076.7 6025.7 6040.4 6109.9 6110.6 6139.1 5753.8 5843.0 5851.3 5869.2 5871.0 5759.2 5837.7 5920.6 5937.7 5984.9 5652.1 5841.2 5859.2 5874.2 5875.4 5754.5 5776.7 5785.5 5795.6 5802.1 5400.7 5510.5 5512.4 5517.0 5628.4 5640.8 5670.3 5684.9 5810.4 5834.9 5659.3 5684.4 5705.2 5730.3 5760.1 07:10:12 INFO - 2015-11-15 07:10:12,171 DEBUG : BROWSER_OUTPUT: 07:10:12 INFO - 2015-11-15 07:10:12,171 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46613.64 Median:39476.61 stddev:77508.56 (196.3%) stddev-sans-first:77648.86 07:10:12 INFO - 2015-11-15 07:10:12,171 DEBUG : BROWSER_OUTPUT: Values: 561.5 591.7 600.2 600.4 608.9 39479.0 40460.6 40470.8 40493.2 40663.4 42126.4 42805.4 42884.6 42937.0 43024.8 8620.9 8773.0 8791.0 8794.7 8805.3 8572.2 8625.5 8646.3 8650.9 8679.4 8628.3 8646.5 8663.7 8694.4 8702.1 8621.8 8658.3 8680.0 8710.9 8717.6 8554.3 8691.4 8692.9 8695.0 8713.0 39474.2 39946.8 39974.6 40109.6 40170.0 3227.3 3239.8 3462.8 3614.5 4057.5 28736.0 29407.7 29418.9 29781.1 29858.3 3327.3 3363.5 3364.8 3416.8 3498.8 280418.0 281421.6 281607.0 281850.0 282704.0 42331.2 55282.7 55643.0 55698.2 55915.4 41617.4 41848.8 41958.2 42040.4 42055.4 14440.1 14532.6 14615.7 14662.6 14673.6 11795.6 11869.3 11959.7 12011.3 12033.6 13897.4 13921.4 13977.8 14211.4 14283.7 5849.3 5876.2 5883.7 5900.8 5907.5 931.9 932.6 950.4 1019.3 1122.6 28099.0 28240.0 28249.6 28535.9 28776.7 1024.2 1038.7 1107.5 1132.0 1170.9 14578.6 14735.5 14871.0 14884.1 15123.4 306559.0 312397.0 313898.0 314915.0 315148.0 51239.5 51426.0 51541.5 51571.0 51609.7 1304.8 1335.8 1340.2 1353.9 1358.5 27225.6 28014.6 28126.0 31713.5 32769.3 50776.5 51340.7 51373.0 51478.0 51526.0 292715.0 295758.0 295897.0 296068.0 296601.0 42112.0 46230.8 46337.8 47487.8 47669.8 43478.1 43622.8 43905.8 44214.3 44292.3 36740.3 36806.0 38611.8 42159.8 42813.1 36647.0 37067.8 37167.4 37171.7 37530.6 37808.0 40398.2 40962.2 41434.2 41576.4 29290.7 30468.2 33225.8 33279.7 34035.1 25451.7 25703.5 25991.4 26143.1 26233.3 07:10:12 INFO - 2015-11-15 07:10:12,171 DEBUG : BROWSER_OUTPUT: 07:10:12 INFO - 2015-11-15 07:10:12,171 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27821.21 Median:24738.17 stddev:90596.29 (366.2%) stddev-sans-first:90826.95 07:10:12 INFO - 2015-11-15 07:10:12,172 DEBUG : BROWSER_OUTPUT: Values: 351.9 353.9 354.3 355.0 356.6 12088.6 12325.9 16557.0 17018.1 17655.0 11609.8 11641.2 11682.9 11819.7 12081.2 4440.4 4527.5 4534.5 4549.2 4555.9 4372.1 4502.9 4506.0 4508.9 4512.4 4496.9 4499.6 4708.7 4807.9 4816.5 4728.7 4782.0 4788.3 4797.3 4797.9 4292.1 4294.7 4298.8 4313.7 4315.4 13087.8 13173.3 13263.2 13265.3 13406.1 1830.3 1869.2 1887.2 1974.5 1990.3 9582.9 9709.2 9824.8 9958.6 10005.7 1618.2 1623.9 1643.5 1679.2 1693.8 60289.1 61453.0 61557.4 62104.0 62807.0 6620.0 6803.4 6811.5 6827.7 6847.8 8101.1 8115.8 8130.5 8141.1 8145.9 5486.8 5530.0 5562.6 5577.6 5585.7 5703.6 5704.7 5741.1 5768.5 5777.2 3004.9 3096.0 3098.0 3100.7 3109.5 1116.0 1119.2 1119.8 1126.5 1171.2 382.2 402.5 406.9 416.4 420.9 9302.6 9400.7 9614.6 10092.9 10190.3 400.9 412.6 440.0 444.7 452.4 6428.3 6905.3 6911.8 6916.2 7143.7 545986.0 547791.0 553548.0 558923.0 559627.0 76568.6 77631.2 77886.2 78625.6 78799.6 556.0 566.3 566.7 567.7 568.6 9589.3 9637.3 11277.9 11628.7 11779.1 33609.7 33920.2 34389.3 35404.8 35479.8 44149.0 44976.8 45545.0 46184.8 46262.8 15148.8 15218.3 15265.1 15567.6 15595.5 19053.0 19257.2 19325.7 19418.1 19648.1 8238.9 9004.4 9132.4 9214.5 16095.1 8681.7 8927.6 9039.1 9219.4 9330.3 8881.1 9018.1 9172.4 9371.3 9437.2 14139.6 14368.3 14614.0 14659.7 14728.2 15038.1 15087.7 15226.5 15569.3 15652.2 07:10:12 INFO - 2015-11-15 07:10:12,173 DEBUG : BROWSER_OUTPUT: 07:10:12 INFO - 2015-11-15 07:10:12,173 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5276.23 Median:6426.05 stddev:2691.00 (41.9%) stddev-sans-first:2683.82 07:10:12 INFO - 2015-11-15 07:10:12,173 DEBUG : BROWSER_OUTPUT: Values: 1530.4 1691.9 1744.1 1758.3 1758.9 6824.3 6973.1 7463.4 7609.8 7666.3 6877.5 7047.6 7298.0 7474.6 7526.3 2188.3 2240.0 2252.6 2263.4 2264.6 2247.8 2270.3 2277.2 2287.6 2294.9 2187.9 2220.2 2231.6 2252.3 2264.2 2232.9 2233.0 2241.1 2246.5 2268.8 2234.3 2242.3 2242.8 2246.9 2247.1 7387.5 7416.0 7425.2 7435.6 7438.4 4350.5 4369.4 4384.8 4405.9 4409.8 2841.4 2943.4 2945.3 2977.9 2992.1 917.2 933.0 938.2 961.9 974.4 9819.2 9886.6 9987.1 10001.6 10010.9 4027.3 4049.6 4054.6 4059.7 4090.3 8248.3 8264.0 8285.9 8343.4 8395.2 4562.5 4570.7 4572.4 4578.9 4580.3 4123.1 4148.1 4155.6 4217.4 4243.7 3456.3 3458.0 3465.6 3488.6 3494.6 1057.6 1066.3 1067.2 1068.8 1086.1 1331.3 1335.1 1348.8 1352.9 1365.6 6984.2 7142.6 7148.9 7154.2 7156.0 1117.3 1126.2 1141.4 1151.9 1161.1 5658.3 5699.4 5708.7 5728.4 5734.8 8977.8 9137.7 9395.7 9515.3 9623.1 9292.3 9375.0 9387.9 9437.2 9476.1 7029.7 7118.4 7179.6 7190.0 7246.1 6871.9 6890.3 6908.4 6911.9 6916.4 7974.6 7998.5 8112.6 8116.2 8151.1 8246.9 8336.6 8351.5 8401.7 8455.0 5580.1 5748.1 6187.0 6463.4 6517.2 7263.7 7272.3 7279.0 7298.3 7304.4 6710.1 6856.5 6884.9 6905.6 7037.2 6700.0 6735.5 6771.2 6827.7 6831.5 6749.0 6801.0 6824.1 6833.5 6859.7 6323.8 6363.7 6386.6 6392.7 6405.9 6421.1 6431.0 6433.3 6438.8 6453.3 07:10:12 INFO - 2015-11-15 07:10:12,173 DEBUG : BROWSER_OUTPUT: 07:10:12 INFO - 2015-11-15 07:10:12,173 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5594.32 Median:6507.06 stddev:1760.14 (27.0%) stddev-sans-first:1719.66 07:10:12 INFO - 2015-11-15 07:10:12,173 DEBUG : BROWSER_OUTPUT: Values: 301.4 309.7 312.6 323.3 325.3 6253.4 6383.2 6449.5 6513.2 6557.2 6295.6 6322.7 6374.4 6381.9 6385.8 4599.1 4725.7 4726.2 4735.5 4744.0 4700.2 4711.0 4720.9 4722.1 4739.9 4656.1 4659.8 4661.3 4664.8 4667.4 4658.1 4672.3 4672.6 4685.3 4686.1 3907.1 4007.1 4012.1 4014.1 4026.2 5919.6 5924.1 5926.6 5934.4 5979.9 5358.6 5408.6 5409.1 5420.5 5444.4 6601.1 6624.6 6632.3 6643.8 6666.3 4360.9 4441.0 4454.6 4463.8 4468.8 6878.1 6942.1 6949.5 6954.9 6955.6 4483.9 4501.5 4509.3 4511.5 4517.3 4497.1 4548.8 4560.3 4561.0 4568.6 5472.3 5473.1 5474.0 5480.7 5486.4 6767.7 6778.5 6790.9 6793.3 6805.0 1624.6 1640.5 1644.7 1645.8 1646.7 1051.8 1067.8 1080.9 1104.9 1130.1 6342.3 6522.1 6523.3 6523.7 6533.4 6964.8 6989.8 7011.6 7030.0 7032.8 6521.8 6532.4 6533.1 6566.0 6586.9 3748.6 3769.0 3778.7 3808.0 3820.8 7383.0 7383.9 7390.6 7392.8 7405.3 7192.4 7215.1 7238.0 7242.5 7249.1 7184.4 7336.1 7366.0 7375.5 7383.5 6974.8 6999.8 7015.6 7017.5 7024.1 6886.2 6930.8 6940.2 6941.4 6947.5 7140.0 7332.1 7353.3 7374.0 7381.0 4563.2 4572.2 4590.6 4611.0 4618.3 6989.1 7007.1 7009.8 7012.7 7024.8 6666.5 6732.4 6793.0 6806.7 6810.9 6770.2 6772.9 6773.1 6789.2 6789.5 6450.5 6500.9 6547.0 6570.3 6580.0 6671.2 6741.1 6830.2 6831.3 6840.8 6623.6 6663.9 6666.7 6682.8 6693.5 07:10:12 INFO - 2015-11-15 07:10:12,173 DEBUG : BROWSER_OUTPUT: 07:10:12 INFO - 2015-11-15 07:10:12,173 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13483.61 Median:47048.65 stddev:16063.56 (34.1%) stddev-sans-first:16080.09 07:10:12 INFO - 2015-11-15 07:10:12,174 DEBUG : BROWSER_OUTPUT: Values: 732.5 745.9 756.2 756.6 775.3 15308.6 15609.9 15617.8 15654.3 15663.8 14350.6 14426.8 14432.9 14535.4 14587.8 801.3 803.9 812.4 814.4 815.7 817.7 821.1 822.6 823.6 828.2 859.9 860.6 863.0 866.0 866.7 859.7 859.8 860.4 861.0 862.4 618.1 623.8 625.4 625.6 630.3 12852.7 13034.9 13068.5 13070.2 13102.1 9625.3 9774.5 10369.7 10534.7 10656.4 9696.1 9983.5 10019.7 10243.8 10319.2 3138.8 3184.6 3213.6 3245.1 3253.2 45701.3 46423.3 46597.5 47031.5 47065.8 7098.4 7380.7 7385.3 7423.2 7466.9 12157.6 12164.4 12192.5 12217.5 12238.7 6279.7 6449.2 6601.0 6628.1 6817.4 4233.4 4251.5 4279.1 4324.8 4352.1 2811.6 2828.1 2837.7 2846.0 2846.1 411.4 420.3 421.6 426.8 430.4 486.0 495.4 549.9 552.6 627.8 7938.6 8010.6 8226.8 8373.5 8397.5 513.3 565.0 581.9 582.2 670.0 4033.5 4106.3 4250.7 4301.0 4410.4 53641.5 58411.0 58493.0 59014.7 59320.0 49527.8 49604.5 49735.0 49924.5 50403.0 45036.0 45554.3 47863.0 49780.3 50445.7 8574.3 8794.3 9143.8 9249.3 9314.3 35125.8 35326.0 35326.8 36789.0 36803.8 42460.8 45974.3 47086.3 47412.0 48514.3 8171.3 8498.0 8510.7 8749.0 8877.8 11820.6 12479.9 12521.4 12533.8 12577.3 9948.9 10082.6 10129.6 10292.4 11408.1 10848.2 11055.0 11073.3 11779.9 11937.8 11119.9 11140.5 11224.4 11226.7 11411.4 10007.9 10013.6 10285.6 10471.1 10620.4 9007.8 9432.0 10005.7 10066.0 10113.2 07:10:12 INFO - 2015-11-15 07:10:12,175 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:10:12 INFO - 2015-11-15 07:10:12,175 DEBUG : BROWSER_OUTPUT: 07:10:12 INFO - 2015-11-15 07:10:12,847 INFO : Browser exited with error code: 0 07:10:12 INFO - 2015-11-15 07:10:12,871 INFO : Completed test dromaeo_css (00:18:30) 07:10:12 INFO - 2015-11-15 07:10:12,871 INFO : Starting test kraken 07:10:12 INFO - 2015-11-15 07:10:12,871 DEBUG : operating with platform_type : linux_ 07:10:12 INFO - 2015-11-15 07:10:12,871 INFO : Initialising browser for kraken test... 07:10:12 INFO - 2015-11-15 07:10:12,877 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRYwhgJ/profile http://localhost:32830/getInfo.html 07:10:17 INFO - 2015-11-15 07:10:17,873 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:10:17 INFO - 2015-11-15 07:10:17,873 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:10:17 INFO - 2015-11-15 07:10:17,874 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:10:17 INFO - 2015-11-15 07:10:17,874 DEBUG : BROWSER_OUTPUT: __metrics 07:10:19 INFO - 2015-11-15 07:10:19,051 INFO : Browser initialized. 07:10:19 INFO - 2015-11-15 07:10:19,052 INFO : Running cycle 1/1 for kraken test... 07:10:19 INFO - 2015-11-15 07:10:19,052 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRYwhgJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:10:30 INFO - 2015-11-15 07:10:30,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 141254656 07:10:30 INFO - 2015-11-15 07:10:30,894 DEBUG : BROWSER_OUTPUT: 07:10:33 INFO - 2015-11-15 07:10:33,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32830/tests/kraken/driver.html?testName=audio-beat-detection) 07:10:33 INFO - 2015-11-15 07:10:33,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 141266944 07:10:33 INFO - 2015-11-15 07:10:33,959 DEBUG : BROWSER_OUTPUT: 07:10:36 INFO - 2015-11-15 07:10:36,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32830/tests/kraken/driver.html?testName=audio-dft) 07:10:37 INFO - 2015-11-15 07:10:37,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 141688832 07:10:37 INFO - 2015-11-15 07:10:37,182 DEBUG : BROWSER_OUTPUT: 07:10:40 INFO - 2015-11-15 07:10:40,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32830/tests/kraken/driver.html?testName=audio-fft) 07:10:40 INFO - 2015-11-15 07:10:40,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 136859648 07:10:40 INFO - 2015-11-15 07:10:40,635 DEBUG : BROWSER_OUTPUT: 07:10:42 INFO - 2015-11-15 07:10:42,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32830/tests/kraken/driver.html?testName=audio-oscillator) 07:10:43 INFO - 2015-11-15 07:10:43,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 136400896 07:10:43 INFO - 2015-11-15 07:10:43,152 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-11-15 07:10:45,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32830/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:10:45 INFO - 2015-11-15 07:10:45,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 136900608 07:10:45 INFO - 2015-11-15 07:10:45,933 DEBUG : BROWSER_OUTPUT: 07:10:48 INFO - 2015-11-15 07:10:48,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32830/tests/kraken/driver.html?testName=imaging-darkroom) 07:10:49 INFO - 2015-11-15 07:10:49,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 136962048 07:10:49 INFO - 2015-11-15 07:10:49,538 DEBUG : BROWSER_OUTPUT: 07:10:52 INFO - 2015-11-15 07:10:52,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32830/tests/kraken/driver.html?testName=imaging-desaturate) 07:10:53 INFO - 2015-11-15 07:10:53,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 138203136 07:10:53 INFO - 2015-11-15 07:10:53,516 DEBUG : BROWSER_OUTPUT: 07:10:56 INFO - 2015-11-15 07:10:56,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32830/tests/kraken/driver.html?testName=json-parse-financial) 07:10:56 INFO - 2015-11-15 07:10:56,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 138440704 07:10:56 INFO - 2015-11-15 07:10:56,940 DEBUG : BROWSER_OUTPUT: 07:10:58 INFO - 2015-11-15 07:10:58,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32830/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:10:59 INFO - 2015-11-15 07:10:59,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 139108352 07:10:59 INFO - 2015-11-15 07:10:59,135 DEBUG : BROWSER_OUTPUT: 07:11:00 INFO - 2015-11-15 07:11:00,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32830/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:01 INFO - 2015-11-15 07:11:01,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 139616256 07:11:01 INFO - 2015-11-15 07:11:01,577 DEBUG : BROWSER_OUTPUT: 07:11:03 INFO - 2015-11-15 07:11:03,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32830/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:04 INFO - 2015-11-15 07:11:04,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 139272192 07:11:04 INFO - 2015-11-15 07:11:04,283 DEBUG : BROWSER_OUTPUT: 07:11:06 INFO - 2015-11-15 07:11:06,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:07 INFO - 2015-11-15 07:11:07,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 140050432 07:11:07 INFO - 2015-11-15 07:11:07,341 DEBUG : BROWSER_OUTPUT: 07:11:09 INFO - 2015-11-15 07:11:09,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:10 INFO - 2015-11-15 07:11:10,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 138780672 07:11:10 INFO - 2015-11-15 07:11:10,510 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32830/tests/kraken/driver.html?testName=ai-astar) 07:11:12 INFO - 2015-11-15 07:11:12,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 138387456 07:11:12 INFO - 2015-11-15 07:11:12,445 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,446 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:11:12 INFO - 2015-11-15 07:11:12,447 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:11:12 INFO - 2015-11-15 07:11:12,447 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:11:12 INFO - 2015-11-15 07:11:12,447 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:11:12 INFO - 2015-11-15 07:11:12,447 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;108;112;111;110;123;112;112;110;111 07:11:12 INFO - 2015-11-15 07:11:12,448 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;135;155;160;125;151;151;126;164;126 07:11:12 INFO - 2015-11-15 07:11:12,448 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;161;160;161;160;162;166;168;162 07:11:12 INFO - 2015-11-15 07:11:12,448 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;73;73;130;72;73;72;73 07:11:12 INFO - 2015-11-15 07:11:12,449 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;142;91;92;91;135;90;93;135 07:11:12 INFO - 2015-11-15 07:11:12,449 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;114;110;109;110;109;109;110;110;109;109 07:11:12 INFO - 2015-11-15 07:11:12,449 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;146;148;146;147;146;146;146;148;147 07:11:12 INFO - 2015-11-15 07:11:12,449 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;97;96;96;97;101;96;96;96 07:11:12 INFO - 2015-11-15 07:11:12,450 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;63;64;63;62;62;61;62;60;61 07:11:12 INFO - 2015-11-15 07:11:12,450 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;71;69;70;72;71;69;70;69 07:11:12 INFO - 2015-11-15 07:11:12,450 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;86;86;92;84;93;85;100;86 07:11:12 INFO - 2015-11-15 07:11:12,450 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;122;115;128;115;132;125;118;120;124 07:11:12 INFO - 2015-11-15 07:11:12,451 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;152;151;156;153;140;150;152;150;137 07:11:12 INFO - 2015-11-15 07:11:12,451 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;69;69;67;67;67;68;66;67 07:11:12 INFO - 2015-11-15 07:11:12,451 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:11:12 INFO - 2015-11-15 07:11:12,452 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:11:12 INFO - 2015-11-15 07:11:12,452 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,742 07:11:12 INFO - 2015-11-15 07:11:12,452 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:11:12 INFO - 2015-11-15 07:11:12,452 DEBUG : BROWSER_OUTPUT: __startTimestamp1447600272446__endTimestamp 07:11:12 INFO - 2015-11-15 07:11:12,452 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,456 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:11:12 INFO - 2015-11-15 07:11:12,456 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:11:12 INFO - 2015-11-15 07:11:12,456 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,456 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.00 Median:111.50 stddev:4.06 (3.6%) stddev-sans-first:4.28 07:11:12 INFO - 2015-11-15 07:11:12,456 DEBUG : BROWSER_OUTPUT: Values: 111.0 108.0 112.0 111.0 110.0 123.0 112.0 112.0 110.0 111.0 07:11:12 INFO - 2015-11-15 07:11:12,457 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,457 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.00 Median:153.00 stddev:15.36 (10.0%) stddev-sans-first:15.67 07:11:12 INFO - 2015-11-15 07:11:12,457 DEBUG : BROWSER_OUTPUT: Values: 157.0 135.0 155.0 160.0 125.0 151.0 151.0 126.0 164.0 126.0 07:11:12 INFO - 2015-11-15 07:11:12,457 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,457 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:2.59 (1.6%) stddev-sans-first:2.74 07:11:12 INFO - 2015-11-15 07:11:12,457 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 161.0 160.0 161.0 160.0 162.0 166.0 168.0 162.0 07:11:12 INFO - 2015-11-15 07:11:12,457 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,458 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.40 Median:73.00 stddev:18.14 (24.8%) stddev-sans-first:19.13 07:11:12 INFO - 2015-11-15 07:11:12,458 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 73.0 73.0 130.0 72.0 73.0 72.0 73.0 07:11:12 INFO - 2015-11-15 07:11:12,458 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,458 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.20 Median:91.00 stddev:22.27 (24.5%) stddev-sans-first:23.02 07:11:12 INFO - 2015-11-15 07:11:12,458 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 142.0 91.0 92.0 91.0 135.0 90.0 93.0 135.0 07:11:12 INFO - 2015-11-15 07:11:12,459 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,459 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:1.52 (1.4%) stddev-sans-first:0.53 07:11:12 INFO - 2015-11-15 07:11:12,459 DEBUG : BROWSER_OUTPUT: Values: 114.0 110.0 109.0 110.0 109.0 109.0 110.0 110.0 109.0 109.0 07:11:12 INFO - 2015-11-15 07:11:12,459 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,459 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:0.87 07:11:12 INFO - 2015-11-15 07:11:12,459 DEBUG : BROWSER_OUTPUT: Values: 149.0 146.0 148.0 146.0 147.0 146.0 146.0 146.0 148.0 147.0 07:11:12 INFO - 2015-11-15 07:11:12,459 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,459 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:1.62 07:11:12 INFO - 2015-11-15 07:11:12,459 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 97.0 96.0 96.0 97.0 101.0 96.0 96.0 96.0 07:11:12 INFO - 2015-11-15 07:11:12,459 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,459 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.90 Median:62.50 stddev:3.07 (4.9%) stddev-sans-first:1.22 07:11:12 INFO - 2015-11-15 07:11:12,460 DEBUG : BROWSER_OUTPUT: Values: 71.0 63.0 64.0 63.0 62.0 62.0 61.0 62.0 60.0 61.0 07:11:12 INFO - 2015-11-15 07:11:12,460 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,460 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:1.05 (1.5%) stddev-sans-first:1.05 07:11:12 INFO - 2015-11-15 07:11:12,460 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 71.0 69.0 70.0 72.0 71.0 69.0 70.0 69.0 07:11:12 INFO - 2015-11-15 07:11:12,460 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,460 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:86.00 stddev:5.10 (5.9%) stddev-sans-first:5.27 07:11:12 INFO - 2015-11-15 07:11:12,460 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 86.0 86.0 92.0 84.0 93.0 85.0 100.0 86.0 07:11:12 INFO - 2015-11-15 07:11:12,460 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,460 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:123.00 stddev:5.68 (4.6%) stddev-sans-first:5.78 07:11:12 INFO - 2015-11-15 07:11:12,460 DEBUG : BROWSER_OUTPUT: Values: 117.0 122.0 115.0 128.0 115.0 132.0 125.0 118.0 120.0 124.0 07:11:12 INFO - 2015-11-15 07:11:12,461 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,461 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:151.50 stddev:6.56 (4.3%) stddev-sans-first:6.26 07:11:12 INFO - 2015-11-15 07:11:12,461 DEBUG : BROWSER_OUTPUT: Values: 140.0 152.0 151.0 156.0 153.0 140.0 150.0 152.0 150.0 137.0 07:11:12 INFO - 2015-11-15 07:11:12,461 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-15 07:11:12,461 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 07:11:12 INFO - 2015-11-15 07:11:12,461 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 69.0 69.0 67.0 67.0 67.0 68.0 66.0 67.0 07:11:12 INFO - 2015-11-15 07:11:12,461 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:11:12 INFO - 2015-11-15 07:11:12,461 DEBUG : BROWSER_OUTPUT: 07:11:13 INFO - 2015-11-15 07:11:13,379 INFO : Browser exited with error code: 0 07:11:13 INFO - 2015-11-15 07:11:13,429 INFO : Completed test kraken (00:01:00) 07:11:13 INFO - 2015-11-15 07:11:13,429 INFO : Starting test v8_7 07:11:13 INFO - 2015-11-15 07:11:13,429 DEBUG : operating with platform_type : linux_ 07:11:13 INFO - 2015-11-15 07:11:13,429 INFO : Initialising browser for v8_7 test... 07:11:13 INFO - 2015-11-15 07:11:13,436 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphwUxPz/profile http://localhost:32830/getInfo.html 07:11:18 INFO - 2015-11-15 07:11:18,386 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:11:18 INFO - 2015-11-15 07:11:18,386 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:11:18 INFO - 2015-11-15 07:11:18,387 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:11:18 INFO - 2015-11-15 07:11:18,387 DEBUG : BROWSER_OUTPUT: __metrics 07:11:19 INFO - 2015-11-15 07:11:19,411 INFO : Browser initialized. 07:11:19 INFO - 2015-11-15 07:11:19,412 INFO : Running cycle 1/1 for v8_7 test... 07:11:19 INFO - 2015-11-15 07:11:19,412 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphwUxPz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:11:31 INFO - 2015-11-15 07:11:31,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 141651968 07:11:31 INFO - 2015-11-15 07:11:31,218 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32830/tests/v8_7/run.html (next: http://localhost:32830/tests/v8_7/run.html) 07:11:52 INFO - 2015-11-15 07:11:52,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 137424896 07:11:52 INFO - 2015-11-15 07:11:52,844 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,844 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:11:52 INFO - 2015-11-15 07:11:52,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:11:52 INFO - 2015-11-15 07:11:52,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:11:52 INFO - 2015-11-15 07:11:52,845 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:11:52 INFO - 2015-11-15 07:11:52,845 DEBUG : BROWSER_OUTPUT: |0;Richards;161.96954972465176 07:11:52 INFO - 2015-11-15 07:11:52,845 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.8649270913277 07:11:52 INFO - 2015-11-15 07:11:52,845 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.214848143982 07:11:52 INFO - 2015-11-15 07:11:52,845 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5065.656565656565 07:11:52 INFO - 2015-11-15 07:11:52,846 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1063.8297872340424 07:11:52 INFO - 2015-11-15 07:11:52,846 DEBUG : BROWSER_OUTPUT: |5;Earley;738.2005899705015 07:11:52 INFO - 2015-11-15 07:11:52,846 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 07:11:52 INFO - 2015-11-15 07:11:52,846 DEBUG : BROWSER_OUTPUT: |7;RegExp;25225 07:11:52 INFO - 2015-11-15 07:11:52,846 DEBUG : BROWSER_OUTPUT: |8;Splay;638.6768447837151 07:11:52 INFO - 2015-11-15 07:11:52,846 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 07:11:52 INFO - 2015-11-15 07:11:52,847 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:11:52 INFO - 2015-11-15 07:11:52,847 DEBUG : BROWSER_OUTPUT: __startTimestamp1447600312843__endTimestamp 07:11:52 INFO - 2015-11-15 07:11:52,847 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,847 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:11:52 INFO - 2015-11-15 07:11:52,847 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:11:52 INFO - 2015-11-15 07:11:52,847 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,848 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:161.97 Median:161.97 stddev:0.00 (0.0%) 07:11:52 INFO - 2015-11-15 07:11:52,848 DEBUG : BROWSER_OUTPUT: Values: 162.0 07:11:52 INFO - 2015-11-15 07:11:52,848 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,849 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.86 Median:191.86 stddev:0.00 (0.0%) 07:11:52 INFO - 2015-11-15 07:11:52,849 DEBUG : BROWSER_OUTPUT: Values: 191.9 07:11:52 INFO - 2015-11-15 07:11:52,849 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,849 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.21 Median:281.21 stddev:0.00 (0.0%) 07:11:52 INFO - 2015-11-15 07:11:52,849 DEBUG : BROWSER_OUTPUT: Values: 281.2 07:11:52 INFO - 2015-11-15 07:11:52,849 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,849 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5065.66 Median:5065.66 stddev:0.00 (0.0%) 07:11:52 INFO - 2015-11-15 07:11:52,850 DEBUG : BROWSER_OUTPUT: Values: 5065.7 07:11:52 INFO - 2015-11-15 07:11:52,850 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,850 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 07:11:52 INFO - 2015-11-15 07:11:52,850 DEBUG : BROWSER_OUTPUT: Values: 1063.8 07:11:52 INFO - 2015-11-15 07:11:52,850 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,850 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:738.20 Median:738.20 stddev:0.00 (0.0%) 07:11:52 INFO - 2015-11-15 07:11:52,850 DEBUG : BROWSER_OUTPUT: Values: 738.2 07:11:52 INFO - 2015-11-15 07:11:52,850 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,850 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 07:11:52 INFO - 2015-11-15 07:11:52,850 DEBUG : BROWSER_OUTPUT: Values: 12207.3 07:11:52 INFO - 2015-11-15 07:11:52,851 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,851 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25225.00 Median:25225.00 stddev:0.00 (0.0%) 07:11:52 INFO - 2015-11-15 07:11:52,851 DEBUG : BROWSER_OUTPUT: Values: 25225.0 07:11:52 INFO - 2015-11-15 07:11:52,851 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,851 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:638.68 Median:638.68 stddev:0.00 (0.0%) 07:11:52 INFO - 2015-11-15 07:11:52,851 DEBUG : BROWSER_OUTPUT: Values: 638.7 07:11:52 INFO - 2015-11-15 07:11:52,851 DEBUG : BROWSER_OUTPUT: 07:11:52 INFO - 2015-11-15 07:11:52,851 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 07:11:52 INFO - 2015-11-15 07:11:52,851 DEBUG : BROWSER_OUTPUT: Values: 4835.7 07:11:52 INFO - 2015-11-15 07:11:52,852 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:11:52 INFO - 2015-11-15 07:11:52,852 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-15 07:11:53,751 INFO : Browser exited with error code: 0 07:11:53 INFO - 2015-11-15 07:11:53,763 INFO : Completed test v8_7 (00:00:40) 07:11:53 INFO - 2015-11-15 07:11:53,918 INFO : Completed test suite (00:20:11) 07:11:53 INFO - 2015-11-15 07:11:53,919 DEBUG : Working with test: dromaeo_css 07:11:53 INFO - 2015-11-15 07:11:53,919 DEBUG : Generating results file: dromaeo_css 07:11:53 INFO - 2015-11-15 07:11:53,920 DEBUG : Working with test: kraken 07:11:53 INFO - 2015-11-15 07:11:53,920 DEBUG : Generating results file: kraken 07:11:53 INFO - 2015-11-15 07:11:53,920 INFO : javascript benchmark 07:11:53 INFO - 2015-11-15 07:11:53,920 DEBUG : Working with test: v8_7 07:11:53 INFO - 2015-11-15 07:11:53,921 DEBUG : Generating results file: v8_7 07:11:53 INFO - 2015-11-15 07:11:53,921 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:54 INFO - 2015-11-15 07:11:54,101 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 07:11:54 INFO - 2015-11-15 07:11:54,102 DEBUG : process_Request line: dromaeo_css 6729.84 graph.html#tests=[[72,63,43]] 07:11:54 INFO - 2015-11-15 07:11:54,102 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:54 INFO - 2015-11-15 07:11:54,139 DEBUG : process_Request line: kraken 1515.00 graph.html#tests=[[232,63,43]] 07:11:54 INFO - 2015-11-15 07:11:54,139 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:54 INFO - 2015-11-15 07:11:54,179 DEBUG : process_Request line: v8_7 21257.50 graph.html#tests=[[230,63,43]] 07:11:54 INFO - 2015-11-15 07:11:54,180 INFO : javascript benchmark 07:11:54 INFO - 2015-11-15 07:11:54,184 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [351.9014675890751, 353.92390636013266, 354.26313268401725, 354.9716022718182, 356.6184182924269, 12088.637340879766, 12325.938370308137, 16557.0, 17018.14909254537, 17654.999999999985, 11609.825852612217, 11641.243319184247, 11682.883171168285, 11819.704507387298, 12081.214721043127, 4440.378347031418, 4527.52460991596, 4534.478534968472, 4549.203889319356, 4555.863324100283, 4372.147431250907, 4502.887427814315, 4506.031203291292, 4508.864734057967, 4512.413386259782, 4496.910061798762, 4499.572540608653, 4708.74101924394, 4807.927881081787, 4816.51834816519, 4728.69263497875, 4781.976090119562, 4788.305695674143, 4797.280407938802, 4797.904041919177, 4292.055747735493, 4294.656427485794, 4298.78506074695, 4313.741175529447, 4315.417418648473, 13087.803682944763, 13173.275469849155, 13263.204207747565, 13265.27041012744, 13406.12860164096, 1830.3136323878546, 1869.242956602578, 1887.160213704902, 1974.4570243183239, 1990.28349794074, 9582.90417095827, 9709.223262139012, 9824.803503929952, 9958.601655933753, 10005.748706541042, 1618.2151656446615, 1623.9431619893246, 1643.4823030745397, 1679.2443400469838, 1693.796744390681, 60289.09566356508, 61452.999999999556, 61557.384426155615, 62104.0, 62807.0, 6620.0, 6803.421709154777, 6811.489138314646, 6827.658617069127, 6847.794566163023, 8101.149379315205, 8115.79710507242, 8130.512169269863, 8141.1451797561585, 8145.918540814635, 5486.835394938158, 5530.004599172187, 5562.610617256753, 5577.581681373913, 5585.69278689676, 5703.572232082611, 5704.686242256716, 5741.081426971748, 5768.509676677446, 5777.162311464814, 3004.9399012019635, 3096.040227529473, 3098.024122401436, 3100.674429184903, 3109.455845227076, 1115.966521004371, 1119.1941801902617, 1119.8040342939953, 1126.4987080748988, 1171.1860257121389, 382.2126419575683, 402.4767801857573, 406.85759984005955, 416.4170161773541, 420.886360682614, 9302.581383837743, 9400.717978460658, 9614.615415383307, 10092.949535252277, 10190.337628054152, 400.93184158693094, 412.5688655355161, 439.9670024748157, 444.67760873367195, 452.4231604704029, 6428.325025872216, 6905.343992320722, 6911.75808846698, 6916.20463646677, 7143.678534465961, 545986.0, 547791.0, 553548.0, 558923.0, 559627.0, 76568.61715691385, 77631.2236877624, 77886.2211377879, 78625.60687196527, 78799.60600196962, 556.0491559433414, 566.3430420711954, 566.7081453051682, 567.701956472855, 568.6360729133359, 9589.280803939593, 9637.325387222827, 11277.887221128012, 11628.709282268012, 11779.116566257393, 33609.663903360655, 33920.15199620029, 34389.31221375508, 35404.822975884956, 35479.82260088683, 44149.0, 44976.77511612421, 45545.0, 46184.76907615441, 46262.768686156356, 15148.772768408262, 15218.315175816893, 15265.084094954338, 15567.610809729847, 15595.454159104831, 19053.0, 19257.22971081141, 19325.710114348014, 19418.126184322024, 19648.115834787182, 8238.876416853871, 9004.41471304363, 9132.406393584395, 9214.493202873906, 16095.114768687834, 8681.652733890574, 8927.598258078273, 9039.141281578239, 9219.44683319003, 9330.346875718635, 8881.111888811067, 9018.053104423941, 9172.44965302084, 9371.34400591952, 9437.19783818383, 14139.575812725634, 14368.281585920453, 14614.0, 14659.706805864036, 14728.189949552878, 15038.097714137186, 15087.698246035237, 15226.543203703906, 15569.299381527631, 15652.217389130727], "dojo.html": [3199.1522246604654, 3247.8376081195934, 3255.365203785263, 3272.999999999999, 3284.1625385526686, 5217.739113044351, 5445.128779395298, 5447.264619276401, 5464.207689884975, 5469.206964990074, 5442.619016668835, 5475.288212532375, 5484.945150548493, 5553.194786755918, 5557.3331200255925, 4674.7428891410955, 4916.0, 5099.36257967754, 5111.744412779365, 5149.0474262261605, 4890.779914903838, 5049.419316778581, 5088.720120393377, 5113.309703190059, 5115.718635475047, 4770.0459908018365, 4887.315775791392, 4915.827946021872, 4921.138800709861, 4977.377827771528, 5003.199488081926, 5025.773840177201, 5031.723255220962, 5053.67151135175, 5097.847064588032, 4872.293517439987, 4894.804207831682, 5014.623903207237, 5047.9495205048215, 5073.746312684388, 5134.614903882187, 5178.818741344035, 5224.529792318672, 5248.947510524884, 5273.024490469237, 5919.644821310735, 5938.198343223653, 5941.851453713649, 5948.405159484017, 5948.40515948406, 5789.131630255453, 5855.795047173371, 5964.045752679551, 5965.433283838029, 6027.397260273981, 5462.453754624546, 5484.2596249505805, 5498.5876059295715, 5499.257600223958, 5500.064988951848, 5954.880902382015, 5955.28536575605, 5970.462658360681, 5970.58205925581, 5977.193078934288, 5689.231953686282, 5727.4845263926445, 5752.884942301131, 5900.350961394243, 5938.317093534212, 5841.182234487175, 5855.970720146372, 5866.73599688015, 5878.147668588031, 5939.930812453714, 5838.38696936824, 5845.918505076575, 5850.2102216200265, 5855.473007429352, 5864.882702345929, 5663.207150998864, 5776.537876969833, 5794.536437085023, 5857.794977175864, 5902.852428689232, 4524.321351797257, 4528.547145285445, 4529.68292219548, 4545.886352841206, 4561.201789686792, 4042.5148982121746, 4045.37296719009, 4049.271131196354, 4055.168690418457, 4061.898452538651, 5367.329083864517, 5528.143137813645, 5541.085720856095, 5648.74580643872, 5727.599068065196, 5935.0, 5947.286325640865, 5972.58191926561, 5985.371535988658, 5985.581009329392, 5457.536109430664, 5659.151127330933, 5667.574931880125, 5676.091825307931, 5689.374168841424, 4932.161532539477, 4942.777575009133, 5026.773795179226, 5046.495350464924, 5095.821646242363, 6227.501799856001, 6297.118403423525, 6305.274893387227, 6306.085617585516, 6306.684665766693, 5850.824475265749, 6036.396360363929, 6046.939530604637, 6069.575129740876, 6076.665783381956, 6025.66858822769, 6040.36576159497, 6109.877802443837, 6110.649890384107, 6139.1098290746695, 5753.798617048383, 5843.0, 5851.297844258546, 5869.207656966255, 5871.031279838779, 5759.193712880284, 5837.737301821513, 5920.644761314163, 5937.732802023833, 5984.910226346521, 5652.095664693629, 5841.211436456194, 5859.20900678403, 5874.17761513397, 5875.353711091691, 5754.539636829128, 5776.682282474504, 5785.537157027344, 5795.59430839854, 5802.100674395476, 5400.675959442289, 5510.531604813636, 5512.3660779010925, 5517.034518959086, 5628.352739435018, 5640.774369025193, 5670.262865827416, 5684.857878553069, 5810.389909059657, 5834.94165058344, 5659.292588426447, 5684.3747187808485, 5705.22979397776, 5730.312362516524, 5760.107183386582], "mootools.html": [1530.3648985670948, 1691.8815682902198, 1744.0930716027665, 1758.2878934031721, 1758.9208485618146, 6824.317568243173, 6973.058637083992, 7463.365613922816, 7609.809754756134, 7666.271704188101, 6877.518573699843, 7047.647617619112, 7297.963510182455, 7474.588897610629, 7526.322630963212, 2188.3325585696357, 2239.9776002240014, 2252.6395776675736, 2263.411513006622, 2264.62633665445, 2247.7752224777473, 2270.2848602690183, 2277.1574517428576, 2287.62254228053, 2294.8737819419925, 2187.890605469728, 2220.200727738013, 2231.553689262146, 2252.2680128958073, 2264.2075273654254, 2232.9218477353215, 2232.966505502419, 2241.1147596699293, 2246.539459410817, 2268.7844654757773, 2234.273860995183, 2242.338510139513, 2242.798148166673, 2246.853954492969, 2247.1348530815753, 7387.519811212254, 7416.0, 7425.220351863085, 7435.628218589049, 7438.442116841258, 4350.499692535367, 4369.4319738434115, 4384.802683879233, 4405.933910991338, 4409.801558929824, 2841.417509410566, 2943.3818898031227, 2945.322575807555, 2977.8511074446405, 2992.132281638322, 917.2203626917134, 932.9766755831091, 938.2259635800424, 961.8653388525612, 974.3812678948848, 9819.165370943478, 9886.555105020292, 9987.051230133198, 10001.649942251986, 10010.89989100107, 4027.335489644176, 4049.595040495986, 4054.614811592894, 4059.654929330981, 4090.284200264942, 8248.309096635176, 8264.0, 8285.917140828515, 8343.415960882801, 8395.24442800151, 4562.498125206224, 4570.702904311209, 4572.428446444194, 4578.88552786183, 4580.312953057001, 4123.134141830189, 4148.149629325981, 4155.646770024582, 4217.40956266123, 4243.702940794176, 3456.2569047654874, 3458.0, 3465.6187819339852, 3488.5639295088113, 3494.5981212160927, 1057.5716834681812, 1066.2802608239408, 1067.1836045425257, 1068.8022715797447, 1086.0876863434594, 1331.2611500617056, 1335.118821577754, 1348.797680347936, 1352.8850047745855, 1365.5971488410942, 6984.2317345092, 7142.5714457132735, 7148.892766608505, 7154.248803875622, 7155.96422017897, 1117.3407689463256, 1126.2093271697877, 1141.4064686363045, 1151.9366434845997, 1161.1407558406718, 5658.321001479849, 5699.430056994351, 5708.743106560215, 5728.398518155617, 5734.799282025193, 8977.775555611031, 9137.725868223964, 9395.671151509665, 9515.286353523376, 9623.133917947418, 9292.349535532448, 9375.015623359586, 9387.90612093884, 9437.245020398488, 9476.099770521789, 7029.718811247493, 7118.394936430462, 7179.641017949186, 7189.964050179716, 7246.130464344313, 6871.931280687129, 6890.31096890307, 6908.447324214151, 6911.861762764616, 6916.412104971134, 7974.601269936364, 7998.520088794691, 8112.59437028158, 8116.228958248957, 8151.062627797879, 8246.917530824854, 8336.62485188156, 8351.540665263468, 8401.663933442594, 8455.02767181782, 5580.135079062752, 5748.051571490657, 6187.0, 6463.353664633499, 6517.217933847968, 7263.673134708845, 7272.309130632581, 7279.0, 7298.343149116605, 7304.379127774198, 6710.060591517094, 6856.485763567852, 6884.862302754017, 6905.620190889549, 7037.190723066913, 6699.9665001674675, 6735.4611631070375, 6771.187457505131, 6827.658617069027, 6831.45348372139, 6748.966255168889, 6801.0, 6824.078749368771, 6833.521653484208, 6859.691313890987, 6323.841903952438, 6363.681815909279, 6386.616802991835, 6392.744290228339, 6405.903911441425, 6421.068945003042, 6431.035344698333, 6433.292337842927, 6438.8390290243115, 6453.322401147811], "ext.html": [561.4525837308622, 591.7100620695858, 600.1927407636729, 600.3996003996004, 608.9465225160471, 39479.0, 40460.59539404605, 40470.7976460118, 40493.190136197256, 40663.390049149246, 42126.36810447846, 42805.357919631155, 42884.571154288446, 42937.0, 43024.78487607565, 8620.913790862089, 8773.034966153718, 8791.0, 8794.736157915273, 8805.295576353908, 8572.22849943505, 8625.525596092213, 8646.30829533639, 8650.913490865105, 8679.392442529026, 8628.309735221168, 8646.481211127353, 8663.696770613029, 8694.39139260252, 8702.086280940504, 8621.827563448727, 8658.264047555966, 8680.045195028573, 8710.912890871074, 8717.564121793885, 8554.272886804629, 8691.39160258782, 8692.869606955837, 8695.0, 8712.956435217846, 39474.21051578981, 39946.800265998776, 39974.60025399738, 40109.598904010876, 40170.0, 3227.2697816084524, 3239.7732158748895, 3462.792232466035, 3614.457831325296, 4057.4928133983253, 28736.0, 29407.70592294071, 29418.852905735548, 29781.10656680303, 29858.253543661365, 3327.3345330933666, 3363.461846104636, 3364.798112113281, 3416.8120753358803, 3498.7725797823314, 280418.0, 281421.59289203625, 281607.0, 281850.0, 282704.0, 42331.15337693229, 55282.72358638181, 55643.0, 55698.16452753212, 55915.44084559184, 41617.37573936393, 41848.790756046634, 41958.1608367837, 42040.36939445911, 42055.36916946248, 14440.133591984304, 14532.636684082983, 14615.707685846437, 14662.63343416423, 14673.633159170893, 11795.646130616095, 11869.287842729464, 11959.701007474883, 12011.279323240633, 12033.578824741093, 13897.374618142208, 13921.443142274196, 13977.790333144807, 14211.431542738175, 14283.714325713427, 5849.30254858185, 5876.206712093813, 5883.7058147092475, 5900.76396944126, 5907.49786268172, 931.902150274225, 932.6409332407072, 950.410745337881, 1019.3374306700704, 1122.6247846388274, 28099.0, 28240.0, 28249.57625635617, 28535.857320713265, 28776.71223287782, 1024.2267088348249, 1038.6624347087077, 1107.5016242690822, 1132.0231946011181, 1170.9180357374903, 14578.635534111732, 14735.484258050918, 14871.033382830297, 14884.10695358282, 15123.39506419753, 306559.0, 312397.0, 313898.0, 314915.0, 315148.0, 51239.48760512422, 51426.0, 51541.484585154416, 51571.0, 51609.74195129075, 1304.8108024336418, 1335.779596366608, 1340.2092765268537, 1353.8713822186876, 1358.5448874626913, 27225.59161612617, 28014.579781303706, 28126.0, 31713.524297136024, 32769.34461310808, 50776.49223507865, 51340.74329628328, 51373.0, 51478.0, 51526.0, 292715.0, 295758.0, 295897.0, 296068.0, 296601.0, 42112.0, 46230.76884615555, 46337.76831115823, 47487.76256118697, 47669.76165119152, 43478.13043739044, 43622.781886090364, 43905.78047109744, 44214.33678494889, 44292.33561496516, 36740.26519469649, 36806.0, 38611.806940965114, 42159.78920105503, 42813.143737125705, 36647.0, 37067.814660926524, 37167.442488362154, 37171.74533162671, 37530.62469375271, 37808.0, 40398.19203615852, 40962.18075638411, 41434.1713165741, 41576.376354355314, 29290.7070929288, 30468.23829404194, 33225.833870830495, 33279.667203327655, 34035.14912127217, 25451.74548254494, 25703.485930280916, 25991.350216243987, 26143.065635058556, 26233.344166395993], "prototype.html": [301.3535965354315, 309.65009539220677, 312.63577931709557, 323.3242523126666, 325.2551656706143, 6253.37466253375, 6383.170187875581, 6449.451796597289, 6513.185851768535, 6557.213134423864, 6295.559310848243, 6322.715477803498, 6374.394432528914, 6381.872362552746, 6385.776497822577, 4599.080183963204, 4725.716457012573, 4726.172919739049, 4735.526447355272, 4744.027474367746, 4700.1539722849875, 4710.976445117787, 4720.9141897363625, 4722.079194557063, 4739.857804265877, 4656.1153380857695, 4659.767011649421, 4661.324108004337, 4664.76676166192, 4667.439907211139, 4658.091672123937, 4672.299155126741, 4672.649551283634, 4685.2972054191805, 4686.133065382915, 3907.1013666856497, 4007.078371974433, 4012.0772222388723, 4014.0566966762785, 4026.1947610478023, 5919.55603329752, 5924.081767326028, 5926.555508336849, 5934.436228558323, 5979.9402005980255, 5358.571314294886, 5408.648437851527, 5409.0534156522845, 5420.457954204588, 5444.40111587725, 6601.075849381091, 6624.635645039521, 6632.2704502504685, 6643.833904152387, 6666.333366663343, 4360.89097772555, 4441.0, 4454.599086082236, 4463.821447142111, 4468.776561171929, 6878.140232470942, 6942.132233470817, 6949.548279361826, 6954.895676564855, 6955.617441040741, 4483.910321793546, 4501.504834468205, 4509.255972764523, 4511.503734589192, 4517.34498497716, 4497.145542346943, 4548.7725613719185, 4560.3354775506705, 4560.95439045612, 4568.588827005586, 5472.288602481652, 5473.06957817172, 5474.042042642522, 5480.671159730429, 5486.396496385394, 6767.729290828312, 6778.457723382117, 6790.932090679129, 6793.286704896013, 6805.0, 1624.5857306386795, 1640.5242479680996, 1644.6875093732153, 1645.7531370294553, 1646.703593353208, 1051.8211903976342, 1067.8344856547249, 1080.935143891369, 1104.8895110488886, 1130.1467392118898, 6342.302346741854, 6522.119513865662, 6523.347665233534, 6523.739050437929, 6533.379328963741, 6964.79105626832, 6989.755358562527, 7011.649417529103, 7029.9648501757165, 7032.824179395556, 6521.836954076091, 6532.444742196872, 6533.052707357407, 6566.0, 6586.868262634721, 3748.6063963283464, 3769.0012146781123, 3778.7165962552367, 3807.961920380816, 3820.789856557916, 7382.966384706146, 7383.9261607384315, 7390.630468476662, 7392.778216653509, 7405.259474052659, 7192.4246060315045, 7215.098112735908, 7238.0, 7242.529235599669, 7249.115230040227, 7184.353408193183, 7336.082989626297, 7365.9631701841145, 7375.483716139926, 7383.520071195355, 6974.755883544051, 6999.775039367988, 7015.579065256101, 7017.473689473208, 7024.086868707035, 6886.173659160932, 6930.826729331606, 6940.201876784235, 6941.375276225164, 6947.548409353376, 7140.0, 7332.0834895638045, 7353.301436363751, 7374.0, 7381.0, 4563.247064234364, 4572.177008138567, 4590.60979816706, 4610.985583171697, 4618.261078227468, 6989.056477375692, 7007.124109486314, 7009.7897063088185, 7012.684429200596, 7024.824379390556, 6666.466682665472, 6732.360425759545, 6792.966035169792, 6806.693698783468, 6810.8637827244165, 6770.205895437614, 6772.864542709217, 6773.085633439423, 6789.219239787488, 6789.524733268624, 6450.54846160783, 6500.934990650222, 6546.967265163644, 6570.342965703582, 6579.967100164468, 6671.199456065303, 6741.056252124608, 6830.180378354629, 6831.316868313129, 6840.760573379908, 6623.602583844985, 6663.866722665616, 6666.733330666719, 6682.76610318656, 6693.464522838259], "yui.html": [732.5494820685277, 745.8620155271274, 756.205983717097, 756.5649751392949, 775.2751177648895, 15308.617284567892, 15609.921950390246, 15617.765733514007, 15654.295556699948, 15663.843361566382, 14350.569482915504, 14426.78359824601, 14432.927835360835, 14535.418583256656, 14587.781183282259, 801.3148757812074, 803.9115697273324, 812.3825892321819, 814.3566582399926, 815.7022686719334, 817.7056259746487, 821.0639870547581, 822.5681517203486, 823.6005537314397, 828.159418190537, 859.8925134358205, 860.6170254236868, 862.965481380744, 866.0, 866.6966561703416, 859.7291853066326, 859.8194379180379, 860.3805260212637, 861.0141388110578, 862.3920136303891, 618.1099217127322, 623.8440389902524, 625.4339822460635, 625.6058683029707, 630.3098107572201, 12852.742945141139, 13034.869651303461, 13068.477260909553, 13070.215787052808, 13102.148360356547, 9625.278104142148, 9774.462404567746, 10369.688909332732, 10534.683959481228, 10656.360618362924, 9696.127348538665, 9983.450910199936, 10019.699409017741, 10243.846342304796, 10319.174466042774, 3138.843057847121, 3184.5860038194887, 3213.550102985584, 3245.1400378899375, 3253.186703324169, 45701.314480282825, 46423.30365044527, 46597.534024659995, 47031.5296847034, 47065.76467117677, 7098.396636285974, 7380.704771809067, 7385.335319821242, 7423.220561840929, 7466.925330746732, 12157.574484892986, 12164.391780410944, 12192.451339689735, 12217.511299548096, 12238.694032649255, 6279.717412716439, 6449.193850768654, 6600.966995165089, 6628.105205797156, 6817.352351526597, 4233.386159006988, 4251.4685664291965, 4279.144171165779, 4324.783760811947, 4352.107817897323, 2811.620431241797, 2828.1091456191643, 2837.6878543360212, 2845.9715402845704, 2846.146156153146, 411.4301692156385, 420.3211812922109, 421.6437110641503, 426.7951383336016, 430.38455009336326, 485.98542043738746, 495.42778091304604, 549.9147632116948, 552.5634748548601, 627.7551754815626, 7938.6030698466, 8010.599470026592, 8226.835463290701, 8373.49759014461, 8397.538135402612, 513.3147248423396, 564.9830505084853, 581.8719881626035, 582.1645938078871, 670.0284587348365, 4033.4756481657196, 4106.328307073292, 4250.702450828412, 4301.0, 4410.3825464435, 53641.46358536365, 58411.0, 58493.0, 59014.70492647509, 59320.0, 49527.75236123869, 49604.50395496071, 49735.0, 49924.50075499271, 50403.0, 45035.999999999345, 45554.316685249745, 47863.04273914572, 49780.253296200586, 50445.74777126091, 8574.31405487572, 8794.252488538546, 9143.77140571491, 9249.30630202751, 9314.301427392837, 35125.824370877985, 35326.0, 35326.82336588301, 36789.0, 36803.81598091992, 42460.78769606256, 45974.310385344914, 47086.293705595126, 47412.0, 48514.27228591644, 8171.305439037748, 8497.957510212409, 8510.659573616986, 8749.0, 8877.778055548662, 11820.645380638594, 12479.87520124787, 12521.37393130358, 12533.811992820298, 12577.308248046445, 9948.900510995087, 10082.647107351208, 10129.59481620727, 10292.433916134685, 11408.144389171011, 10848.186386020921, 11055.0, 11073.280236784583, 11779.941100294787, 11937.754834107187, 11119.944400278271, 11140.498677559692, 11224.438778061227, 11226.719332016764, 11411.372374519482, 10007.949960250153, 10013.599456021677, 10285.588576456857, 10471.109955653856, 10620.415877126832, 9007.774805629911, 9432.0, 10005.699829005142, 10066.0, 10113.24150688716]}, "summary": {"lowerIsBetter": false, "suite": 6729.8374116159775, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7131.933870892716, "unit": "ms", "value": 7131.933870892716}, "dojo.html": {"lowerIsBetter": false, "filtered": 5425.080106435421, "unit": "ms", "value": 5425.080106435421}, "mootools.html": {"lowerIsBetter": false, "filtered": 4372.578824674258, "unit": "ms", "value": 4372.578824674258}, "ext.html": {"lowerIsBetter": false, "filtered": 18298.274054035446, "unit": "ms", "value": 18298.274054035446}, "prototype.html": {"lowerIsBetter": false, "filtered": 5005.413044948916, "unit": "ms", "value": 5005.413044948916}, "yui.html": {"lowerIsBetter": false, "filtered": 5995.0149110883385, "unit": "ms", "value": 5995.0149110883385}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-034.e"}, "testrun": {"date": 1447599102, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115043023", "branch": "Mozilla-Inbound", "revision": "22360424ed1532c73c93aab85bfd9173899956f8"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 162.0, 161.0, 160.0, 161.0, 160.0, 162.0, 166.0, 168.0, 162.0], "ai-astar": [111.0, 108.0, 112.0, 111.0, 110.0, 123.0, 112.0, 112.0, 110.0, 111.0], "imaging-gaussian-blur": [114.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0], "audio-beat-detection": [157.0, 135.0, 155.0, 160.0, 125.0, 151.0, 151.0, 126.0, 164.0, 126.0], "json-stringify-tinderbox": [69.0, 70.0, 71.0, 69.0, 70.0, 72.0, 71.0, 69.0, 70.0, 69.0], "stanford-crypto-pbkdf2": [140.0, 152.0, 151.0, 156.0, 153.0, 140.0, 150.0, 152.0, 150.0, 137.0], "json-parse-financial": [71.0, 63.0, 64.0, 63.0, 62.0, 62.0, 61.0, 62.0, 60.0, 61.0], "stanford-crypto-sha256-iterative": [67.0, 67.0, 69.0, 69.0, 67.0, 67.0, 67.0, 68.0, 66.0, 67.0], "audio-fft": [73.0, 72.0, 73.0, 73.0, 73.0, 130.0, 72.0, 73.0, 72.0, 73.0], "imaging-darkroom": [149.0, 146.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 147.0], "stanford-crypto-ccm": [117.0, 122.0, 115.0, 128.0, 115.0, 132.0, 125.0, 118.0, 120.0, 124.0], "audio-oscillator": [91.0, 92.0, 142.0, 91.0, 92.0, 91.0, 135.0, 90.0, 93.0, 135.0], "stanford-crypto-aes": [85.0, 86.0, 86.0, 86.0, 92.0, 84.0, 93.0, 85.0, 100.0, 86.0], "imaging-desaturate": [96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 101.0, 96.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1514.9999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.4, "unit": "ms", "value": 78.4}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 148.1, "unit": "ms", "value": 148.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.0, "unit": "ms", "value": 145.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.6, "unit": "ms", "value": 121.6}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.9, "unit": "ms", "value": 146.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 62.9, "unit": "ms", "value": 62.9}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 105.2, "unit": "ms", "value": 105.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 112.0, "unit": "ms", "value": 112.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.5, "unit": "ms", "value": 162.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.4, "unit": "ms", "value": 67.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 70.0, "unit": "ms", "value": 70.0}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.9, "unit": "ms", "value": 109.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 88.3, "unit": "ms", "value": 88.3}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.8, "unit": "ms", "value": 96.8}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-034.e"}, "testrun": {"date": 1447599102, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115043023", "branch": "Mozilla-Inbound", "revision": "22360424ed1532c73c93aab85bfd9173899956f8"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.8649270913277], "Encrypt": [281.214848143982], "NavierStokes": [4835.748792270531], "Decrypt": [5065.656565656565], "Splay": [638.6768447837151], "Richards": [161.96954972465176], "RegExp": [25225.0], "Earley": [738.2005899705015], "Boyer": [12207.317073170732], "RayTrace": [1063.8297872340424]}, "summary": {"lowerIsBetter": false, "suite": 21257.5029094945, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.60701600000004, "unit": "score", "value": 344.60701600000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 946.5396360000002, "unit": "score", "value": 946.5396360000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.881118881119, "unit": "score", "value": 306.881118881119}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.54619940179463, "unit": "score", "value": 52.54619940179463}, "Splay": {"lowerIsBetter": false, "filtered": 127.59347808764934, "unit": "score", "value": 127.59347808764934}, "RegExp": {"lowerIsBetter": false, "filtered": 36.11437066402381, "unit": "score", "value": 36.11437066402381}, "Richards": {"lowerIsBetter": false, "filtered": 217.95454800000002, "unit": "score", "value": 217.95454800000002}, "Earley": {"lowerIsBetter": false, "filtered": 902.821006993007, "unit": "score", "value": 902.821006993007}, "Boyer": {"lowerIsBetter": false, "filtered": 54.595370629370635, "unit": "score", "value": 54.595370629370635}, "RayTrace": {"lowerIsBetter": false, "filtered": 695.5896600000003, "unit": "score", "value": 695.5896600000003}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-034.e"}, "testrun": {"date": 1447599102, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115043023", "branch": "Mozilla-Inbound", "revision": "22360424ed1532c73c93aab85bfd9173899956f8"}}] 07:11:54 INFO - RETURN: dromaeo_css: 6729.84 07:11:54 INFO - RETURN: kraken: 1515.00 07:11:54 INFO - RETURN: v8_7: 21257.50 07:11:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21257.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1515.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6729.84"}}} 07:11:54 INFO - Return code: 0 07:11:54 INFO - # TBPL SUCCESS # 07:11:54 INFO - Running post-action listener: _resource_record_post_action 07:11:54 INFO - Running post-run listener: _resource_record_post_run 07:11:55 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 20480; Write bytes: 275357696; Read time: 68; Write time: 178056 07:11:55 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 598016; Read time: 0; Write time: 48 07:11:55 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 16384; Write bytes: 270733312; Read time: 56; Write time: 177708 07:11:55 INFO - Running post-run listener: _upload_blobber_files 07:11:55 INFO - Blob upload gear active. 07:11:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:11:55 INFO - Copying logs to upload dir... 07:11:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.264639 ========= master_lag: 3.69 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-11-15 07:11:58.938264) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 07:11:58.941598) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009978 build_url: 'https://queue.taskcluster.net/v1/task/46NAZuBURyO_QhsqcjlDfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.03 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 07:11:58.982337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 07:11:58.982695) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447591456.896487-1230844539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.68 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 07:11:59.664452) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 07:11:59.664818) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 07:11:59.665672) ========= ========= Total master_lag: 4.51 =========