builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1448094815.15 results: success (0) buildid: 20151120223009 builduid: cb5dfffebce841b8a23a9166c06eae6c revision: de4585e9617cb5b888ebec7296080bc4c33acaa5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.154900) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.155347) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.155634) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006605 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.181709) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.181975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.223560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.223810) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004701 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.284844) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.285118) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.285445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.285709) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-21 00:33:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.7M=0s 2015-11-21 00:33:35 (54.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172804 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.483962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.484265) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017054 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.538839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:35.539176) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev de4585e9617cb5b888ebec7296080bc4c33acaa5 --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 de4585e9617cb5b888ebec7296080bc4c33acaa5 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-21 00:33:35,787 truncating revision to first 12 chars 2015-11-21 00:33:35,787 Setting DEBUG logging. 2015-11-21 00:33:35,787 attempt 1/10 2015-11-21 00:33:35,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/de4585e9617c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-21 00:33:36,017 unpacking tar archive at: mozilla-inbound-de4585e9617c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526693 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:36.079779) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:36.080057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:36.097826) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:36.098096) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 00:33:36.098470) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-21 00:33:36.098769) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:33:36 INFO - MultiFileLogger online at 20151121 00:33:36 in /builds/slave/test-pgo 00:33:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 00:33:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:33:36 INFO - {'append_to_log': False, 00:33:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:33:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:33:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:33:36 INFO - 'branch': 'Mozilla-Inbound', 00:33:36 INFO - 'buildbot_json_path': 'buildprops.json', 00:33:36 INFO - 'config_files': ('talos/linux_config.py',), 00:33:36 INFO - 'default_actions': ('clobber', 00:33:36 INFO - 'read-buildbot-config', 00:33:36 INFO - 'download-and-extract', 00:33:36 INFO - 'populate-webroot', 00:33:36 INFO - 'create-virtualenv', 00:33:36 INFO - 'install', 00:33:36 INFO - 'run-tests'), 00:33:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:33:36 INFO - 'download_minidump_stackwalk': True, 00:33:36 INFO - 'download_symbols': 'ondemand', 00:33:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:33:36 INFO - 'tooltool.py': '/tools/tooltool.py', 00:33:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:33:36 INFO - '/tools/misc-python/virtualenv.py')}, 00:33:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:33:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:33:36 INFO - 'installer_path': 'installer.exe', 00:33:36 INFO - 'log_level': 'info', 00:33:36 INFO - 'log_name': 'talos', 00:33:36 INFO - 'log_to_console': True, 00:33:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:33:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:33:36 INFO - 'opt_config_files': (), 00:33:36 INFO - 'pip_index': False, 00:33:36 INFO - 'sps_profile': False, 00:33:36 INFO - 'sps_profile_interval': 0, 00:33:36 INFO - 'suite': 'dromaeojs', 00:33:36 INFO - 'system_bits': '64', 00:33:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:33:36 INFO - 'title': 'talos-linux64-ix-033', 00:33:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:33:36 INFO - 'use_talos_json': True, 00:33:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:33:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:33:36 INFO - 'work_dir': 'build'} 00:33:36 INFO - ##### 00:33:36 INFO - ##### Running clobber step. 00:33:36 INFO - ##### 00:33:36 INFO - Running pre-action listener: _resource_record_pre_action 00:33:36 INFO - Running main action method: clobber 00:33:36 INFO - rmtree: /builds/slave/test-pgo/build 00:33:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:33:36 INFO - Running post-action listener: _resource_record_post_action 00:33:36 INFO - ##### 00:33:36 INFO - ##### Running read-buildbot-config step. 00:33:36 INFO - ##### 00:33:36 INFO - Running pre-action listener: _resource_record_pre_action 00:33:36 INFO - Running main action method: read_buildbot_config 00:33:36 INFO - Using buildbot properties: 00:33:36 INFO - { 00:33:36 INFO - "properties": { 00:33:36 INFO - "buildnumber": 1290, 00:33:36 INFO - "product": "firefox", 00:33:36 INFO - "script_repo_revision": "production", 00:33:36 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 00:33:36 INFO - "repository": "", 00:33:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 00:33:36 INFO - "buildid": "20151120223009", 00:33:36 INFO - "slavename": "talos-linux64-ix-033", 00:33:36 INFO - "pgo_build": "True", 00:33:36 INFO - "basedir": "/builds/slave/test-pgo", 00:33:36 INFO - "project": "", 00:33:36 INFO - "platform": "ubuntu64_hw", 00:33:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:33:36 INFO - "slavebuilddir": "test", 00:33:36 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 00:33:36 INFO - "branch": "mozilla-inbound", 00:33:36 INFO - "repo_path": "integration/mozilla-inbound", 00:33:36 INFO - "stage_platform": "linux64-pgo", 00:33:36 INFO - "builduid": "cb5dfffebce841b8a23a9166c06eae6c", 00:33:36 INFO - "revision": "de4585e9617cb5b888ebec7296080bc4c33acaa5" 00:33:36 INFO - }, 00:33:36 INFO - "sourcestamp": { 00:33:36 INFO - "repository": "", 00:33:36 INFO - "hasPatch": false, 00:33:36 INFO - "project": "", 00:33:36 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 00:33:36 INFO - "changes": [ 00:33:36 INFO - { 00:33:36 INFO - "category": null, 00:33:36 INFO - "files": [ 00:33:36 INFO - { 00:33:36 INFO - "url": null, 00:33:36 INFO - "name": "https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:33:36 INFO - } 00:33:36 INFO - ], 00:33:36 INFO - "repository": "", 00:33:36 INFO - "rev": "de4585e9617cb5b888ebec7296080bc4c33acaa5", 00:33:36 INFO - "who": "sendchange", 00:33:36 INFO - "when": 1448094768, 00:33:36 INFO - "number": 6692122, 00:33:36 INFO - "comments": "", 00:33:36 INFO - "project": "", 00:33:36 INFO - "at": "Sat 21 Nov 2015 00:32:48", 00:33:36 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 00:33:36 INFO - "revlink": "", 00:33:36 INFO - "properties": [ 00:33:36 INFO - [ 00:33:36 INFO - "buildid", 00:33:36 INFO - "20151120223009", 00:33:36 INFO - "Change" 00:33:36 INFO - ], 00:33:36 INFO - [ 00:33:36 INFO - "builduid", 00:33:36 INFO - "cb5dfffebce841b8a23a9166c06eae6c", 00:33:36 INFO - "Change" 00:33:36 INFO - ], 00:33:36 INFO - [ 00:33:36 INFO - "pgo_build", 00:33:36 INFO - "True", 00:33:36 INFO - "Change" 00:33:36 INFO - ] 00:33:36 INFO - ], 00:33:36 INFO - "revision": "de4585e9617cb5b888ebec7296080bc4c33acaa5" 00:33:36 INFO - } 00:33:36 INFO - ], 00:33:36 INFO - "revision": "de4585e9617cb5b888ebec7296080bc4c33acaa5" 00:33:36 INFO - } 00:33:36 INFO - } 00:33:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:33:36 INFO - Running post-action listener: _resource_record_post_action 00:33:36 INFO - ##### 00:33:36 INFO - ##### Running download-and-extract step. 00:33:36 INFO - ##### 00:33:36 INFO - Running pre-action listener: _resource_record_pre_action 00:33:36 INFO - Running main action method: download_and_extract 00:33:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:36 INFO - https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:33:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/test_packages.json 00:33:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/test_packages.json 00:33:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:33:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:33:37 INFO - Downloaded 1302 bytes. 00:33:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:33:37 INFO - Using the following test package requirements: 00:33:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:33:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:33:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:37 INFO - u'jsshell-linux-x86_64.zip'], 00:33:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:33:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:33:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:33:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:33:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:33:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:33:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:33:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:37 INFO - https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:33:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:33:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:33:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/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 00:33:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/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 00:33:38 INFO - Downloaded 22525891 bytes. 00:33:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:33:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:33:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:33:39 INFO - Return code: 0 00:33:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:39 INFO - https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:33:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:33:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:33:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/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 00:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/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 00:33:41 INFO - Downloaded 22525891 bytes. 00:33:41 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 00:33:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:33:41 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 00:33:42 INFO - Return code: 0 00:33: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')]} 00:33:42 INFO - https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:33:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:33:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:33:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/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 00:33:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/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 00:33:44 INFO - Downloaded 11130997 bytes. 00:33:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 00:33:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:33:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 00:33:44 INFO - Return code: 0 00:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:44 INFO - https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:33:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:33:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:33:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/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 00:33:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BCfS6yFRSTiOBMbt_Kcovw/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 00:33:47 INFO - Downloaded 57432705 bytes. 00:33:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:33:47 INFO - mkdir: /builds/slave/test-pgo/properties 00:33:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:33:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:33:47 INFO - Contents: 00:33:47 INFO - build_url:https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:33:47 INFO - Running post-action listener: _resource_record_post_action 00:33:47 INFO - Running post-action listener: set_extra_try_arguments 00:33:47 INFO - ##### 00:33:47 INFO - ##### Running populate-webroot step. 00:33:47 INFO - ##### 00:33:47 INFO - Running pre-action listener: _resource_record_pre_action 00:33:47 INFO - Running main action method: populate_webroot 00:33:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:33:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:33:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:33:47 INFO - '../fennec_ids.txt'], 00:33:47 INFO - 'tests': ['tcheck2']}, 00:33:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:33:47 INFO - '--tppagecycles', 00:33:47 INFO - '7'], 00:33:47 INFO - 'tests': ['tsvgm']}}, 00:33:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:33:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:33:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:33:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:33:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:33:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:33:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:33:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:47 INFO - 'talos_options': ['--e10s'], 00:33:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:33:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:47 INFO - 'tests': ['damp', 'tps']}, 00:33:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:47 INFO - 'talos_options': ['--e10s'], 00:33:47 INFO - 'tests': ['damp', 'tps']}, 00:33:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:33:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:33:47 INFO - 'other': {'tests': ['a11yr', 00:33:47 INFO - 'ts_paint', 00:33:47 INFO - 'tpaint', 00:33:47 INFO - 'sessionrestore', 00:33:47 INFO - 'sessionrestore_no_auto_restore']}, 00:33:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:33:47 INFO - 'tests': ['a11yr', 00:33:47 INFO - 'ts_paint', 00:33:47 INFO - 'tpaint', 00:33:47 INFO - 'sessionrestore', 00:33:47 INFO - 'sessionrestore_no_auto_restore']}, 00:33:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:33:47 INFO - 'tests': ['a11yr', 00:33:47 INFO - 'ts_paint', 00:33:47 INFO - 'tpaint', 00:33:47 INFO - 'sessionrestore', 00:33:47 INFO - 'sessionrestore_no_auto_restore']}, 00:33:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:33:47 INFO - 'tests': ['a11yr', 00:33:47 INFO - 'ts_paint', 00:33:47 INFO - 'tpaint', 00:33:47 INFO - 'sessionrestore', 00:33:47 INFO - 'sessionrestore_no_auto_restore']}, 00:33:47 INFO - 'other_l64': {'tests': ['a11yr', 00:33:47 INFO - 'ts_paint', 00:33:47 INFO - 'tpaint', 00:33:47 INFO - 'sessionrestore', 00:33:47 INFO - 'sessionrestore_no_auto_restore']}, 00:33:47 INFO - 'other_nol64': {'tests': ['a11yr', 00:33:47 INFO - 'ts_paint', 00:33:47 INFO - 'tpaint', 00:33:47 INFO - 'sessionrestore', 00:33:47 INFO - 'sessionrestore_no_auto_restore']}, 00:33:47 INFO - 'svgr': {'tests': ['tsvgx', 00:33:47 INFO - 'tsvgr_opacity', 00:33:47 INFO - 'tart', 00:33:47 INFO - 'tscrollx', 00:33:47 INFO - 'cart']}, 00:33:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:33:47 INFO - 'tests': ['tsvgx', 00:33:47 INFO - 'tsvgr_opacity', 00:33:47 INFO - 'tart', 00:33:47 INFO - 'tscrollx', 00:33:47 INFO - 'cart']}, 00:33:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:47 INFO - 'tests': ['tp5o']}, 00:33:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:47 INFO - 'talos_options': ['--e10s'], 00:33:47 INFO - 'tests': ['tp5o']}, 00:33:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:47 INFO - 'talos_options': ['--xperf_path', 00:33:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:33:47 INFO - 'tests': ['tp5n']}, 00:33:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:47 INFO - 'talos_options': ['--e10s', 00:33:47 INFO - '--xperf_path', 00:33:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:33:47 INFO - 'tests': ['tp5n']}}, 00:33:47 INFO - 'talos.zip': {'path': '', 00:33:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:33:47 INFO - Running post-action listener: _resource_record_post_action 00:33:47 INFO - ##### 00:33:47 INFO - ##### Running create-virtualenv step. 00:33:47 INFO - ##### 00:33:47 INFO - Running pre-action listener: _resource_record_pre_action 00:33:47 INFO - Running main action method: create_virtualenv 00:33:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:33:47 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 00:33:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:33:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:33:47 INFO - Using real prefix '/usr' 00:33:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:33:48 INFO - Installing distribute.............................................................................................................................................................................................done. 00:33:50 INFO - Installing pip.................done. 00:33:50 INFO - Return code: 0 00:33:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f991ba79c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02a90>, '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 0x1b54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b552e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', '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 00:33:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 00:33:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:33:50 INFO - Using env: {'DISPLAY': ':0', 00:33:50 INFO - 'HOME': '/home/cltbld', 00:33:50 INFO - 'LANG': 'en_US.UTF-8', 00:33:50 INFO - 'LANGUAGE': 'en_US:en', 00:33:50 INFO - 'LOGNAME': 'cltbld', 00:33:50 INFO - 'MAIL': '/var/mail/cltbld', 00:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:50 INFO - 'MOZ_NO_REMOTE': '1', 00:33:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:50 INFO - 'NO_EM_RESTART': '1', 00:33:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:33:50 INFO - 'PWD': '/builds/slave/test-pgo', 00:33:50 INFO - 'SHELL': '/bin/bash', 00:33:50 INFO - 'SHLVL': '1', 00:33:50 INFO - 'TERM': 'linux', 00:33:50 INFO - 'TMOUT': '86400', 00:33:50 INFO - 'USER': 'cltbld', 00:33:50 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', 00:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:50 INFO - '_': '/tools/buildbot/bin/python'} 00:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:50 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 00:33:50 INFO - Cleaning up... 00:33:50 INFO - Return code: 0 00:33:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f991ba79c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02a90>, '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 0x1b54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b552e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', '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 00:33:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:33:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:33:50 INFO - Using env: {'DISPLAY': ':0', 00:33:50 INFO - 'HOME': '/home/cltbld', 00:33:50 INFO - 'LANG': 'en_US.UTF-8', 00:33:50 INFO - 'LANGUAGE': 'en_US:en', 00:33:50 INFO - 'LOGNAME': 'cltbld', 00:33:50 INFO - 'MAIL': '/var/mail/cltbld', 00:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:50 INFO - 'MOZ_NO_REMOTE': '1', 00:33:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:50 INFO - 'NO_EM_RESTART': '1', 00:33:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:33:50 INFO - 'PWD': '/builds/slave/test-pgo', 00:33:50 INFO - 'SHELL': '/bin/bash', 00:33:50 INFO - 'SHLVL': '1', 00:33:50 INFO - 'TERM': 'linux', 00:33:50 INFO - 'TMOUT': '86400', 00:33:50 INFO - 'USER': 'cltbld', 00:33:50 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', 00:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:50 INFO - '_': '/tools/buildbot/bin/python'} 00:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:50 INFO - Downloading/unpacking psutil>=0.7.1 00:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:33:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:33:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:33:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:33:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:33:52 INFO - Installing collected packages: psutil 00:33:52 INFO - Running setup.py install for psutil 00:33:52 INFO - building 'psutil._psutil_linux' extension 00:33:52 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 00:33:52 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 00:33:52 INFO - building 'psutil._psutil_posix' extension 00:33:52 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 00:33:53 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 00:33:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:33:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:33:53 INFO - Successfully installed psutil 00:33:53 INFO - Cleaning up... 00:33:53 INFO - Return code: 0 00:33:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:53 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 0x7f991ba79c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02a90>, '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 0x1b54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b552e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', '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 00:33:53 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 00:33:53 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 00:33:53 INFO - Using env: {'DISPLAY': ':0', 00:33:53 INFO - 'HOME': '/home/cltbld', 00:33:53 INFO - 'LANG': 'en_US.UTF-8', 00:33:53 INFO - 'LANGUAGE': 'en_US:en', 00:33:53 INFO - 'LOGNAME': 'cltbld', 00:33:53 INFO - 'MAIL': '/var/mail/cltbld', 00:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:53 INFO - 'MOZ_NO_REMOTE': '1', 00:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:53 INFO - 'NO_EM_RESTART': '1', 00:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:33:53 INFO - 'PWD': '/builds/slave/test-pgo', 00:33:53 INFO - 'SHELL': '/bin/bash', 00:33:53 INFO - 'SHLVL': '1', 00:33:53 INFO - 'TERM': 'linux', 00:33:53 INFO - 'TMOUT': '86400', 00:33:53 INFO - 'USER': 'cltbld', 00:33:53 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', 00:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:53 INFO - '_': '/tools/buildbot/bin/python'} 00:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:33:53 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 00:33:53 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 00:33:53 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 00:33:53 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 00:33:53 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 00:33:53 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 00:33:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:33:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:33:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:33:55 INFO - Installing collected packages: mozsystemmonitor 00:33:55 INFO - Running setup.py install for mozsystemmonitor 00:33:55 INFO - Successfully installed mozsystemmonitor 00:33:55 INFO - Cleaning up... 00:33:55 INFO - Return code: 0 00:33:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:55 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 0x7f991ba79c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02a90>, '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 0x1b54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b552e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', '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 00:33:55 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 00:33:55 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 00:33:55 INFO - Using env: {'DISPLAY': ':0', 00:33:55 INFO - 'HOME': '/home/cltbld', 00:33:55 INFO - 'LANG': 'en_US.UTF-8', 00:33:55 INFO - 'LANGUAGE': 'en_US:en', 00:33:55 INFO - 'LOGNAME': 'cltbld', 00:33:55 INFO - 'MAIL': '/var/mail/cltbld', 00:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:55 INFO - 'MOZ_NO_REMOTE': '1', 00:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:55 INFO - 'NO_EM_RESTART': '1', 00:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:33:55 INFO - 'PWD': '/builds/slave/test-pgo', 00:33:55 INFO - 'SHELL': '/bin/bash', 00:33:55 INFO - 'SHLVL': '1', 00:33:55 INFO - 'TERM': 'linux', 00:33:55 INFO - 'TMOUT': '86400', 00:33:55 INFO - 'USER': 'cltbld', 00:33:55 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', 00:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:55 INFO - '_': '/tools/buildbot/bin/python'} 00:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:55 INFO - Downloading/unpacking blobuploader==1.2.4 00:33:55 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 00:33:55 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 00:33:55 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 00:33:55 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 00:33:55 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 00:33:55 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 00:33:57 INFO - Downloading blobuploader-1.2.4.tar.gz 00:33:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:33:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:33:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:33:57 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 00:33:57 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 00:33:57 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 00:33:57 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 00:33:57 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 00:33:57 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 00:33:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:33:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:33:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:33:57 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 00:33:57 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 00:33:57 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 00:33:57 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 00:33:57 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 00:33:57 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 00:33:57 INFO - Downloading docopt-0.6.1.tar.gz 00:33:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:33:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:33:58 INFO - Installing collected packages: blobuploader, requests, docopt 00:33:58 INFO - Running setup.py install for blobuploader 00:33:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:33:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:33:58 INFO - Running setup.py install for requests 00:33:58 INFO - Running setup.py install for docopt 00:33:58 INFO - Successfully installed blobuploader requests docopt 00:33:58 INFO - Cleaning up... 00:33:58 INFO - Return code: 0 00:33:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:58 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 0x7f991ba79c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02a90>, '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 0x1b54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b552e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', '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 00:33:58 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 00:33:58 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 00:33:58 INFO - Using env: {'DISPLAY': ':0', 00:33:58 INFO - 'HOME': '/home/cltbld', 00:33:58 INFO - 'LANG': 'en_US.UTF-8', 00:33:58 INFO - 'LANGUAGE': 'en_US:en', 00:33:58 INFO - 'LOGNAME': 'cltbld', 00:33:58 INFO - 'MAIL': '/var/mail/cltbld', 00:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:58 INFO - 'MOZ_NO_REMOTE': '1', 00:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:58 INFO - 'NO_EM_RESTART': '1', 00:33:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:33:58 INFO - 'PWD': '/builds/slave/test-pgo', 00:33:58 INFO - 'SHELL': '/bin/bash', 00:33:58 INFO - 'SHLVL': '1', 00:33:58 INFO - 'TERM': 'linux', 00:33:58 INFO - 'TMOUT': '86400', 00:33:58 INFO - 'USER': 'cltbld', 00:33:58 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', 00:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:58 INFO - '_': '/tools/buildbot/bin/python'} 00:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:33:58 INFO - Running setup.py (path:/tmp/pip-KCx3HA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:33:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:33:58 INFO - Running setup.py (path:/tmp/pip-Ze0FEk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:33:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:33:58 INFO - Running setup.py (path:/tmp/pip-Y7Sqix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:33:59 INFO - Running setup.py (path:/tmp/pip-KHUjh8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:33:59 INFO - Running setup.py (path:/tmp/pip-elSS4b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:33:59 INFO - Running setup.py (path:/tmp/pip-BbJ724-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:33:59 INFO - Running setup.py (path:/tmp/pip-kfT7CL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:33:59 INFO - Running setup.py (path:/tmp/pip-jCPq6I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:33:59 INFO - Running setup.py (path:/tmp/pip-6HjfWJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:33:59 INFO - Running setup.py (path:/tmp/pip-fQERW9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:33:59 INFO - Running setup.py (path:/tmp/pip-7BeSoj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:33:59 INFO - Running setup.py (path:/tmp/pip-N83z9J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:33:59 INFO - Running setup.py (path:/tmp/pip-TSpptt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:33:59 INFO - Running setup.py (path:/tmp/pip-gO7lSF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:33:59 INFO - Running setup.py (path:/tmp/pip-jM_bTV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:33:59 INFO - Running setup.py (path:/tmp/pip-tdcHHP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:33:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:33:59 INFO - Running setup.py (path:/tmp/pip-OS52Xj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:34:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:34:00 INFO - Running setup.py install for manifestparser 00:34:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:34:00 INFO - Running setup.py install for mozcrash 00:34:00 INFO - Running setup.py install for mozdebug 00:34:00 INFO - Running setup.py install for mozdevice 00:34:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:34:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:34:00 INFO - Running setup.py install for mozfile 00:34:00 INFO - Running setup.py install for mozhttpd 00:34:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:34:00 INFO - Running setup.py install for mozinfo 00:34:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:34:00 INFO - Running setup.py install for mozInstall 00:34:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:34:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:34:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:34:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:34:00 INFO - Running setup.py install for mozleak 00:34:00 INFO - Running setup.py install for mozlog 00:34:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:34:01 INFO - Running setup.py install for moznetwork 00:34:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:34:01 INFO - Running setup.py install for mozprocess 00:34:01 INFO - Running setup.py install for mozprofile 00:34:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:34:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:34:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:34:01 INFO - Running setup.py install for mozrunner 00:34:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:34:01 INFO - Running setup.py install for mozscreenshot 00:34:01 INFO - Running setup.py install for moztest 00:34:01 INFO - Running setup.py install for mozversion 00:34:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:34:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:34:01 INFO - Cleaning up... 00:34:01 INFO - Return code: 0 00:34:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:34:01 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')]} 00:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:01 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')]} 00:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:01 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 0x7f991ba79c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02a90>, '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 0x1b54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b552e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', '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 00:34:01 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 00:34:01 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 00:34:01 INFO - Using env: {'DISPLAY': ':0', 00:34:01 INFO - 'HOME': '/home/cltbld', 00:34:01 INFO - 'LANG': 'en_US.UTF-8', 00:34:01 INFO - 'LANGUAGE': 'en_US:en', 00:34:01 INFO - 'LOGNAME': 'cltbld', 00:34:01 INFO - 'MAIL': '/var/mail/cltbld', 00:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:01 INFO - 'MOZ_NO_REMOTE': '1', 00:34:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:01 INFO - 'NO_EM_RESTART': '1', 00:34:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:34:01 INFO - 'PWD': '/builds/slave/test-pgo', 00:34:01 INFO - 'SHELL': '/bin/bash', 00:34:01 INFO - 'SHLVL': '1', 00:34:01 INFO - 'TERM': 'linux', 00:34:01 INFO - 'TMOUT': '86400', 00:34:01 INFO - 'USER': 'cltbld', 00:34:01 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', 00:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:01 INFO - '_': '/tools/buildbot/bin/python'} 00:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:34:02 INFO - Running setup.py (path:/tmp/pip-Z2MRnr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:34:02 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)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:34:02 INFO - Running setup.py (path:/tmp/pip-nyCBVi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:34:02 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)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:34:02 INFO - Running setup.py (path:/tmp/pip-RSB9F9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:34:02 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)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:34:02 INFO - Running setup.py (path:/tmp/pip-T1MdM9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:34:02 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)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:34:02 INFO - Running setup.py (path:/tmp/pip-l7OeDz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:34:02 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)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:34:02 INFO - Running setup.py (path:/tmp/pip-U92lgX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:34:02 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)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:34:02 INFO - Running setup.py (path:/tmp/pip-ub6TH0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:34:02 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)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:34:02 INFO - Running setup.py (path:/tmp/pip-1Yf6uE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:34:02 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)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:34:02 INFO - Running setup.py (path:/tmp/pip-JXcd67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:34:02 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)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:34:02 INFO - Running setup.py (path:/tmp/pip-4XKy0j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:34:02 INFO - Running setup.py (path:/tmp/pip-86FP2n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:34:02 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)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:34:02 INFO - Running setup.py (path:/tmp/pip-FTzTnv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:34:02 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)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:34:02 INFO - Running setup.py (path:/tmp/pip-a0t9ZG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:34:02 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)) 00:34:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:34:02 INFO - Running setup.py (path:/tmp/pip-KFzrIY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:34:03 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)) 00:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:34:03 INFO - Running setup.py (path:/tmp/pip-0AC71C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:34:03 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)) 00:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:34:03 INFO - Running setup.py (path:/tmp/pip-gq_NwP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:34:03 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)) 00:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:34:03 INFO - Running setup.py (path:/tmp/pip-K9aIhU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:34:03 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)) 00:34:03 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)) 00:34:03 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)) 00:34:03 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)) 00:34:03 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)) 00:34:03 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)) 00:34:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:34:03 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 00:34:03 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 00:34:03 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 00:34:03 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 00:34:03 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 00:34:03 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 00:34:04 INFO - Downloading blessings-1.5.1.tar.gz 00:34:04 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 00:34:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:34:04 INFO - Installing collected packages: blessings 00:34:04 INFO - Running setup.py install for blessings 00:34:05 INFO - Successfully installed blessings 00:34:05 INFO - Cleaning up... 00:34:05 INFO - Return code: 0 00:34:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:34:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:34:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:34:05 INFO - Reading from file tmpfile_stdout 00:34:05 INFO - Current package versions: 00:34:05 INFO - argparse == 1.2.1 00:34:05 INFO - blessings == 1.5.1 00:34:05 INFO - blobuploader == 1.2.4 00:34:05 INFO - docopt == 0.6.1 00:34:05 INFO - manifestparser == 1.1 00:34:05 INFO - mozInstall == 1.12 00:34:05 INFO - mozcrash == 0.16 00:34:05 INFO - mozdebug == 0.1 00:34:05 INFO - mozdevice == 0.47 00:34:05 INFO - mozfile == 1.2 00:34:05 INFO - mozhttpd == 0.7 00:34:05 INFO - mozinfo == 0.9 00:34:05 INFO - mozleak == 0.1 00:34:05 INFO - mozlog == 3.1 00:34:05 INFO - moznetwork == 0.27 00:34:05 INFO - mozprocess == 0.22 00:34:05 INFO - mozprofile == 0.27 00:34:05 INFO - mozrunner == 6.11 00:34:05 INFO - mozscreenshot == 0.1 00:34:05 INFO - mozsystemmonitor == 0.0 00:34:05 INFO - moztest == 0.7 00:34:05 INFO - mozversion == 1.4 00:34:05 INFO - psutil == 3.1.1 00:34:05 INFO - requests == 1.2.3 00:34:05 INFO - wsgiref == 0.1.2 00:34:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:34: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')]} 00:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34: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')]} 00:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:05 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 0x7f991ba79c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02a90>, '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 0x1b54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b552e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', '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 00:34:05 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 00:34:05 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 00:34:05 INFO - Using env: {'DISPLAY': ':0', 00:34:05 INFO - 'HOME': '/home/cltbld', 00:34:05 INFO - 'LANG': 'en_US.UTF-8', 00:34:05 INFO - 'LANGUAGE': 'en_US:en', 00:34:05 INFO - 'LOGNAME': 'cltbld', 00:34:05 INFO - 'MAIL': '/var/mail/cltbld', 00:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:05 INFO - 'MOZ_NO_REMOTE': '1', 00:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:05 INFO - 'NO_EM_RESTART': '1', 00:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:34:05 INFO - 'PWD': '/builds/slave/test-pgo', 00:34:05 INFO - 'SHELL': '/bin/bash', 00:34:05 INFO - 'SHLVL': '1', 00:34:05 INFO - 'TERM': 'linux', 00:34:05 INFO - 'TMOUT': '86400', 00:34:05 INFO - 'USER': 'cltbld', 00:34:05 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', 00:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:05 INFO - '_': '/tools/buildbot/bin/python'} 00:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:05 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)) 00:34:05 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)) 00:34:05 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)) 00:34:05 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)) 00:34:05 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)) 00:34:05 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)) 00:34:05 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)) 00:34:05 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)) 00:34:05 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)) 00:34:05 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)) 00:34:05 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)) 00:34:05 INFO - Cleaning up... 00:34:05 INFO - Return code: 0 00:34:05 INFO - Running post-action listener: _resource_record_post_action 00:34:05 INFO - Running post-action listener: _start_resource_monitoring 00:34:05 INFO - Starting resource monitoring. 00:34:05 INFO - ##### 00:34:05 INFO - ##### Running install step. 00:34:05 INFO - ##### 00:34:05 INFO - Running pre-action listener: _resource_record_pre_action 00:34:05 INFO - Running main action method: install 00:34:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:34:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:34:05 INFO - Reading from file tmpfile_stdout 00:34:05 INFO - Detecting whether we're running mozinstall >=1.0... 00:34:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:34:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:34:05 INFO - Reading from file tmpfile_stdout 00:34:05 INFO - Output received: 00:34:05 INFO - Usage: mozinstall [options] installer 00:34:05 INFO - Options: 00:34:05 INFO - -h, --help show this help message and exit 00:34:05 INFO - -d DEST, --destination=DEST 00:34:05 INFO - Directory to install application into. [default: 00:34:05 INFO - "/builds/slave/test-pgo"] 00:34:05 INFO - --app=APP Application being installed. [default: firefox] 00:34:05 INFO - mkdir: /builds/slave/test-pgo/build/application 00:34:05 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'] 00:34:05 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 00:34:20 INFO - Reading from file tmpfile_stdout 00:34:20 INFO - Output received: 00:34:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:34:20 INFO - Running post-action listener: _resource_record_post_action 00:34:20 INFO - ##### 00:34:20 INFO - ##### Running run-tests step. 00:34:20 INFO - ##### 00:34:20 INFO - Running pre-action listener: _resource_record_pre_action 00:34:20 INFO - Running main action method: run_tests 00:34:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:34:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:34:20 INFO - Python 2.7.3 00:34:20 INFO - Return code: 0 00:34:20 INFO - grabbing minidump binary from tooltool 00:34: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')]} 00:34:20 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 0x1b02a90>, '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 0x1b54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b552e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:34:20 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 00:34:20 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 00:34:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:34:22 INFO - Return code: 0 00:34:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:34:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:34:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:34:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:34:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:34:22 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 00:34:22 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 00:34:22 INFO - Using env: {'DISPLAY': ':0', 00:34:22 INFO - 'HOME': '/home/cltbld', 00:34:22 INFO - 'LANG': 'en_US.UTF-8', 00:34:22 INFO - 'LANGUAGE': 'en_US:en', 00:34:22 INFO - 'LOGNAME': 'cltbld', 00:34:22 INFO - 'MAIL': '/var/mail/cltbld', 00:34:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:34:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:22 INFO - 'MOZ_NO_REMOTE': '1', 00:34:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:22 INFO - 'NO_EM_RESTART': '1', 00:34:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:34:22 INFO - 'PWD': '/builds/slave/test-pgo', 00:34:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:34:22 INFO - 'SHELL': '/bin/bash', 00:34:22 INFO - 'SHLVL': '1', 00:34:22 INFO - 'TERM': 'linux', 00:34:22 INFO - 'TMOUT': '86400', 00:34:22 INFO - 'USER': 'cltbld', 00:34:22 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520', 00:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:22 INFO - '_': '/tools/buildbot/bin/python'} 00:34:22 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 00:34:22 INFO - mozversion INFO | application_buildid: 20151120223009 00:34:22 INFO - mozversion INFO | application_changeset: de4585e9617cb5b888ebec7296080bc4c33acaa5 00:34:22 INFO - mozversion INFO | application_display_name: Nightly 00:34:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:34:22 INFO - mozversion INFO | application_name: Firefox 00:34:22 INFO - mozversion INFO | application_remotingname: firefox 00:34:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:34:22 INFO - mozversion INFO | application_vendor: Mozilla 00:34:22 INFO - mozversion INFO | application_version: 45.0a1 00:34:22 INFO - mozversion INFO | platform_buildid: 20151120223009 00:34:22 INFO - mozversion INFO | platform_changeset: de4585e9617cb5b888ebec7296080bc4c33acaa5 00:34:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:34:22 INFO - mozversion INFO | platform_version: 45.0a1 00:34:22 INFO - 2015-11-21 00:34:22,725 DEBUG : using testdate: 1448094862 00:34:22 INFO - 2015-11-21 00:34:22,725 DEBUG : actual date: 1448094862 00:34:22 INFO - 2015-11-21 00:34:22,733 INFO : starting webserver on 'localhost:59045' 00:34:22 INFO - 2015-11-21 00:34:22,733 INFO : Starting test suite talos-linux64-ix-033 00:34:22 INFO - 2015-11-21 00:34:22,734 INFO : Starting test dromaeo_css 00:34:22 INFO - 2015-11-21 00:34:22,734 DEBUG : operating with platform_type : linux_ 00:34:22 INFO - 2015-11-21 00:34:22,734 INFO : Initialising browser for dromaeo_css test... 00:34:22 INFO - 2015-11-21 00:34:22,743 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeztGDQ/profile http://localhost:59045/getInfo.html 00:34:28 INFO - 2015-11-21 00:34:28,489 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:34:28 INFO - 2015-11-21 00:34:28,489 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:34:28 INFO - 2015-11-21 00:34:28,489 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:34:28 INFO - 2015-11-21 00:34:28,489 DEBUG : BROWSER_OUTPUT: __metrics 00:34:28 INFO - 2015-11-21 00:34:28,611 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:34:30 INFO - 2015-11-21 00:34:30,514 INFO : Browser initialized. 00:34:30 INFO - 2015-11-21 00:34:30,515 INFO : Running cycle 1/1 for dromaeo_css test... 00:34:30 INFO - 2015-11-21 00:34:30,515 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeztGDQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:34:42 INFO - 2015-11-21 00:34:42,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 141754368 00:34:42 INFO - 2015-11-21 00:34:42,323 DEBUG : BROWSER_OUTPUT: 00:35:33 INFO - 2015-11-21 00:35:33,059 DEBUG : BROWSER_OUTPUT: 1448094933058 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] 00:37:42 INFO - 2015-11-21 00:37:42,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59045/tests/dromaeo/cssquery-ext.html) 00:37:44 INFO - 2015-11-21 00:37:44,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 350531584 00:37:44 INFO - 2015-11-21 00:37:44,483 DEBUG : BROWSER_OUTPUT: 00:40:46 INFO - 2015-11-21 00:40:46,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/dromaeo/cssquery-ext.html (next: http://localhost:59045/tests/dromaeo/cssquery-jquery.html) 00:40:47 INFO - 2015-11-21 00:40:47,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 229261312 00:40:47 INFO - 2015-11-21 00:40:47,535 DEBUG : BROWSER_OUTPUT: 00:43:49 INFO - 2015-11-21 00:43:49,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59045/tests/dromaeo/cssquery-mootools.html) 00:43:50 INFO - 2015-11-21 00:43:50,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 221736960 00:43:50 INFO - 2015-11-21 00:43:50,050 DEBUG : BROWSER_OUTPUT: 00:46:51 INFO - 2015-11-21 00:46:51,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59045/tests/dromaeo/cssquery-prototype.html) 00:46:52 INFO - 2015-11-21 00:46:52,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 202567680 00:46:52 INFO - 2015-11-21 00:46:52,505 DEBUG : BROWSER_OUTPUT: 00:49:54 INFO - 2015-11-21 00:49:54,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59045/tests/dromaeo/cssquery-yui.html) 00:49:55 INFO - 2015-11-21 00:49:55,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 204021760 00:49:55 INFO - 2015-11-21 00:49:55,466 DEBUG : BROWSER_OUTPUT: 00:52:58 INFO - 2015-11-21 00:52:58,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/dromaeo/cssquery-yui.html (next: http://localhost:59045/tests/dromaeo/cssquery-dojo.html) 00:52:58 INFO - 2015-11-21 00:52:58,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 264855552 00:52:58 INFO - 2015-11-21 00:52:58,355 DEBUG : BROWSER_OUTPUT: 00:52:58 INFO - 2015-11-21 00:52:58,356 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:52:58 INFO - 2015-11-21 00:52:58,357 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:52:58 INFO - 2015-11-21 00:52:58,357 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:52:58 INFO - 2015-11-21 00:52:58,357 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:52:58 INFO - 2015-11-21 00:52:58,358 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3143.7013483719047;3230.9353812923728;3273.4598791199455;3278.3443311337737;3298.1589694627864;5292.417834038252;5410.107332290172;5411.810586629469;5429.131338985763;5476.096444086726;5363;5427.240186373911;5441.319835020622;5444.482774136451;5472.616916815825;4928.704277743329;4935.062338155757;4953.653244272911;4957.801687932497;4982.153033984231;4886;5029.899402011957;5057.418396884369;5083.364579427572;5121.1038068338075;4847;4937.185364414867;4939.086269040221;4944.505549445027;4948.950510494921;4897.118518666639;4911.140550403665;4912.459629440758;4930.950690493085;4969.4036715594;4782.736949467778;4901.754912254373;4913.533214344631;4921.778519966574;4953.900921981576;5203.297554830087;5235.842924712265;5244;5249.343832020997;5283;5782.219400380979;5787.189793428881;5795.652260864319;5797.739101740432;5842.678652674102;5777.653340799566;5864.560157988168;5911.054231323011;5919.0825422059215;5934.851628709273;5504.7522861470925;5516.668999860021;5568.582356323211;5572.414896435897;5613.270274864323;5991.370906054802;6011.909821352683;6030.4572588467245;6036.124761909498;6046.213992181077;5635.887282254414;5764.164196191528;5816.360200377955;5853.795117170964;5855.326637436664;5829.650220986669;5926.081457374114;5960.7019649017375;5969.403059694083;5974.044152935509;5744.942550574524;5796.797112101056;5809.912851307234;5818.389069147764;5851.093080572518;5717.799877004368;5789.739461724233;5798.1302804579655;5803.448672376117;5824.796132135355;4484.304932735431;4492.034212644297;4504.09918016398;4519.84180553679;4575.130725162208;4045.3931910213114;4046.7167298288837;4054.9391759123637;4071.5114186297833;4087.1008378156757;5451.945480545223;5608.971955140199;5610.719464026783;5614.69119198448;5615.382307946123;5784.82645520635;5785.27684039495;5815.621984570989;5815.9709201453725;5892.911606325909;5652.576056795675;5664.405237450009;5665.065264231355;5670.688112153871;5670.829875103754;4973.452920178777;5221.216817477409;5229.895402092013;5234.241035049972;5279.023380674587;5943.55423343251;5979.910301345483;5994.790182343597;6002.459778619946;6062.636241825505;5831.591788574929;5921.526277897672;5972.522198224218;5992;5994.820155395345;5928.199693041384;6044.607100538451;6159.815205543661;6177.722002509808;6187.16473276102;5722.17028530869;5728.882867840898;5815.912761308499;5832.941670583409;5882.470577648032;5794.913076303775;5825.79609713658;5829.300483941955;5838.357780644211;5838.474537291664;5503;5619.8876022480135;5707.771689132388;5717.599768016199;5717.656940583578;5648.85877853057;5675.517581005661;5702.258706368146;5704.3154821421695;5724.856878578069;5625.015622266005;5626.549876009991;5627.8593035174445;5632.070708333079;5632.380438151882;5679.943200567942;5740;5746.885062298647;5753.108268218432;5757.798477053283;5542.307211598551;5581.972090139523;5625.21247025425;5637.746301416364;5649.491545760901 00:52:58 INFO - 2015-11-21 00:52:58,362 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.1919043273434;592.1473078766577;600.5735927491484;605.3825098399634;606.969651517424;31049.534256986135;40065.19869602606;40110.19779604406;40132;40140;42776;43102.4742402048;43155.56844431555;43211.56788432115;43346;7552.924470755304;7607.049118860143;8751.474911505298;8863.11368863115;8879.067697891725;10537.84193237102;10749.032587067162;10751;10756.085732712729;10761.408122553257;10311.587536498531;10350.068493835553;10364.326318789255;10394.740131496736;10396.06435420812;7743.457957942946;7801.96099019507;10180.185585153169;10480.68557943263;10744.409057501834;10283.228757843117;10389.688309350731;10429.374237545771;10430.478476076241;10431.530581123792;40634.1873162538;40849.59150408488;41145;41157.176856463004;41244;3196.392685389792;3218.340240250743;3530.9823450882836;3883.870009652732;3992.041909941622;30283.545746813816;30451.847740761154;30921.536176957365;31275.687243127504;31885.521717174262;3842.385218365076;3875.5736868944396;3888.183481468895;3969.761814291152;4085.0604360997136;288288;288488;288881.5555922228;288930;290009;55004;55362.72318638462;57646.7117664409;58292.417075829544;59273;59444.70277648584;59836;59843;59903;59943.70028149831;14637.853621463863;14683.192424416546;14690.779638305434;14755.040922340013;14807.70384592302;11113.277636953733;11163.330200188015;11168.441577921072;11175.608853690082;11278.605248816417;18891;18980.335688250845;19000.334988275343;19054.80945190558;19072.427827165207;7195.316444937723;7559.371501679115;7565.508241964255;7578.60440944251;7609.277118673717;920.2775820980498;1023.5905637744961;1055.875492600378;1058.9682309530726;1068.1348108032519;28209.15372538827;28666.570001449996;28702.85648571744;28828;29018.564721529194;997.7405874472544;1007.1238022920106;1049.5539395756773;1119.4234968990977;1162.2271189658952;13676.65808354799;13883.37524811386;13904.652383690489;15007.24963751808;15357.385704571916;256302;260590;260856;261414.38585614282;261711;46874;47081.5291847084;47119.52880471152;47155;47155.5284447158;1317.1109501086728;1342.1142046249429;1355.390074466494;1359.4222455456588;1366.2144267046488;25754.227373178834;27549.31126721848;28148;28870.566941496316;28927.56608650914;44267.77866110649;44464.33303500385;44524.10951781011;44586.3312050313;47730.761346193045;252180;299941;304838;305038;307490;28007.859960700065;28561.42877142487;28616.713832861406;28640.28399289951;28643.570346444405;38469.61530384772;39848.00379990524;39960.80019599883;40042.39936400898;40651;34971;36147.096322592144;36459.45310820287;36559.26881462303;36639.816800915825;33735.493967591;33982.320353592295;33985.15037123993;35643.64356356403;36605.450918235714;34847.47728784121;35441.46837797487;35645.643543564234;35701;35933.406659334905;31330.216744580655;32518.34963300768;32587.34825303528;32864.67135328616;32945;24670.506589868462;25258;25363.112291069723;25556.616650750624;25651.871740641178 00:52:58 INFO - 2015-11-21 00:52:58,362 DEBUG : BROWSER_OUTPUT: |2;jquery.html;339.3789365461206;342.28974877129957;342.6813063850618;342.76178056250916;346.7919248450928;14183.71632567348;14624.268786560657;17066.658666826672;17272.56818579536;18075;16296.511104666879;16421.261043253053;16431.67136657266;16436.096014719187;16476.917615411938;5254.316938797961;5429.972850135744;5432.320959880015;5433.239346491494;5434.809781657643;4042.8584999525024;4142.378643203513;5390.21841832934;5874.9118763218585;6056.273247210341;5930.881382372371;5935.584509084366;5953.732082056318;5980.581359304851;5996.880062398749;5468.699221542814;5468.91796623051;5471.753771080291;5472.315960504937;5475.4524547545125;5136.178211486182;5186.1442861927735;5189.922151167735;5199.064168449678;5200.713960732158;20599.38201853947;20853.791462085337;21026.158953641836;21101.788982110134;21177;2225.2322948582714;2269.035659844576;2344.812415006795;2523.936901577457;2669.5728683410757;12868.871311286954;13004.609861704164;13149.671258218525;13411.128276661986;13674.794878076837;1727.1019070083612;1773.8846974946716;1810.4568629411256;1879.9906000470046;1881.9059047047729;58358.708206458694;60992;61771.99999999955;61777.691111544606;62171.37828621746;8866.955665221632;8912.55437228149;9208.631654733736;9214.078592140731;9266.721998340061;11622.360770157553;11642.825357619642;11652.70868228284;11655.18413711032;11755;7177.497575169792;7192.172900116449;7295.927040729524;7372.815679607946;7375.4099672026105;7314.780556583311;7337.926620733831;7355.301246381585;7413.258674132544;7414.369778568775;5726.284214473191;5727.39862314451;5727.911696777599;5733.913991290134;5821.505172060422;1588.4202266172763;1602.5753175408527;1655.5778276539647;1746.3451205797826;1765.7881054273312;901.2519608724742;905.307439808547;916.1617120334952;919.103873723128;1028.6296933104077;16359.918200408922;16453.91773041127;17609;17777.111144442726;18481.260749570134;878.3149143667949;909.1544863277084;926.6571368593663;934.1032608695729;1010.4594042187395;9147.908520914705;9190.494522801177;9456.338056336128;9626.711198664052;9630.374025688308;545233;545463;550335;589592;590358;77520.22479775242;78718.21281787108;78794.60602697065;79237;79301.60349198332;1140.9372484513265;1152.5274637398627;1153.3944679043568;1153.7692461507731;1164.7612239490884;14802.407903683732;14810.185439800483;14818.333175007367;14966.251687415368;15215.391384344945;34130.14674633154;34230.486542702376;34539.30921381508;34817.65182348144;35362.11594710153;47105.293420598035;47133.7643311795;47851;47863.76068119637;47939.76030119827;8979.281657467518;9115.954420227856;9605.567749451431;9606.759831004281;9612.951935240559;13258.867411325764;16846.66306673884;17220.138993050048;17473;17541;11319.547218111184;11389.480722308406;13157.210567365988;13678.247696376397;14167.787483187554;13419.194848309133;13437.260950647807;13683.315834208448;13947.16317020982;13997.580072597839;11089.390083545482;11420.086393088699;14360.35378407995;14362.281885905872;14441.277936103363;8580.313574914117;9118.452892826452;9133.132352426508;9469.10043545862;9474.715758527254;13984;13985.790213147015;14297.785533216802;14366.497172598909;14824.777628335369 00:52:58 INFO - 2015-11-21 00:52:58,363 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1475.2844870237936;1512.8108986376703;1600.1359265996362;1650.1171873047922;1760.779902512186;6686.0973768541235;6845.6919438625255;7731.884021739678;7932.801679958004;7937.44437889348;7524.4732868699075;7675.884861727079;7749.380049596033;7753.457257991943;7770.300672939435;2227.57676041552;2256.5035692147785;2257.887105644711;2259.2318611672026;2260.886955652211;2034.5829105033506;2064.308456667018;2064.370367038053;2238.888055597222;2313.9537209255805;2232.2187234467888;2232.631615783394;2241.3276017194858;2245.6182448983714;2249.6175650139435;2195.1987524553583;2283.6346184610384;2292.4039749665126;2294.9541009179725;2295.7015587973624;1993.9700904486444;2035.369035598969;2035.6437623415843;2035.9592808143902;2272.4205327641344;7691.038620172479;7853.371730261565;7864.370850331959;7870.881936770953;7872.055353357577;4571.062932098912;4632.513586073447;4653.418322709661;4656.813727450898;4658.58072773452;3111.2532992081965;3138.356636889455;3177.5869137012273;3194.7763656544053;3223.1136437479645;1098.3958822647512;1109.6291815617117;1111.9332840029624;1112.7385064509833;1123.6797512708838;10732.678019659423;10776.515056822462;10790.78418431627;10796.892031079668;10804.351738895613;4129.793510324472;4181.853635122756;4184.309588917856;4204.936925946114;4223.239816832938;9080.273578113734;9102.362834601647;9108.726738197865;9128.863067053999;9137.40606860552;4586.954130458719;4588.449386073693;4588.49526552079;4593.196190666687;4618;4154.771487568213;4180.665546756313;4192.11965487245;4198.790060496963;4202.201581699467;3729.776213427149;3746.269477451925;3762.6613604775152;3765.9246815063543;3772.3775577030033;1206.6741979665442;1215.0219073645624;1215.7811593913004;1226.515526367098;1239.6652903716126;1243.4280231093617;1244.6452760963082;1261.5899832554273;1270.6632742323293;1271.0213135885317;7355.374793142536;7427.294407031323;7433.888491672629;7438.66526006331;7496.812579685442;468.5197672385764;477.79454834420835;478.8922492439243;480.176497307113;484.706752414784;5272.209168624737;5400.405955344909;5837.124431335249;5847.473727364558;5900.616459930091;9261.814763704688;9333.160015598629;9367.765805854908;9391.90608093924;9421.434713917188;9154.81690366189;9179.036201198778;9191.586378612845;9455.810883782286;9529.952350238205;7151.2848715128075;7270.818229544304;7320.96339518299;7329.670164842488;7351.191368949304;7166.784996450115;7252.347288744038;7265.636718164176;7311.4150867929375;7316.926830731624;7842.451028428183;8249.79375515617;8360.45657032291;8373.95813020931;8412.579371031547;8485.35598221597;8518.914810851813;8577.270931970603;8692.261157801659;8705.8694119587;6758.966205168943;6799.082123913208;6819.045333653392;6822.181338239443;6822.897656535255;7251.803452430501;7280.708771649287;7338.853222935405;7393.408527317909;7400.629968501661;6566.573172743756;6733.797986060426;6780.93219067803;6796.592204467748;6850.554713943578;6678.766243181465;6705.564138330993;6802.693878775566;6879.243283238739;6908.171019477695;6809.89785153233;6843.076184715;6843.973403989441;6852.486063545154;6883.965580172067;6128;6205.81382558524;6246.593971391845;6262.4990000800735;6268.435840774352;6460.160179176677;6497.707603157964;6509.056186852975;6510.21877374718;6514.837129071811 00:52:58 INFO - 2015-11-21 00:52:58,363 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.4889079690901;323.3726570453319;324.4144319503296;326.66027331575145;327.7410845432109;6027.186329845469;6068.6965651717455;6109.708859177814;6112.938870611292;6114.419130182637;5775.913361299574;5899.469047785698;5946.672932988684;6016.278046634399;6046.334903160659;4595.103954728829;4617.5613316735025;4618;4632.07358528294;4633.930491042637;4611.031683346501;4615.215413379717;4620.653450991173;4629.259318509039;4644.558766917137;4360.520342762294;4434.733915965036;4474.798634061475;4494.101179764044;4600.493945665974;4559.156556037144;4576.519465456129;4595.816167353302;4602.332661764025;4618.053299073682;4012.3580227163807;4016.9196616067516;4021.5978402159844;4027.7784721840285;4028.1742242840146;5732.369439361667;5739.196512488255;5746.425357464262;5748.913766293509;5749.1663708762;5166.405863325728;5307.6019298552765;5310.654807437543;5312;5315.681059136464;6398.232212134527;6419.165508483868;6421.743130274784;6426.614403135827;6431.646259455728;4367.606915377632;4371;4376.737395756265;4377.365282034088;4380.649548036149;6526.902096468557;6595.505337099688;6653.966730166367;6672.532922695414;6674.733010679567;4458;4464.776761161929;4466.441694788152;4467;4468.977655111768;4520.864374068783;4521.186186486399;4522.683412161117;4523;4527.728336299832;5260.13207820713;5270.341207349082;5278.023565640369;5286.259923610698;5293.0472514946905;6319.557630965788;6460.483161347081;6467.935320646733;6471.805845824539;6475.287718350977;1581.3990683540412;1592.9601759955863;1593.2591345024618;1594.4339759385482;1596.3454983456727;1025.8820235672845;1040.8750949886062;1041.1306559023149;1051.458498873081;1065.3607835298758;6190.607113399449;6191.659458729723;6194.442500174916;6201.317855035943;6202.224721909762;6641.369069938348;6642.767503137367;6647.302033286532;6660.433863121689;6665.066890635315;6060.696965151725;6108.5418593605655;6175.505959523317;6193;6261.686915654199;3581.94627080594;3589.3180295744246;3597.226596281812;3604.1890574621025;3617.258462015333;6832.726690932406;6860.416864566468;6895.896561551581;6915.930840691629;6922.376986071177;6666.233383160901;6842.7605033823575;6854.280300568468;6854.588724676535;6855.691493882788;6901.378875901193;6908.447324214051;6912.550684205611;6917.377436030782;6924.792256232422;6704.296048914794;6704.631245281361;6706.228783689743;6707.3292670732535;6707.832304192434;6448.161738973903;6653.73385064592;6661.966690166518;6666.899996499959;6668.799936001928;6922.826929326807;6927.826804329932;6935.479839012195;6936.375726184466;6939.132608423947;4470.798814053441;4474.977625111854;4478.440194975628;4483.193025255486;4491.640668746558;6540.50946179048;6590.9670451647435;6628.668566571556;6631.502637302318;6633.800985970429;6482.286948435574;6487.18910136233;6487.708053137526;6491.091247225298;6508.446782023581;6468.191476065492;6470.158879345655;6482.157319548429;6487.091807146909;6488.967555162383;6200.596961197508;6356.936430635635;6372.58578192416;6391.552591318563;6397.520185985976;6530.47756179495;6532.673366331569;6541.2477565078725;6541.443977261986;6544.443722283469;6238.313785483684;6366.458850997532;6378.808635740936;6379.043143528508;6380.9361906380345 00:52:58 INFO - 2015-11-21 00:52:58,364 DEBUG : BROWSER_OUTPUT: |5;yui.html;757.3070640364066;828.7928017995501;840.9611551315483;853.5433543054467;855.0637052427594;13430.865691343084;13739.31303434828;13770.24263665498;13772.380242889069;13787.379567919443;12948.352582370868;12982.675433114153;13051;13051.804222936664;13059.73880522389;655.056718325612;663.489113382695;797.5055465611329;810.1736229046369;810.4367464612097;790.3163763344694;818.7216346442209;820.8645573480369;820.979475513111;821.0680877204356;849.8767678686587;862.6980556805131;863.4732812984074;864.5417928497906;865.0268447996004;696.7282759723712;704.4223736536043;839.4669384940546;850.0988951711206;855.8502262104138;628.7516431009772;629.0218709906094;629.5058379172327;629.820501157168;629.9748010079592;13220.801687974688;13344.866551334557;13365.599032029055;13371.866281337258;13392.330383480885;11929.701757456047;12012.159148859584;12153.574624888175;12642.431090600945;13238.205707657571;10054;10309.896901030968;10341.63804266847;10491.318064325795;10793.892061079367;3638.727095467824;3697.778133311983;3730.5336832895887;3791.431285307226;3792.639699228569;46617.30074048892;47229.52770472286;47334.76332618315;47470.287945680495;47492.28761568579;9496.762580935394;9711.27165462579;9711.56297966579;9810.068043535995;9916.702498925044;18754.437366879014;18881.339153129575;18883.433496995112;19707.40877773669;19717.408477745692;6945.40964018054;7202.569781129679;7264.455165862581;7462.776116716507;7651.69393224276;3852.2680690668685;3930.194310166409;3959.089409435846;3981.980090099531;3996.140829721624;2928.736413722733;2956.6895475975143;2959.0383125483872;2968.391479746647;2969.346743716379;530.8858595402007;531.4180971835833;533.4585395823243;535.9383670877821;557.0863783395235;559.8068666310116;594.5808205215313;603.4930658247093;640.5676168586185;673.5655502201053;7472.252774722593;7821.139674635786;7867.2919437249775;7896.84206315882;8000.599970001476;524.2162966365308;647.1166857239833;663.9966800165968;679.1137565477001;727.1274470635259;3491.773034752733;3565.857365705395;3742.644448777362;3744.1388480649603;4034.919301613951;59440.70279648574;60246.698766505884;60865.69567152136;61749.69125154345;61824.38175618276;46116.53883461122;53607.46392536103;53816.730916345165;53942.46057539453;53950.460495394545;48124.51875481271;48484.27273590899;48508;48726.512734872194;49072.75463622659;7576.28025337592;7786.688532458865;8086.312663423675;8129.430939834155;8130.471519351223;37522.624773751915;37924;38297.808510957264;38631.99999999887;38799.6120038796;44470.77764611286;44559.777201113786;44868.775656121514;45605.543944561454;46181.30728039149;10326.931242038952;10786.892131078903;10792.892071079188;10810.621628242974;10852.728681783019;11941.343226122646;11994.580189693319;12077.154599177973;12830.230186188859;12836.486540538273;10472.834712475998;10633.627823026158;10666.626668066581;10960.725981850517;11047;11472.598459054227;11619.070474361863;11754.76490470203;12153.69615759613;12183.512659493521;7879.251471110236;9603.663871764455;9843.85234221473;11034.17243706709;11131.387773672202;9369.12805341205;9412.58220622906;9933.552990115317;9935.652252171429;10379.377237365783;9479.573419196015;9548.904510954802;9569.282303827102;9709.70870873875;9753.609855605697 00:52:58 INFO - 2015-11-21 00:52:58,364 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:52:58 INFO - 2015-11-21 00:52:58,365 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:52:58 INFO - 2015-11-21 00:52:58,365 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1680 00:52:58 INFO - 2015-11-21 00:52:58,365 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:52:58 INFO - 2015-11-21 00:52:58,365 DEBUG : BROWSER_OUTPUT: __startTimestamp1448095978355__endTimestamp 00:52:58 INFO - 2015-11-21 00:52:58,365 DEBUG : BROWSER_OUTPUT: 00:52:58 INFO - 2015-11-21 00:52:58,365 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:52:58 INFO - 2015-11-21 00:52:58,365 DEBUG : BROWSER_OUTPUT: Number of tests: 6 00:52:58 INFO - 2015-11-21 00:52:58,365 DEBUG : BROWSER_OUTPUT: 00:52:58 INFO - 2015-11-21 00:52:58,366 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5437.10 Median:5648.86 stddev:605.80 (10.7%) stddev-sans-first:580.33 00:52:58 INFO - 2015-11-21 00:52:58,366 DEBUG : BROWSER_OUTPUT: Values: 3143.7 3230.9 3273.5 3278.3 3298.2 5292.4 5410.1 5411.8 5429.1 5476.1 5363.0 5427.2 5441.3 5444.5 5472.6 4928.7 4935.1 4953.7 4957.8 4982.2 4886.0 5029.9 5057.4 5083.4 5121.1 4847.0 4937.2 4939.1 4944.5 4949.0 4897.1 4911.1 4912.5 4931.0 4969.4 4782.7 4901.8 4913.5 4921.8 4953.9 5203.3 5235.8 5244.0 5249.3 5283.0 5782.2 5787.2 5795.7 5797.7 5842.7 5777.7 5864.6 5911.1 5919.1 5934.9 5504.8 5516.7 5568.6 5572.4 5613.3 5991.4 6011.9 6030.5 6036.1 6046.2 5635.9 5764.2 5816.4 5853.8 5855.3 5829.7 5926.1 5960.7 5969.4 5974.0 5744.9 5796.8 5809.9 5818.4 5851.1 5717.8 5789.7 5798.1 5803.4 5824.8 4484.3 4492.0 4504.1 4519.8 4575.1 4045.4 4046.7 4054.9 4071.5 4087.1 5451.9 5609.0 5610.7 5614.7 5615.4 5784.8 5785.3 5815.6 5816.0 5892.9 5652.6 5664.4 5665.1 5670.7 5670.8 4973.5 5221.2 5229.9 5234.2 5279.0 5943.6 5979.9 5994.8 6002.5 6062.6 5831.6 5921.5 5972.5 5992.0 5994.8 5928.2 6044.6 6159.8 6177.7 6187.2 5722.2 5728.9 5815.9 5832.9 5882.5 5794.9 5825.8 5829.3 5838.4 5838.5 5503.0 5619.9 5707.8 5717.6 5717.7 5648.9 5675.5 5702.3 5704.3 5724.9 5625.0 5626.5 5627.9 5632.1 5632.4 5679.9 5740.0 5746.9 5753.1 5757.8 5542.3 5582.0 5625.2 5637.7 5649.5 00:52:58 INFO - 2015-11-21 00:52:58,366 DEBUG : BROWSER_OUTPUT: 00:52:58 INFO - 2015-11-21 00:52:58,366 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45055.33 Median:31302.95 stddev:73412.18 (234.5%) stddev-sans-first:73542.08 00:52:58 INFO - 2015-11-21 00:52:58,366 DEBUG : BROWSER_OUTPUT: Values: 555.2 592.1 600.6 605.4 607.0 31049.5 40065.2 40110.2 40132.0 40140.0 42776.0 43102.5 43155.6 43211.6 43346.0 7552.9 7607.0 8751.5 8863.1 8879.1 10537.8 10749.0 10751.0 10756.1 10761.4 10311.6 10350.1 10364.3 10394.7 10396.1 7743.5 7802.0 10180.2 10480.7 10744.4 10283.2 10389.7 10429.4 10430.5 10431.5 40634.2 40849.6 41145.0 41157.2 41244.0 3196.4 3218.3 3531.0 3883.9 3992.0 30283.5 30451.8 30921.5 31275.7 31885.5 3842.4 3875.6 3888.2 3969.8 4085.1 288288.0 288488.0 288881.6 288930.0 290009.0 55004.0 55362.7 57646.7 58292.4 59273.0 59444.7 59836.0 59843.0 59903.0 59943.7 14637.9 14683.2 14690.8 14755.0 14807.7 11113.3 11163.3 11168.4 11175.6 11278.6 18891.0 18980.3 19000.3 19054.8 19072.4 7195.3 7559.4 7565.5 7578.6 7609.3 920.3 1023.6 1055.9 1059.0 1068.1 28209.2 28666.6 28702.9 28828.0 29018.6 997.7 1007.1 1049.6 1119.4 1162.2 13676.7 13883.4 13904.7 15007.2 15357.4 256302.0 260590.0 260856.0 261414.4 261711.0 46874.0 47081.5 47119.5 47155.0 47155.5 1317.1 1342.1 1355.4 1359.4 1366.2 25754.2 27549.3 28148.0 28870.6 28927.6 44267.8 44464.3 44524.1 44586.3 47730.8 252180.0 299941.0 304838.0 305038.0 307490.0 28007.9 28561.4 28616.7 28640.3 28643.6 38469.6 39848.0 39960.8 40042.4 40651.0 34971.0 36147.1 36459.5 36559.3 36639.8 33735.5 33982.3 33985.2 35643.6 36605.5 34847.5 35441.5 35645.6 35701.0 35933.4 31330.2 32518.3 32587.3 32864.7 32945.0 24670.5 25258.0 25363.1 25556.6 25651.9 00:52:58 INFO - 2015-11-21 00:52:58,366 DEBUG : BROWSER_OUTPUT: 00:52:58 INFO - 2015-11-21 00:52:58,366 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29472.64 Median:35089.88 stddev:92201.09 (262.8%) stddev-sans-first:92433.79 00:52:58 INFO - 2015-11-21 00:52:58,368 DEBUG : BROWSER_OUTPUT: Values: 339.4 342.3 342.7 342.8 346.8 14183.7 14624.3 17066.7 17272.6 18075.0 16296.5 16421.3 16431.7 16436.1 16476.9 5254.3 5430.0 5432.3 5433.2 5434.8 4042.9 4142.4 5390.2 5874.9 6056.3 5930.9 5935.6 5953.7 5980.6 5996.9 5468.7 5468.9 5471.8 5472.3 5475.5 5136.2 5186.1 5189.9 5199.1 5200.7 20599.4 20853.8 21026.2 21101.8 21177.0 2225.2 2269.0 2344.8 2523.9 2669.6 12868.9 13004.6 13149.7 13411.1 13674.8 1727.1 1773.9 1810.5 1880.0 1881.9 58358.7 60992.0 61772.0 61777.7 62171.4 8867.0 8912.6 9208.6 9214.1 9266.7 11622.4 11642.8 11652.7 11655.2 11755.0 7177.5 7192.2 7295.9 7372.8 7375.4 7314.8 7337.9 7355.3 7413.3 7414.4 5726.3 5727.4 5727.9 5733.9 5821.5 1588.4 1602.6 1655.6 1746.3 1765.8 901.3 905.3 916.2 919.1 1028.6 16359.9 16453.9 17609.0 17777.1 18481.3 878.3 909.2 926.7 934.1 1010.5 9147.9 9190.5 9456.3 9626.7 9630.4 545233.0 545463.0 550335.0 589592.0 590358.0 77520.2 78718.2 78794.6 79237.0 79301.6 1140.9 1152.5 1153.4 1153.8 1164.8 14802.4 14810.2 14818.3 14966.3 15215.4 34130.1 34230.5 34539.3 34817.7 35362.1 47105.3 47133.8 47851.0 47863.8 47939.8 8979.3 9116.0 9605.6 9606.8 9613.0 13258.9 16846.7 17220.1 17473.0 17541.0 11319.5 11389.5 13157.2 13678.2 14167.8 13419.2 13437.3 13683.3 13947.2 13997.6 11089.4 11420.1 14360.4 14362.3 14441.3 8580.3 9118.5 9133.1 9469.1 9474.7 13984.0 13985.8 14297.8 14366.5 14824.8 00:52:58 INFO - 2015-11-21 00:52:58,368 DEBUG : BROWSER_OUTPUT: 00:52:58 INFO - 2015-11-21 00:52:58,368 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5399.87 Median:6166.91 stddev:2832.71 (45.9%) stddev-sans-first:2825.30 00:52:58 INFO - 2015-11-21 00:52:58,368 DEBUG : BROWSER_OUTPUT: Values: 1475.3 1512.8 1600.1 1650.1 1760.8 6686.1 6845.7 7731.9 7932.8 7937.4 7524.5 7675.9 7749.4 7753.5 7770.3 2227.6 2256.5 2257.9 2259.2 2260.9 2034.6 2064.3 2064.4 2238.9 2314.0 2232.2 2232.6 2241.3 2245.6 2249.6 2195.2 2283.6 2292.4 2295.0 2295.7 1994.0 2035.4 2035.6 2036.0 2272.4 7691.0 7853.4 7864.4 7870.9 7872.1 4571.1 4632.5 4653.4 4656.8 4658.6 3111.3 3138.4 3177.6 3194.8 3223.1 1098.4 1109.6 1111.9 1112.7 1123.7 10732.7 10776.5 10790.8 10796.9 10804.4 4129.8 4181.9 4184.3 4204.9 4223.2 9080.3 9102.4 9108.7 9128.9 9137.4 4587.0 4588.4 4588.5 4593.2 4618.0 4154.8 4180.7 4192.1 4198.8 4202.2 3729.8 3746.3 3762.7 3765.9 3772.4 1206.7 1215.0 1215.8 1226.5 1239.7 1243.4 1244.6 1261.6 1270.7 1271.0 7355.4 7427.3 7433.9 7438.7 7496.8 468.5 477.8 478.9 480.2 484.7 5272.2 5400.4 5837.1 5847.5 5900.6 9261.8 9333.2 9367.8 9391.9 9421.4 9154.8 9179.0 9191.6 9455.8 9530.0 7151.3 7270.8 7321.0 7329.7 7351.2 7166.8 7252.3 7265.6 7311.4 7316.9 7842.5 8249.8 8360.5 8374.0 8412.6 8485.4 8518.9 8577.3 8692.3 8705.9 6759.0 6799.1 6819.0 6822.2 6822.9 7251.8 7280.7 7338.9 7393.4 7400.6 6566.6 6733.8 6780.9 6796.6 6850.6 6678.8 6705.6 6802.7 6879.2 6908.2 6809.9 6843.1 6844.0 6852.5 6884.0 6128.0 6205.8 6246.6 6262.5 6268.4 6460.2 6497.7 6509.1 6510.2 6514.8 00:52:58 INFO - 2015-11-21 00:52:58,368 DEBUG : BROWSER_OUTPUT: 00:52:58 INFO - 2015-11-21 00:52:58,368 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5367.33 Median:6113.68 stddev:1645.29 (26.9%) stddev-sans-first:1605.62 00:52:58 INFO - 2015-11-21 00:52:58,370 DEBUG : BROWSER_OUTPUT: Values: 315.5 323.4 324.4 326.7 327.7 6027.2 6068.7 6109.7 6112.9 6114.4 5775.9 5899.5 5946.7 6016.3 6046.3 4595.1 4617.6 4618.0 4632.1 4633.9 4611.0 4615.2 4620.7 4629.3 4644.6 4360.5 4434.7 4474.8 4494.1 4600.5 4559.2 4576.5 4595.8 4602.3 4618.1 4012.4 4016.9 4021.6 4027.8 4028.2 5732.4 5739.2 5746.4 5748.9 5749.2 5166.4 5307.6 5310.7 5312.0 5315.7 6398.2 6419.2 6421.7 6426.6 6431.6 4367.6 4371.0 4376.7 4377.4 4380.6 6526.9 6595.5 6654.0 6672.5 6674.7 4458.0 4464.8 4466.4 4467.0 4469.0 4520.9 4521.2 4522.7 4523.0 4527.7 5260.1 5270.3 5278.0 5286.3 5293.0 6319.6 6460.5 6467.9 6471.8 6475.3 1581.4 1593.0 1593.3 1594.4 1596.3 1025.9 1040.9 1041.1 1051.5 1065.4 6190.6 6191.7 6194.4 6201.3 6202.2 6641.4 6642.8 6647.3 6660.4 6665.1 6060.7 6108.5 6175.5 6193.0 6261.7 3581.9 3589.3 3597.2 3604.2 3617.3 6832.7 6860.4 6895.9 6915.9 6922.4 6666.2 6842.8 6854.3 6854.6 6855.7 6901.4 6908.4 6912.6 6917.4 6924.8 6704.3 6704.6 6706.2 6707.3 6707.8 6448.2 6653.7 6662.0 6666.9 6668.8 6922.8 6927.8 6935.5 6936.4 6939.1 4470.8 4475.0 4478.4 4483.2 4491.6 6540.5 6591.0 6628.7 6631.5 6633.8 6482.3 6487.2 6487.7 6491.1 6508.4 6468.2 6470.2 6482.2 6487.1 6489.0 6200.6 6356.9 6372.6 6391.6 6397.5 6530.5 6532.7 6541.2 6541.4 6544.4 6238.3 6366.5 6378.8 6379.0 6380.9 00:52:58 INFO - 2015-11-21 00:52:58,370 DEBUG : BROWSER_OUTPUT: 00:52:58 INFO - 2015-11-21 00:52:58,370 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13969.45 Median:48496.14 stddev:16558.41 (34.1%) stddev-sans-first:16575.14 00:52:58 INFO - 2015-11-21 00:52:58,370 DEBUG : BROWSER_OUTPUT: Values: 757.3 828.8 841.0 853.5 855.1 13430.9 13739.3 13770.2 13772.4 13787.4 12948.4 12982.7 13051.0 13051.8 13059.7 655.1 663.5 797.5 810.2 810.4 790.3 818.7 820.9 821.0 821.1 849.9 862.7 863.5 864.5 865.0 696.7 704.4 839.5 850.1 855.9 628.8 629.0 629.5 629.8 630.0 13220.8 13344.9 13365.6 13371.9 13392.3 11929.7 12012.2 12153.6 12642.4 13238.2 10054.0 10309.9 10341.6 10491.3 10793.9 3638.7 3697.8 3730.5 3791.4 3792.6 46617.3 47229.5 47334.8 47470.3 47492.3 9496.8 9711.3 9711.6 9810.1 9916.7 18754.4 18881.3 18883.4 19707.4 19717.4 6945.4 7202.6 7264.5 7462.8 7651.7 3852.3 3930.2 3959.1 3982.0 3996.1 2928.7 2956.7 2959.0 2968.4 2969.3 530.9 531.4 533.5 535.9 557.1 559.8 594.6 603.5 640.6 673.6 7472.3 7821.1 7867.3 7896.8 8000.6 524.2 647.1 664.0 679.1 727.1 3491.8 3565.9 3742.6 3744.1 4034.9 59440.7 60246.7 60865.7 61749.7 61824.4 46116.5 53607.5 53816.7 53942.5 53950.5 48124.5 48484.3 48508.0 48726.5 49072.8 7576.3 7786.7 8086.3 8129.4 8130.5 37522.6 37924.0 38297.8 38632.0 38799.6 44470.8 44559.8 44868.8 45605.5 46181.3 10326.9 10786.9 10792.9 10810.6 10852.7 11941.3 11994.6 12077.2 12830.2 12836.5 10472.8 10633.6 10666.6 10960.7 11047.0 11472.6 11619.1 11754.8 12153.7 12183.5 7879.3 9603.7 9843.9 11034.2 11131.4 9369.1 9412.6 9933.6 9935.7 10379.4 9479.6 9548.9 9569.3 9709.7 9753.6 00:52:58 INFO - 2015-11-21 00:52:58,370 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:52:58 INFO - 2015-11-21 00:52:58,370 DEBUG : BROWSER_OUTPUT: 00:52:59 INFO - 2015-11-21 00:52:59,109 INFO : Browser exited with error code: 0 00:52:59 INFO - 2015-11-21 00:52:59,132 INFO : Completed test dromaeo_css (00:18:36) 00:52:59 INFO - 2015-11-21 00:52:59,132 INFO : Starting test kraken 00:52:59 INFO - 2015-11-21 00:52:59,133 DEBUG : operating with platform_type : linux_ 00:52:59 INFO - 2015-11-21 00:52:59,133 INFO : Initialising browser for kraken test... 00:52:59 INFO - 2015-11-21 00:52:59,139 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3_uvQO/profile http://localhost:59045/getInfo.html 00:53:03 INFO - 2015-11-21 00:53:03,661 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:53:03 INFO - 2015-11-21 00:53:03,661 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:53:03 INFO - 2015-11-21 00:53:03,661 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:53:03 INFO - 2015-11-21 00:53:03,662 DEBUG : BROWSER_OUTPUT: __metrics 00:53:03 INFO - 2015-11-21 00:53:03,839 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:53:05 INFO - 2015-11-21 00:53:05,358 INFO : Browser initialized. 00:53:05 INFO - 2015-11-21 00:53:05,358 INFO : Running cycle 1/1 for kraken test... 00:53:05 INFO - 2015-11-21 00:53:05,359 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3_uvQO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:53:17 INFO - 2015-11-21 00:53:17,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 141901824 00:53:17 INFO - 2015-11-21 00:53:17,072 DEBUG : BROWSER_OUTPUT: 00:53:19 INFO - 2015-11-21 00:53:19,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59045/tests/kraken/driver.html?testName=audio-beat-detection) 00:53:20 INFO - 2015-11-21 00:53:20,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 178294784 00:53:20 INFO - 2015-11-21 00:53:20,112 DEBUG : BROWSER_OUTPUT: 00:53:22 INFO - 2015-11-21 00:53:22,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59045/tests/kraken/driver.html?testName=audio-dft) 00:53:23 INFO - 2015-11-21 00:53:23,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 168636416 00:53:23 INFO - 2015-11-21 00:53:23,247 DEBUG : BROWSER_OUTPUT: 00:53:26 INFO - 2015-11-21 00:53:26,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59045/tests/kraken/driver.html?testName=audio-fft) 00:53:26 INFO - 2015-11-21 00:53:26,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 152104960 00:53:26 INFO - 2015-11-21 00:53:26,719 DEBUG : BROWSER_OUTPUT: 00:53:28 INFO - 2015-11-21 00:53:28,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59045/tests/kraken/driver.html?testName=audio-oscillator) 00:53:29 INFO - 2015-11-21 00:53:29,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 154775552 00:53:29 INFO - 2015-11-21 00:53:29,248 DEBUG : BROWSER_OUTPUT: 00:53:31 INFO - 2015-11-21 00:53:31,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59045/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:53:31 INFO - 2015-11-21 00:53:31,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 155496448 00:53:31 INFO - 2015-11-21 00:53:31,955 DEBUG : BROWSER_OUTPUT: 00:53:34 INFO - 2015-11-21 00:53:34,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59045/tests/kraken/driver.html?testName=imaging-darkroom) 00:53:35 INFO - 2015-11-21 00:53:35,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 155217920 00:53:35 INFO - 2015-11-21 00:53:35,380 DEBUG : BROWSER_OUTPUT: 00:53:38 INFO - 2015-11-21 00:53:38,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59045/tests/kraken/driver.html?testName=imaging-desaturate) 00:53:39 INFO - 2015-11-21 00:53:39,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 157728768 00:53:39 INFO - 2015-11-21 00:53:39,342 DEBUG : BROWSER_OUTPUT: 00:53:42 INFO - 2015-11-21 00:53:42,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59045/tests/kraken/driver.html?testName=json-parse-financial) 00:53:42 INFO - 2015-11-21 00:53:42,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 157446144 00:53:42 INFO - 2015-11-21 00:53:42,646 DEBUG : BROWSER_OUTPUT: 00:53:44 INFO - 2015-11-21 00:53:44,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59045/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:53:44 INFO - 2015-11-21 00:53:44,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 170442752 00:53:44 INFO - 2015-11-21 00:53:44,828 DEBUG : BROWSER_OUTPUT: 00:53:46 INFO - 2015-11-21 00:53:46,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59045/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:53:47 INFO - 2015-11-21 00:53:47,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 165994496 00:53:47 INFO - 2015-11-21 00:53:47,212 DEBUG : BROWSER_OUTPUT: 00:53:49 INFO - 2015-11-21 00:53:49,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59045/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:53:49 INFO - 2015-11-21 00:53:49,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 171692032 00:53:49 INFO - 2015-11-21 00:53:49,842 DEBUG : BROWSER_OUTPUT: 00:53:52 INFO - 2015-11-21 00:53:52,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:53:52 INFO - 2015-11-21 00:53:52,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 178921472 00:53:52 INFO - 2015-11-21 00:53:52,810 DEBUG : BROWSER_OUTPUT: 00:53:55 INFO - 2015-11-21 00:53:55,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:53:55 INFO - 2015-11-21 00:53:55,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 176136192 00:53:55 INFO - 2015-11-21 00:53:55,933 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59045/tests/kraken/driver.html?testName=ai-astar) 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 233967616 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;103;110;112;111;100;109;109;105 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;129;148;163;125;151;153;124;158;124 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;162;160;161;161;160;163;162;161 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;84;91;72;72;73;107;94;71 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;137;90;89;90;135;90;90;138 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;110;110;109;110 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;145;145;147;145;145;145;145 00:53:57 INFO - 2015-11-21 00:53:57,893 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;95;96;96;96;95 00:53:57 INFO - 2015-11-21 00:53:57,894 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;66;63;64;63;65;63;75;62;62 00:53:57 INFO - 2015-11-21 00:53:57,894 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;69;70;68;69;69;69 00:53:57 INFO - 2015-11-21 00:53:57,894 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;86;88;85;85;87;93;87;85;86 00:53:57 INFO - 2015-11-21 00:53:57,894 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;120;115;111;120;115;129;116;121;128 00:53:57 INFO - 2015-11-21 00:53:57,894 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;141;141;143;151;148;156;150;141;139 00:53:57 INFO - 2015-11-21 00:53:57,894 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;69;68;67;69;68;71;69;71;66 00:53:57 INFO - 2015-11-21 00:53:57,894 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:53:57 INFO - 2015-11-21 00:53:57,894 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:53:57 INFO - 2015-11-21 00:53:57,894 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,904 00:53:57 INFO - 2015-11-21 00:53:57,894 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:53:57 INFO - 2015-11-21 00:53:57,894 DEBUG : BROWSER_OUTPUT: __startTimestamp1448096037888__endTimestamp 00:53:57 INFO - 2015-11-21 00:53:57,895 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,895 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:53:57 INFO - 2015-11-21 00:53:57,895 DEBUG : BROWSER_OUTPUT: Number of tests: 14 00:53:57 INFO - 2015-11-21 00:53:57,895 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,895 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.70 Median:109.50 stddev:3.83 (3.5%) stddev-sans-first:4.06 00:53:57 INFO - 2015-11-21 00:53:57,895 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 103.0 110.0 112.0 111.0 100.0 109.0 109.0 105.0 00:53:57 INFO - 2015-11-21 00:53:57,895 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,895 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.90 Median:149.50 stddev:15.07 (10.1%) stddev-sans-first:15.97 00:53:57 INFO - 2015-11-21 00:53:57,895 DEBUG : BROWSER_OUTPUT: Values: 144.0 129.0 148.0 163.0 125.0 151.0 153.0 124.0 158.0 124.0 00:53:57 INFO - 2015-11-21 00:53:57,895 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,895 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 162.0 160.0 161.0 161.0 160.0 163.0 162.0 161.0 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:72.50 stddev:12.82 (17.7%) stddev-sans-first:13.11 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 84.0 91.0 72.0 72.0 73.0 107.0 94.0 71.0 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.00 Median:90.00 stddev:22.56 (25.1%) stddev-sans-first:23.43 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 137.0 90.0 89.0 90.0 135.0 90.0 90.0 138.0 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 110.0 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 00:53:57 INFO - 2015-11-21 00:53:57,896 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 145.0 145.0 147.0 145.0 145.0 145.0 145.0 00:53:57 INFO - 2015-11-21 00:53:57,897 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,897 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 00:53:57 INFO - 2015-11-21 00:53:57,897 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 00:53:57 INFO - 2015-11-21 00:53:57,897 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,897 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.60 Median:63.50 stddev:3.86 (6.1%) stddev-sans-first:4.06 00:53:57 INFO - 2015-11-21 00:53:57,897 DEBUG : BROWSER_OUTPUT: Values: 63.0 66.0 63.0 64.0 63.0 65.0 63.0 75.0 62.0 62.0 00:53:57 INFO - 2015-11-21 00:53:57,897 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,897 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 00:53:57 INFO - 2015-11-21 00:53:57,897 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 69.0 70.0 68.0 69.0 69.0 69.0 00:53:57 INFO - 2015-11-21 00:53:57,897 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,897 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.00 stddev:2.38 (2.7%) stddev-sans-first:2.52 00:53:57 INFO - 2015-11-21 00:53:57,898 DEBUG : BROWSER_OUTPUT: Values: 87.0 86.0 88.0 85.0 85.0 87.0 93.0 87.0 85.0 86.0 00:53:57 INFO - 2015-11-21 00:53:57,898 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,898 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:120.00 stddev:5.85 (4.9%) stddev-sans-first:6.02 00:53:57 INFO - 2015-11-21 00:53:57,898 DEBUG : BROWSER_OUTPUT: Values: 115.0 120.0 115.0 111.0 120.0 115.0 129.0 116.0 121.0 128.0 00:53:57 INFO - 2015-11-21 00:53:57,898 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,898 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:145.50 stddev:5.72 (3.9%) stddev-sans-first:5.88 00:53:57 INFO - 2015-11-21 00:53:57,898 DEBUG : BROWSER_OUTPUT: Values: 141.0 141.0 141.0 143.0 151.0 148.0 156.0 150.0 141.0 139.0 00:53:57 INFO - 2015-11-21 00:53:57,898 DEBUG : BROWSER_OUTPUT: 00:53:57 INFO - 2015-11-21 00:53:57,898 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.65 (2.4%) stddev-sans-first:1.66 00:53:57 INFO - 2015-11-21 00:53:57,898 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 68.0 67.0 69.0 68.0 71.0 69.0 71.0 66.0 00:53:57 INFO - 2015-11-21 00:53:57,898 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:53:57 INFO - 2015-11-21 00:53:57,898 DEBUG : BROWSER_OUTPUT: 00:53:59 INFO - 2015-11-21 00:53:59,073 INFO : Browser exited with error code: 0 00:53:59 INFO - 2015-11-21 00:53:59,122 INFO : Completed test kraken (00:00:59) 00:53:59 INFO - 2015-11-21 00:53:59,122 INFO : Starting test v8_7 00:53:59 INFO - 2015-11-21 00:53:59,122 DEBUG : operating with platform_type : linux_ 00:53:59 INFO - 2015-11-21 00:53:59,122 INFO : Initialising browser for v8_7 test... 00:53:59 INFO - 2015-11-21 00:53:59,128 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvMwA66/profile http://localhost:59045/getInfo.html 00:54:03 INFO - 2015-11-21 00:54:03,562 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:54:03 INFO - 2015-11-21 00:54:03,562 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:54:03 INFO - 2015-11-21 00:54:03,562 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:54:03 INFO - 2015-11-21 00:54:03,562 DEBUG : BROWSER_OUTPUT: __metrics 00:54:03 INFO - 2015-11-21 00:54:03,785 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:54:05 INFO - 2015-11-21 00:54:05,297 INFO : Browser initialized. 00:54:05 INFO - 2015-11-21 00:54:05,298 INFO : Running cycle 1/1 for v8_7 test... 00:54:05 INFO - 2015-11-21 00:54:05,298 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvMwA66/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:54:17 INFO - 2015-11-21 00:54:17,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 141402112 00:54:17 INFO - 2015-11-21 00:54:17,065 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59045/tests/v8_7/run.html (next: http://localhost:59045/tests/v8_7/run.html) 00:54:38 INFO - 2015-11-21 00:54:38,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 608149504 00:54:38 INFO - 2015-11-21 00:54:38,719 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,720 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:54:38 INFO - 2015-11-21 00:54:38,720 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:54:38 INFO - 2015-11-21 00:54:38,720 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:54:38 INFO - 2015-11-21 00:54:38,720 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:54:38 INFO - 2015-11-21 00:54:38,721 DEBUG : BROWSER_OUTPUT: |0;Richards;163.18537859007833 00:54:38 INFO - 2015-11-21 00:54:38,721 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.64833462432222 00:54:38 INFO - 2015-11-21 00:54:38,721 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.4141069397042 00:54:38 INFO - 2015-11-21 00:54:38,721 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.251256281407 00:54:38 INFO - 2015-11-21 00:54:38,721 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1103.7527593818984 00:54:38 INFO - 2015-11-21 00:54:38,721 DEBUG : BROWSER_OUTPUT: |5;Earley;777.6049766718507 00:54:38 INFO - 2015-11-21 00:54:38,722 DEBUG : BROWSER_OUTPUT: |6;Boyer;11586.206896551725 00:54:38 INFO - 2015-11-21 00:54:38,722 DEBUG : BROWSER_OUTPUT: |7;RegExp;25200 00:54:38 INFO - 2015-11-21 00:54:38,722 DEBUG : BROWSER_OUTPUT: |8;Splay;661.8325642715887 00:54:38 INFO - 2015-11-21 00:54:38,722 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 00:54:38 INFO - 2015-11-21 00:54:38,722 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:54:38 INFO - 2015-11-21 00:54:38,722 DEBUG : BROWSER_OUTPUT: __startTimestamp1448096078717__endTimestamp 00:54:38 INFO - 2015-11-21 00:54:38,723 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,723 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:54:38 INFO - 2015-11-21 00:54:38,723 DEBUG : BROWSER_OUTPUT: Number of tests: 10 00:54:38 INFO - 2015-11-21 00:54:38,723 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,723 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.19 Median:163.19 stddev:0.00 (0.0%) 00:54:38 INFO - 2015-11-21 00:54:38,723 DEBUG : BROWSER_OUTPUT: Values: 163.2 00:54:38 INFO - 2015-11-21 00:54:38,724 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,724 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.65 Median:193.65 stddev:0.00 (0.0%) 00:54:38 INFO - 2015-11-21 00:54:38,724 DEBUG : BROWSER_OUTPUT: Values: 193.6 00:54:38 INFO - 2015-11-21 00:54:38,724 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,724 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.41 Median:284.41 stddev:0.00 (0.0%) 00:54:38 INFO - 2015-11-21 00:54:38,725 DEBUG : BROWSER_OUTPUT: Values: 284.4 00:54:38 INFO - 2015-11-21 00:54:38,725 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,725 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.25 Median:5050.25 stddev:0.00 (0.0%) 00:54:38 INFO - 2015-11-21 00:54:38,725 DEBUG : BROWSER_OUTPUT: Values: 5050.3 00:54:38 INFO - 2015-11-21 00:54:38,725 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,726 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1103.75 Median:1103.75 stddev:0.00 (0.0%) 00:54:38 INFO - 2015-11-21 00:54:38,727 DEBUG : BROWSER_OUTPUT: Values: 1103.8 00:54:38 INFO - 2015-11-21 00:54:38,727 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,727 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:777.60 Median:777.60 stddev:0.00 (0.0%) 00:54:38 INFO - 2015-11-21 00:54:38,727 DEBUG : BROWSER_OUTPUT: Values: 777.6 00:54:38 INFO - 2015-11-21 00:54:38,727 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,727 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11586.21 Median:11586.21 stddev:0.00 (0.0%) 00:54:38 INFO - 2015-11-21 00:54:38,727 DEBUG : BROWSER_OUTPUT: Values: 11586.2 00:54:38 INFO - 2015-11-21 00:54:38,727 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,728 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 00:54:38 INFO - 2015-11-21 00:54:38,728 DEBUG : BROWSER_OUTPUT: Values: 25200.0 00:54:38 INFO - 2015-11-21 00:54:38,728 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,728 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:661.83 Median:661.83 stddev:0.00 (0.0%) 00:54:38 INFO - 2015-11-21 00:54:38,728 DEBUG : BROWSER_OUTPUT: Values: 661.8 00:54:38 INFO - 2015-11-21 00:54:38,728 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-21 00:54:38,728 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 00:54:38 INFO - 2015-11-21 00:54:38,729 DEBUG : BROWSER_OUTPUT: Values: 4850.2 00:54:38 INFO - 2015-11-21 00:54:38,729 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:54:38 INFO - 2015-11-21 00:54:38,729 DEBUG : BROWSER_OUTPUT: 00:54:39 INFO - 2015-11-21 00:54:39,701 INFO : Browser exited with error code: 0 00:54:39 INFO - 2015-11-21 00:54:39,716 INFO : Completed test v8_7 (00:00:40) 00:54:39 INFO - 2015-11-21 00:54:39,721 INFO : Completed test suite (00:20:16) 00:54:39 INFO - 2015-11-21 00:54:39,722 DEBUG : Working with test: dromaeo_css 00:54:39 INFO - 2015-11-21 00:54:39,722 DEBUG : Generating results file: dromaeo_css 00:54:39 INFO - 2015-11-21 00:54:39,722 DEBUG : Working with test: kraken 00:54:39 INFO - 2015-11-21 00:54:39,722 DEBUG : Generating results file: kraken 00:54:39 INFO - 2015-11-21 00:54:39,722 INFO : javascript benchmark 00:54:39 INFO - 2015-11-21 00:54:39,722 DEBUG : Working with test: v8_7 00:54:39 INFO - 2015-11-21 00:54:39,722 DEBUG : Generating results file: v8_7 00:54:39 INFO - 2015-11-21 00:54:39,723 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:54:39 INFO - 2015-11-21 00:54:39,780 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 00:54:39 INFO - 2015-11-21 00:54:39,780 DEBUG : process_Request line: dromaeo_css 6987.74 graph.html#tests=[[72,63,35]] 00:54:39 INFO - 2015-11-21 00:54:39,781 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:54:39 INFO - 2015-11-21 00:54:39,811 DEBUG : process_Request line: kraken 1498.80 graph.html#tests=[[232,63,35]] 00:54:39 INFO - 2015-11-21 00:54:39,811 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:54:39 INFO - 2015-11-21 00:54:39,841 DEBUG : process_Request line: v8_7 21045.51 graph.html#tests=[[230,63,35]] 00:54:39 INFO - 2015-11-21 00:54:39,842 INFO : javascript benchmark 00:54:39 INFO - 2015-11-21 00:54:39,846 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3143.7013483719047, 3230.9353812923728, 3273.4598791199455, 3278.3443311337737, 3298.1589694627864, 5292.417834038252, 5410.107332290172, 5411.810586629469, 5429.131338985763, 5476.096444086726, 5363.0, 5427.240186373911, 5441.319835020622, 5444.482774136451, 5472.616916815825, 4928.704277743329, 4935.062338155757, 4953.653244272911, 4957.801687932497, 4982.153033984231, 4886.0, 5029.899402011957, 5057.418396884369, 5083.364579427572, 5121.1038068338075, 4847.0, 4937.185364414867, 4939.086269040221, 4944.505549445027, 4948.950510494921, 4897.118518666639, 4911.140550403665, 4912.459629440758, 4930.950690493085, 4969.4036715594, 4782.736949467778, 4901.754912254373, 4913.533214344631, 4921.778519966574, 4953.900921981576, 5203.297554830087, 5235.842924712265, 5244.0, 5249.343832020997, 5283.0, 5782.219400380979, 5787.189793428881, 5795.652260864319, 5797.739101740432, 5842.678652674102, 5777.653340799566, 5864.560157988168, 5911.054231323011, 5919.0825422059215, 5934.851628709273, 5504.7522861470925, 5516.668999860021, 5568.582356323211, 5572.414896435897, 5613.270274864323, 5991.370906054802, 6011.909821352683, 6030.4572588467245, 6036.124761909498, 6046.213992181077, 5635.887282254414, 5764.164196191528, 5816.360200377955, 5853.795117170964, 5855.326637436664, 5829.650220986669, 5926.081457374114, 5960.7019649017375, 5969.403059694083, 5974.044152935509, 5744.942550574524, 5796.797112101056, 5809.912851307234, 5818.389069147764, 5851.093080572518, 5717.799877004368, 5789.739461724233, 5798.1302804579655, 5803.448672376117, 5824.796132135355, 4484.304932735431, 4492.034212644297, 4504.09918016398, 4519.84180553679, 4575.130725162208, 4045.3931910213114, 4046.7167298288837, 4054.9391759123637, 4071.5114186297833, 4087.1008378156757, 5451.945480545223, 5608.971955140199, 5610.719464026783, 5614.69119198448, 5615.382307946123, 5784.82645520635, 5785.27684039495, 5815.621984570989, 5815.9709201453725, 5892.911606325909, 5652.576056795675, 5664.405237450009, 5665.065264231355, 5670.688112153871, 5670.829875103754, 4973.452920178777, 5221.216817477409, 5229.895402092013, 5234.241035049972, 5279.023380674587, 5943.55423343251, 5979.910301345483, 5994.790182343597, 6002.459778619946, 6062.636241825505, 5831.591788574929, 5921.526277897672, 5972.522198224218, 5992.0, 5994.820155395345, 5928.199693041384, 6044.607100538451, 6159.815205543661, 6177.722002509808, 6187.16473276102, 5722.17028530869, 5728.882867840898, 5815.912761308499, 5832.941670583409, 5882.470577648032, 5794.913076303775, 5825.79609713658, 5829.300483941955, 5838.357780644211, 5838.474537291664, 5503.0, 5619.8876022480135, 5707.771689132388, 5717.599768016199, 5717.656940583578, 5648.85877853057, 5675.517581005661, 5702.258706368146, 5704.3154821421695, 5724.856878578069, 5625.015622266005, 5626.549876009991, 5627.8593035174445, 5632.070708333079, 5632.380438151882, 5679.943200567942, 5740.0, 5746.885062298647, 5753.108268218432, 5757.798477053283, 5542.307211598551, 5581.972090139523, 5625.21247025425, 5637.746301416364, 5649.491545760901], "unit": "ms", "name": "dojo.html", "value": 5397.545727956878}, {"lowerIsBetter": false, "replicates": [555.1919043273434, 592.1473078766577, 600.5735927491484, 605.3825098399634, 606.969651517424, 31049.534256986135, 40065.19869602606, 40110.19779604406, 40132.0, 40140.0, 42776.0, 43102.4742402048, 43155.56844431555, 43211.56788432115, 43346.0, 7552.924470755304, 7607.049118860143, 8751.474911505298, 8863.11368863115, 8879.067697891725, 10537.84193237102, 10749.032587067162, 10751.0, 10756.085732712729, 10761.408122553257, 10311.587536498531, 10350.068493835553, 10364.326318789255, 10394.740131496736, 10396.06435420812, 7743.457957942946, 7801.96099019507, 10180.185585153169, 10480.68557943263, 10744.409057501834, 10283.228757843117, 10389.688309350731, 10429.374237545771, 10430.478476076241, 10431.530581123792, 40634.1873162538, 40849.59150408488, 41145.0, 41157.176856463004, 41244.0, 3196.392685389792, 3218.340240250743, 3530.9823450882836, 3883.870009652732, 3992.041909941622, 30283.545746813816, 30451.847740761154, 30921.536176957365, 31275.687243127504, 31885.521717174262, 3842.385218365076, 3875.5736868944396, 3888.183481468895, 3969.761814291152, 4085.0604360997136, 288288.0, 288488.0, 288881.5555922228, 288930.0, 290009.0, 55004.0, 55362.72318638462, 57646.7117664409, 58292.417075829544, 59273.0, 59444.70277648584, 59836.0, 59843.0, 59903.0, 59943.70028149831, 14637.853621463863, 14683.192424416546, 14690.779638305434, 14755.040922340013, 14807.70384592302, 11113.277636953733, 11163.330200188015, 11168.441577921072, 11175.608853690082, 11278.605248816417, 18891.0, 18980.335688250845, 19000.334988275343, 19054.80945190558, 19072.427827165207, 7195.316444937723, 7559.371501679115, 7565.508241964255, 7578.60440944251, 7609.277118673717, 920.2775820980498, 1023.5905637744961, 1055.875492600378, 1058.9682309530726, 1068.1348108032519, 28209.15372538827, 28666.570001449996, 28702.85648571744, 28828.0, 29018.564721529194, 997.7405874472544, 1007.1238022920106, 1049.5539395756773, 1119.4234968990977, 1162.2271189658952, 13676.65808354799, 13883.37524811386, 13904.652383690489, 15007.24963751808, 15357.385704571916, 256302.0, 260590.0, 260856.0, 261414.38585614282, 261711.0, 46874.0, 47081.5291847084, 47119.52880471152, 47155.0, 47155.5284447158, 1317.1109501086728, 1342.1142046249429, 1355.390074466494, 1359.4222455456588, 1366.2144267046488, 25754.227373178834, 27549.31126721848, 28148.0, 28870.566941496316, 28927.56608650914, 44267.77866110649, 44464.33303500385, 44524.10951781011, 44586.3312050313, 47730.761346193045, 252180.0, 299941.0, 304838.0, 305038.0, 307490.0, 28007.859960700065, 28561.42877142487, 28616.713832861406, 28640.28399289951, 28643.570346444405, 38469.61530384772, 39848.00379990524, 39960.80019599883, 40042.39936400898, 40651.0, 34971.0, 36147.096322592144, 36459.45310820287, 36559.26881462303, 36639.816800915825, 33735.493967591, 33982.320353592295, 33985.15037123993, 35643.64356356403, 36605.450918235714, 34847.47728784121, 35441.46837797487, 35645.643543564234, 35701.0, 35933.406659334905, 31330.216744580655, 32518.34963300768, 32587.34825303528, 32864.67135328616, 32945.0, 24670.506589868462, 25258.0, 25363.112291069723, 25556.616650750624, 25651.871740641178], "unit": "ms", "name": "ext.html", "value": 18502.487946484318}, {"lowerIsBetter": false, "replicates": [339.3789365461206, 342.28974877129957, 342.6813063850618, 342.76178056250916, 346.7919248450928, 14183.71632567348, 14624.268786560657, 17066.658666826672, 17272.56818579536, 18075.0, 16296.511104666879, 16421.261043253053, 16431.67136657266, 16436.096014719187, 16476.917615411938, 5254.316938797961, 5429.972850135744, 5432.320959880015, 5433.239346491494, 5434.809781657643, 4042.8584999525024, 4142.378643203513, 5390.21841832934, 5874.9118763218585, 6056.273247210341, 5930.881382372371, 5935.584509084366, 5953.732082056318, 5980.581359304851, 5996.880062398749, 5468.699221542814, 5468.91796623051, 5471.753771080291, 5472.315960504937, 5475.4524547545125, 5136.178211486182, 5186.1442861927735, 5189.922151167735, 5199.064168449678, 5200.713960732158, 20599.38201853947, 20853.791462085337, 21026.158953641836, 21101.788982110134, 21177.0, 2225.2322948582714, 2269.035659844576, 2344.812415006795, 2523.936901577457, 2669.5728683410757, 12868.871311286954, 13004.609861704164, 13149.671258218525, 13411.128276661986, 13674.794878076837, 1727.1019070083612, 1773.8846974946716, 1810.4568629411256, 1879.9906000470046, 1881.9059047047729, 58358.708206458694, 60992.0, 61771.99999999955, 61777.691111544606, 62171.37828621746, 8866.955665221632, 8912.55437228149, 9208.631654733736, 9214.078592140731, 9266.721998340061, 11622.360770157553, 11642.825357619642, 11652.70868228284, 11655.18413711032, 11755.0, 7177.497575169792, 7192.172900116449, 7295.927040729524, 7372.815679607946, 7375.4099672026105, 7314.780556583311, 7337.926620733831, 7355.301246381585, 7413.258674132544, 7414.369778568775, 5726.284214473191, 5727.39862314451, 5727.911696777599, 5733.913991290134, 5821.505172060422, 1588.4202266172763, 1602.5753175408527, 1655.5778276539647, 1746.3451205797826, 1765.7881054273312, 901.2519608724742, 905.307439808547, 916.1617120334952, 919.103873723128, 1028.6296933104077, 16359.918200408922, 16453.91773041127, 17609.0, 17777.111144442726, 18481.260749570134, 878.3149143667949, 909.1544863277084, 926.6571368593663, 934.1032608695729, 1010.4594042187395, 9147.908520914705, 9190.494522801177, 9456.338056336128, 9626.711198664052, 9630.374025688308, 545233.0, 545463.0, 550335.0, 589592.0, 590358.0, 77520.22479775242, 78718.21281787108, 78794.60602697065, 79237.0, 79301.60349198332, 1140.9372484513265, 1152.5274637398627, 1153.3944679043568, 1153.7692461507731, 1164.7612239490884, 14802.407903683732, 14810.185439800483, 14818.333175007367, 14966.251687415368, 15215.391384344945, 34130.14674633154, 34230.486542702376, 34539.30921381508, 34817.65182348144, 35362.11594710153, 47105.293420598035, 47133.7643311795, 47851.0, 47863.76068119637, 47939.76030119827, 8979.281657467518, 9115.954420227856, 9605.567749451431, 9606.759831004281, 9612.951935240559, 13258.867411325764, 16846.66306673884, 17220.138993050048, 17473.0, 17541.0, 11319.547218111184, 11389.480722308406, 13157.210567365988, 13678.247696376397, 14167.787483187554, 13419.194848309133, 13437.260950647807, 13683.315834208448, 13947.16317020982, 13997.580072597839, 11089.390083545482, 11420.086393088699, 14360.35378407995, 14362.281885905872, 14441.277936103363, 8580.313574914117, 9118.452892826452, 9133.132352426508, 9469.10043545862, 9474.715758527254, 13984.0, 13985.790213147015, 14297.785533216802, 14366.497172598909, 14824.777628335369], "unit": "ms", "name": "jquery.html", "value": 8887.147072335414}, {"lowerIsBetter": false, "replicates": [1475.2844870237936, 1512.8108986376703, 1600.1359265996362, 1650.1171873047922, 1760.779902512186, 6686.0973768541235, 6845.6919438625255, 7731.884021739678, 7932.801679958004, 7937.44437889348, 7524.4732868699075, 7675.884861727079, 7749.380049596033, 7753.457257991943, 7770.300672939435, 2227.57676041552, 2256.5035692147785, 2257.887105644711, 2259.2318611672026, 2260.886955652211, 2034.5829105033506, 2064.308456667018, 2064.370367038053, 2238.888055597222, 2313.9537209255805, 2232.2187234467888, 2232.631615783394, 2241.3276017194858, 2245.6182448983714, 2249.6175650139435, 2195.1987524553583, 2283.6346184610384, 2292.4039749665126, 2294.9541009179725, 2295.7015587973624, 1993.9700904486444, 2035.369035598969, 2035.6437623415843, 2035.9592808143902, 2272.4205327641344, 7691.038620172479, 7853.371730261565, 7864.370850331959, 7870.881936770953, 7872.055353357577, 4571.062932098912, 4632.513586073447, 4653.418322709661, 4656.813727450898, 4658.58072773452, 3111.2532992081965, 3138.356636889455, 3177.5869137012273, 3194.7763656544053, 3223.1136437479645, 1098.3958822647512, 1109.6291815617117, 1111.9332840029624, 1112.7385064509833, 1123.6797512708838, 10732.678019659423, 10776.515056822462, 10790.78418431627, 10796.892031079668, 10804.351738895613, 4129.793510324472, 4181.853635122756, 4184.309588917856, 4204.936925946114, 4223.239816832938, 9080.273578113734, 9102.362834601647, 9108.726738197865, 9128.863067053999, 9137.40606860552, 4586.954130458719, 4588.449386073693, 4588.49526552079, 4593.196190666687, 4618.0, 4154.771487568213, 4180.665546756313, 4192.11965487245, 4198.790060496963, 4202.201581699467, 3729.776213427149, 3746.269477451925, 3762.6613604775152, 3765.9246815063543, 3772.3775577030033, 1206.6741979665442, 1215.0219073645624, 1215.7811593913004, 1226.515526367098, 1239.6652903716126, 1243.4280231093617, 1244.6452760963082, 1261.5899832554273, 1270.6632742323293, 1271.0213135885317, 7355.374793142536, 7427.294407031323, 7433.888491672629, 7438.66526006331, 7496.812579685442, 468.5197672385764, 477.79454834420835, 478.8922492439243, 480.176497307113, 484.706752414784, 5272.209168624737, 5400.405955344909, 5837.124431335249, 5847.473727364558, 5900.616459930091, 9261.814763704688, 9333.160015598629, 9367.765805854908, 9391.90608093924, 9421.434713917188, 9154.81690366189, 9179.036201198778, 9191.586378612845, 9455.810883782286, 9529.952350238205, 7151.2848715128075, 7270.818229544304, 7320.96339518299, 7329.670164842488, 7351.191368949304, 7166.784996450115, 7252.347288744038, 7265.636718164176, 7311.4150867929375, 7316.926830731624, 7842.451028428183, 8249.79375515617, 8360.45657032291, 8373.95813020931, 8412.579371031547, 8485.35598221597, 8518.914810851813, 8577.270931970603, 8692.261157801659, 8705.8694119587, 6758.966205168943, 6799.082123913208, 6819.045333653392, 6822.181338239443, 6822.897656535255, 7251.803452430501, 7280.708771649287, 7338.853222935405, 7393.408527317909, 7400.629968501661, 6566.573172743756, 6733.797986060426, 6780.93219067803, 6796.592204467748, 6850.554713943578, 6678.766243181465, 6705.564138330993, 6802.693878775566, 6879.243283238739, 6908.171019477695, 6809.89785153233, 6843.076184715, 6843.973403989441, 6852.486063545154, 6883.965580172067, 6128.0, 6205.81382558524, 6246.593971391845, 6262.4990000800735, 6268.435840774352, 6460.160179176677, 6497.707603157964, 6509.056186852975, 6510.21877374718, 6514.837129071811], "unit": "ms", "name": "mootools.html", "value": 4368.920600369767}, {"lowerIsBetter": false, "replicates": [315.4889079690901, 323.3726570453319, 324.4144319503296, 326.66027331575145, 327.7410845432109, 6027.186329845469, 6068.6965651717455, 6109.708859177814, 6112.938870611292, 6114.419130182637, 5775.913361299574, 5899.469047785698, 5946.672932988684, 6016.278046634399, 6046.334903160659, 4595.103954728829, 4617.5613316735025, 4618.0, 4632.07358528294, 4633.930491042637, 4611.031683346501, 4615.215413379717, 4620.653450991173, 4629.259318509039, 4644.558766917137, 4360.520342762294, 4434.733915965036, 4474.798634061475, 4494.101179764044, 4600.493945665974, 4559.156556037144, 4576.519465456129, 4595.816167353302, 4602.332661764025, 4618.053299073682, 4012.3580227163807, 4016.9196616067516, 4021.5978402159844, 4027.7784721840285, 4028.1742242840146, 5732.369439361667, 5739.196512488255, 5746.425357464262, 5748.913766293509, 5749.1663708762, 5166.405863325728, 5307.6019298552765, 5310.654807437543, 5312.0, 5315.681059136464, 6398.232212134527, 6419.165508483868, 6421.743130274784, 6426.614403135827, 6431.646259455728, 4367.606915377632, 4371.0, 4376.737395756265, 4377.365282034088, 4380.649548036149, 6526.902096468557, 6595.505337099688, 6653.966730166367, 6672.532922695414, 6674.733010679567, 4458.0, 4464.776761161929, 4466.441694788152, 4467.0, 4468.977655111768, 4520.864374068783, 4521.186186486399, 4522.683412161117, 4523.0, 4527.728336299832, 5260.13207820713, 5270.341207349082, 5278.023565640369, 5286.259923610698, 5293.0472514946905, 6319.557630965788, 6460.483161347081, 6467.935320646733, 6471.805845824539, 6475.287718350977, 1581.3990683540412, 1592.9601759955863, 1593.2591345024618, 1594.4339759385482, 1596.3454983456727, 1025.8820235672845, 1040.8750949886062, 1041.1306559023149, 1051.458498873081, 1065.3607835298758, 6190.607113399449, 6191.659458729723, 6194.442500174916, 6201.317855035943, 6202.224721909762, 6641.369069938348, 6642.767503137367, 6647.302033286532, 6660.433863121689, 6665.066890635315, 6060.696965151725, 6108.5418593605655, 6175.505959523317, 6193.0, 6261.686915654199, 3581.94627080594, 3589.3180295744246, 3597.226596281812, 3604.1890574621025, 3617.258462015333, 6832.726690932406, 6860.416864566468, 6895.896561551581, 6915.930840691629, 6922.376986071177, 6666.233383160901, 6842.7605033823575, 6854.280300568468, 6854.588724676535, 6855.691493882788, 6901.378875901193, 6908.447324214051, 6912.550684205611, 6917.377436030782, 6924.792256232422, 6704.296048914794, 6704.631245281361, 6706.228783689743, 6707.3292670732535, 6707.832304192434, 6448.161738973903, 6653.73385064592, 6661.966690166518, 6666.899996499959, 6668.799936001928, 6922.826929326807, 6927.826804329932, 6935.479839012195, 6936.375726184466, 6939.132608423947, 4470.798814053441, 4474.977625111854, 4478.440194975628, 4483.193025255486, 4491.640668746558, 6540.50946179048, 6590.9670451647435, 6628.668566571556, 6631.502637302318, 6633.800985970429, 6482.286948435574, 6487.18910136233, 6487.708053137526, 6491.091247225298, 6508.446782023581, 6468.191476065492, 6470.158879345655, 6482.157319548429, 6487.091807146909, 6488.967555162383, 6200.596961197508, 6356.936430635635, 6372.58578192416, 6391.552591318563, 6397.520185985976, 6530.47756179495, 6532.673366331569, 6541.2477565078725, 6541.443977261986, 6544.443722283469, 6238.313785483684, 6366.458850997532, 6378.808635740936, 6379.043143528508, 6380.9361906380345], "unit": "ms", "name": "prototype.html", "value": 4823.2091842546315}, {"lowerIsBetter": false, "replicates": [757.3070640364066, 828.7928017995501, 840.9611551315483, 853.5433543054467, 855.0637052427594, 13430.865691343084, 13739.31303434828, 13770.24263665498, 13772.380242889069, 13787.379567919443, 12948.352582370868, 12982.675433114153, 13051.0, 13051.804222936664, 13059.73880522389, 655.056718325612, 663.489113382695, 797.5055465611329, 810.1736229046369, 810.4367464612097, 790.3163763344694, 818.7216346442209, 820.8645573480369, 820.979475513111, 821.0680877204356, 849.8767678686587, 862.6980556805131, 863.4732812984074, 864.5417928497906, 865.0268447996004, 696.7282759723712, 704.4223736536043, 839.4669384940546, 850.0988951711206, 855.8502262104138, 628.7516431009772, 629.0218709906094, 629.5058379172327, 629.820501157168, 629.9748010079592, 13220.801687974688, 13344.866551334557, 13365.599032029055, 13371.866281337258, 13392.330383480885, 11929.701757456047, 12012.159148859584, 12153.574624888175, 12642.431090600945, 13238.205707657571, 10054.0, 10309.896901030968, 10341.63804266847, 10491.318064325795, 10793.892061079367, 3638.727095467824, 3697.778133311983, 3730.5336832895887, 3791.431285307226, 3792.639699228569, 46617.30074048892, 47229.52770472286, 47334.76332618315, 47470.287945680495, 47492.28761568579, 9496.762580935394, 9711.27165462579, 9711.56297966579, 9810.068043535995, 9916.702498925044, 18754.437366879014, 18881.339153129575, 18883.433496995112, 19707.40877773669, 19717.408477745692, 6945.40964018054, 7202.569781129679, 7264.455165862581, 7462.776116716507, 7651.69393224276, 3852.2680690668685, 3930.194310166409, 3959.089409435846, 3981.980090099531, 3996.140829721624, 2928.736413722733, 2956.6895475975143, 2959.0383125483872, 2968.391479746647, 2969.346743716379, 530.8858595402007, 531.4180971835833, 533.4585395823243, 535.9383670877821, 557.0863783395235, 559.8068666310116, 594.5808205215313, 603.4930658247093, 640.5676168586185, 673.5655502201053, 7472.252774722593, 7821.139674635786, 7867.2919437249775, 7896.84206315882, 8000.599970001476, 524.2162966365308, 647.1166857239833, 663.9966800165968, 679.1137565477001, 727.1274470635259, 3491.773034752733, 3565.857365705395, 3742.644448777362, 3744.1388480649603, 4034.919301613951, 59440.70279648574, 60246.698766505884, 60865.69567152136, 61749.69125154345, 61824.38175618276, 46116.53883461122, 53607.46392536103, 53816.730916345165, 53942.46057539453, 53950.460495394545, 48124.51875481271, 48484.27273590899, 48508.0, 48726.512734872194, 49072.75463622659, 7576.28025337592, 7786.688532458865, 8086.312663423675, 8129.430939834155, 8130.471519351223, 37522.624773751915, 37924.0, 38297.808510957264, 38631.99999999887, 38799.6120038796, 44470.77764611286, 44559.777201113786, 44868.775656121514, 45605.543944561454, 46181.30728039149, 10326.931242038952, 10786.892131078903, 10792.892071079188, 10810.621628242974, 10852.728681783019, 11941.343226122646, 11994.580189693319, 12077.154599177973, 12830.230186188859, 12836.486540538273, 10472.834712475998, 10633.627823026158, 10666.626668066581, 10960.725981850517, 11047.0, 11472.598459054227, 11619.070474361863, 11754.76490470203, 12153.69615759613, 12183.512659493521, 7879.251471110236, 9603.663871764455, 9843.85234221473, 11034.17243706709, 11131.387773672202, 9369.12805341205, 9412.58220622906, 9933.552990115317, 9935.652252171429, 10379.377237365783, 9479.573419196015, 9548.904510954802, 9569.282303827102, 9709.70870873875, 9753.609855605697], "unit": "ms", "name": "yui.html", "value": 6224.163527442615}], "name": "dromaeo_css", "value": 6987.736665303714}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 110.0, 112.0, 111.0, 100.0, 109.0, 109.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [144.0, 129.0, 148.0, 163.0, 125.0, 151.0, 153.0, 124.0, 158.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.9}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 160.0, 161.0, 161.0, 160.0, 163.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 84.0, 91.0, 72.0, 72.0, 73.0, 107.0, 94.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 137.0, 90.0, 89.0, 90.0, 135.0, 90.0, 90.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 104.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 147.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 63.0, 64.0, 63.0, 65.0, 63.0, 75.0, 62.0, 62.0], "unit": "ms", "name": "json-parse-financial", "value": 64.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 70.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 88.0, 85.0, 85.0, 87.0, 93.0, 87.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [115.0, 120.0, 115.0, 111.0, 120.0, 115.0, 129.0, 116.0, 121.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [141.0, 141.0, 141.0, 143.0, 151.0, 148.0, 156.0, 150.0, 141.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.1}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 67.0, 69.0, 68.0, 71.0, 69.0, 71.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1498.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.18537859007833], "unit": "score", "name": "Richards", "value": 216.33065600000006}, {"lowerIsBetter": false, "replicates": [193.64833462432222], "unit": "score", "name": "DeltaBlue", "value": 341.433352}, {"lowerIsBetter": false, "replicates": [284.4141069397042], "unit": "score", "name": "Encrypt", "value": 935.8923959999998}, {"lowerIsBetter": false, "replicates": [5050.251256281407], "unit": "score", "name": "Decrypt", "value": 52.70648656716413}, {"lowerIsBetter": false, "replicates": [1103.7527593818984], "unit": "score", "name": "RayTrace", "value": 670.4300340000001}, {"lowerIsBetter": false, "replicates": [777.6049766718507], "unit": "score", "name": "Earley", "value": 857.0714179999998}, {"lowerIsBetter": false, "replicates": [11586.206896551725], "unit": "score", "name": "Boyer", "value": 57.52210416666671}, {"lowerIsBetter": false, "replicates": [25200.0], "unit": "score", "name": "RegExp", "value": 36.150198412698415}, {"lowerIsBetter": false, "replicates": [661.8325642715887], "unit": "score", "name": "Splay", "value": 123.12932968127491}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21045.50606264774}]} 00:54:39 INFO - RETURN: dromaeo_css: 6987.74 00:54:39 INFO - RETURN: kraken: 1498.80 00:54:39 INFO - RETURN: v8_7: 21045.51 00:54:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "21045.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1498.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6987.74"}}} 00:54:39 INFO - Return code: 0 00:54:39 INFO - # TBPL SUCCESS # 00:54:39 INFO - Running post-action listener: _resource_record_post_action 00:54:39 INFO - Running post-run listener: _resource_record_post_run 00:54:41 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 12288; Write bytes: 516960256; Read time: 2052; Write time: 1313900 00:54:41 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 4096; Write bytes: 184918016; Read time: 340; Write time: 432508 00:54:41 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8192; Write bytes: 306864128; Read time: 1712; Write time: 797976 00:54:41 INFO - Running post-run listener: _upload_blobber_files 00:54:41 INFO - Blob upload gear active. 00:54:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 00:54:41 INFO - Copying logs to upload dir... 00:54:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.753185 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-21 00:54:40.875949) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 00:54:40.879541) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009982 build_url: 'https://queue.taskcluster.net/v1/task/BCfS6yFRSTiOBMbt_Kcovw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 00:54:40.931751) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 00:54:40.932329) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448094476.776237-448699520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 00:54:40.982203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 00:54:40.982508) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 00:54:40.982846) ========= ========= Total master_lag: 0.26 =========