builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1448026534.56 results: success (0) buildid: 20151120030227 builduid: 5a10f9ad2c234d3696596db9ce2d60d8 revision: 3835b568092ae3b71adc931d24928670ad7141a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:34.558025) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:34.558447) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:34.558719) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006410 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:34.586710) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:34.587014) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:34.609578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:34.609881) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.37 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:34.988904) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:34.989235) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:34.989606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:34.989877) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 05:35:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-11-20 05:35:35 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.211526 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.244100) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.244417) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017627 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.303605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.303909) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --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=0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 05:35:35,498 truncating revision to first 12 chars 2015-11-20 05:35:35,498 Setting DEBUG logging. 2015-11-20 05:35:35,498 attempt 1/10 2015-11-20 05:35:35,498 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3835b568092a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 05:35:36,147 unpacking tar archive at: mozilla-central-3835b568092a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.946152 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:36.263313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:36.263620) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:36.273233) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:36.273519) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:36.273889) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-20 05:35:36.274181) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:35:36 INFO - MultiFileLogger online at 20151120 05:35:36 in /builds/slave/test-pgo 05:35:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:35:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:35:36 INFO - {'append_to_log': False, 05:35:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:35:36 INFO - 'blob_upload_branch': 'Firefox', 05:35:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:35:36 INFO - 'branch': 'Firefox', 05:35:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:36 INFO - 'config_files': ('talos/linux_config.py',), 05:35:36 INFO - 'default_actions': ('clobber', 05:35:36 INFO - 'read-buildbot-config', 05:35:36 INFO - 'download-and-extract', 05:35:36 INFO - 'populate-webroot', 05:35:36 INFO - 'create-virtualenv', 05:35:36 INFO - 'install', 05:35:36 INFO - 'run-tests'), 05:35:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:36 INFO - 'download_minidump_stackwalk': True, 05:35:36 INFO - 'download_symbols': 'ondemand', 05:35:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:36 INFO - 'installer_path': 'installer.exe', 05:35:36 INFO - 'log_level': 'info', 05:35:36 INFO - 'log_name': 'talos', 05:35:36 INFO - 'log_to_console': True, 05:35:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:35:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:35:36 INFO - 'opt_config_files': (), 05:35:36 INFO - 'pip_index': False, 05:35:36 INFO - 'sps_profile': False, 05:35:36 INFO - 'sps_profile_interval': 0, 05:35:36 INFO - 'suite': 'dromaeojs', 05:35:36 INFO - 'system_bits': '64', 05:35:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:36 INFO - 'title': 'talos-linux64-ix-035', 05:35:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:36 INFO - 'use_talos_json': True, 05:35:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:35:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:36 INFO - 'work_dir': 'build'} 05:35:36 INFO - ##### 05:35:36 INFO - ##### Running clobber step. 05:35:36 INFO - ##### 05:35:36 INFO - Running pre-action listener: _resource_record_pre_action 05:35:36 INFO - Running main action method: clobber 05:35:36 INFO - rmtree: /builds/slave/test-pgo/build 05:35:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:35:37 INFO - Running post-action listener: _resource_record_post_action 05:35:37 INFO - ##### 05:35:37 INFO - ##### Running read-buildbot-config step. 05:35:37 INFO - ##### 05:35:37 INFO - Running pre-action listener: _resource_record_pre_action 05:35:37 INFO - Running main action method: read_buildbot_config 05:35:37 INFO - Using buildbot properties: 05:35:37 INFO - { 05:35:37 INFO - "properties": { 05:35:37 INFO - "buildnumber": 570, 05:35:37 INFO - "product": "firefox", 05:35:37 INFO - "script_repo_revision": "production", 05:35:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:35:37 INFO - "repository": "", 05:35:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:35:37 INFO - "buildid": "20151120030227", 05:35:37 INFO - "slavename": "talos-linux64-ix-035", 05:35:37 INFO - "stage_platform": "linux64-pgo", 05:35:37 INFO - "basedir": "/builds/slave/test-pgo", 05:35:37 INFO - "nightly_build": "True", 05:35:37 INFO - "project": "", 05:35:37 INFO - "platform": "ubuntu64_hw", 05:35:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:35:37 INFO - "slavebuilddir": "test", 05:35:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:35:37 INFO - "branch": "mozilla-central", 05:35:37 INFO - "repo_path": "mozilla-central", 05:35:37 INFO - "pgo_build": "True", 05:35:37 INFO - "builduid": "5a10f9ad2c234d3696596db9ce2d60d8", 05:35:37 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 05:35:37 INFO - }, 05:35:37 INFO - "sourcestamp": { 05:35:37 INFO - "repository": "", 05:35:37 INFO - "hasPatch": false, 05:35:37 INFO - "project": "", 05:35:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:35:37 INFO - "changes": [ 05:35:37 INFO - { 05:35:37 INFO - "category": null, 05:35:37 INFO - "files": [ 05:35:37 INFO - { 05:35:37 INFO - "url": null, 05:35:37 INFO - "name": "https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:35:37 INFO - } 05:35:37 INFO - ], 05:35:37 INFO - "repository": "", 05:35:37 INFO - "rev": "3835b568092ae3b71adc931d24928670ad7141a7", 05:35:37 INFO - "who": "sendchange", 05:35:37 INFO - "when": 1448026465, 05:35:37 INFO - "number": 6688414, 05:35:37 INFO - "comments": "", 05:35:37 INFO - "project": "", 05:35:37 INFO - "at": "Fri 20 Nov 2015 05:34:25", 05:35:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:35:37 INFO - "revlink": "", 05:35:37 INFO - "properties": [ 05:35:37 INFO - [ 05:35:37 INFO - "buildid", 05:35:37 INFO - "20151120030227", 05:35:37 INFO - "Change" 05:35:37 INFO - ], 05:35:37 INFO - [ 05:35:37 INFO - "builduid", 05:35:37 INFO - "5a10f9ad2c234d3696596db9ce2d60d8", 05:35:37 INFO - "Change" 05:35:37 INFO - ], 05:35:37 INFO - [ 05:35:37 INFO - "nightly_build", 05:35:37 INFO - "True", 05:35:37 INFO - "Change" 05:35:37 INFO - ], 05:35:37 INFO - [ 05:35:37 INFO - "pgo_build", 05:35:37 INFO - "True", 05:35:37 INFO - "Change" 05:35:37 INFO - ] 05:35:37 INFO - ], 05:35:37 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 05:35:37 INFO - } 05:35:37 INFO - ], 05:35:37 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 05:35:37 INFO - } 05:35:37 INFO - } 05:35:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:35:37 INFO - Running post-action listener: _resource_record_post_action 05:35:37 INFO - ##### 05:35:37 INFO - ##### Running download-and-extract step. 05:35:37 INFO - ##### 05:35:37 INFO - Running pre-action listener: _resource_record_pre_action 05:35:37 INFO - Running main action method: download_and_extract 05:35:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:35: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')]} 05:35:37 INFO - https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:35:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/test_packages.json 05:35:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/test_packages.json 05:35:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:35:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:35:38 INFO - Downloaded 1302 bytes. 05:35:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:35:38 INFO - Using the following test package requirements: 05:35:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:35:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:38 INFO - u'jsshell-linux-x86_64.zip'], 05:35:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:35:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:35:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:35:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:35:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:35:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:38 INFO - https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:35:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:40 INFO - Downloaded 22520846 bytes. 05:35:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:35:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:35:41 INFO - Return code: 0 05:35:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:41 INFO - https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:35:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:56 INFO - Downloaded 22520846 bytes. 05:35:56 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 05:35:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:56 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 05:35:57 INFO - Return code: 0 05:35:57 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')]} 05:35:57 INFO - https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:35:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:58 INFO - Downloaded 11130997 bytes. 05:35:58 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 05:35:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:58 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 05:35:58 INFO - Return code: 0 05:35: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')]} 05:35:58 INFO - https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:35:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:59 INFO - Downloaded 57346532 bytes. 05:35:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:59 INFO - mkdir: /builds/slave/test-pgo/properties 05:35:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:35:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:35:59 INFO - Contents: 05:35:59 INFO - build_url:https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:59 INFO - Running post-action listener: _resource_record_post_action 05:35:59 INFO - Running post-action listener: set_extra_try_arguments 05:35:59 INFO - ##### 05:35:59 INFO - ##### Running populate-webroot step. 05:35:59 INFO - ##### 05:35:59 INFO - Running pre-action listener: _resource_record_pre_action 05:35:59 INFO - Running main action method: populate_webroot 05:35:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:35:59 INFO - '../fennec_ids.txt'], 05:35:59 INFO - 'tests': ['tcheck2']}, 05:35:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:59 INFO - '--tppagecycles', 05:35:59 INFO - '7'], 05:35:59 INFO - 'tests': ['tsvgm']}}, 05:35:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:35:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:35:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:35:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:35:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:35:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'talos_options': ['--e10s'], 05:35:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'tests': ['damp', 'tps']}, 05:35:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'talos_options': ['--e10s'], 05:35:59 INFO - 'tests': ['damp', 'tps']}, 05:35:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:35:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:59 INFO - 'other': {'tests': ['a11yr', 05:35:59 INFO - 'ts_paint', 05:35:59 INFO - 'tpaint', 05:35:59 INFO - 'sessionrestore', 05:35:59 INFO - 'sessionrestore_no_auto_restore']}, 05:35:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:35:59 INFO - 'tests': ['a11yr', 05:35:59 INFO - 'ts_paint', 05:35:59 INFO - 'tpaint', 05:35:59 INFO - 'sessionrestore', 05:35:59 INFO - 'sessionrestore_no_auto_restore']}, 05:35:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:35:59 INFO - 'tests': ['a11yr', 05:35:59 INFO - 'ts_paint', 05:35:59 INFO - 'tpaint', 05:35:59 INFO - 'sessionrestore', 05:35:59 INFO - 'sessionrestore_no_auto_restore']}, 05:35:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:35:59 INFO - 'tests': ['a11yr', 05:35:59 INFO - 'ts_paint', 05:35:59 INFO - 'tpaint', 05:35:59 INFO - 'sessionrestore', 05:35:59 INFO - 'sessionrestore_no_auto_restore']}, 05:35:59 INFO - 'other_l64': {'tests': ['a11yr', 05:35:59 INFO - 'ts_paint', 05:35:59 INFO - 'tpaint', 05:35:59 INFO - 'sessionrestore', 05:35:59 INFO - 'sessionrestore_no_auto_restore']}, 05:35:59 INFO - 'other_nol64': {'tests': ['a11yr', 05:35:59 INFO - 'ts_paint', 05:35:59 INFO - 'tpaint', 05:35:59 INFO - 'sessionrestore', 05:35:59 INFO - 'sessionrestore_no_auto_restore']}, 05:35:59 INFO - 'svgr': {'tests': ['tsvgx', 05:35:59 INFO - 'tsvgr_opacity', 05:35:59 INFO - 'tart', 05:35:59 INFO - 'tscrollx', 05:35:59 INFO - 'cart']}, 05:35:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:35:59 INFO - 'tests': ['tsvgx', 05:35:59 INFO - 'tsvgr_opacity', 05:35:59 INFO - 'tart', 05:35:59 INFO - 'tscrollx', 05:35:59 INFO - 'cart']}, 05:35:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'tests': ['tp5o']}, 05:35:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'talos_options': ['--e10s'], 05:35:59 INFO - 'tests': ['tp5o']}, 05:35:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'talos_options': ['--xperf_path', 05:35:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:59 INFO - 'tests': ['tp5n']}, 05:35:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'talos_options': ['--e10s', 05:35:59 INFO - '--xperf_path', 05:35:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:59 INFO - 'tests': ['tp5n']}}, 05:35:59 INFO - 'talos.zip': {'path': '', 05:35:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:59 INFO - Running post-action listener: _resource_record_post_action 05:35:59 INFO - ##### 05:35:59 INFO - ##### Running create-virtualenv step. 05:35:59 INFO - ##### 05:35:59 INFO - Running pre-action listener: _resource_record_pre_action 05:35:59 INFO - Running main action method: create_virtualenv 05:35:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:35:59 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 05:35:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:35:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:59 INFO - Using real prefix '/usr' 05:35:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:36:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:36:02 INFO - Installing pip.................done. 05:36:02 INFO - Return code: 0 05:36:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f125e0eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf976c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10497c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dd70>, '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 0x108eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', '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 05:36:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:36:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:36:02 INFO - Using env: {'DISPLAY': ':0', 05:36:02 INFO - 'HOME': '/home/cltbld', 05:36:02 INFO - 'LANG': 'en_US.UTF-8', 05:36:02 INFO - 'LANGUAGE': 'en_US:en', 05:36:02 INFO - 'LOGNAME': 'cltbld', 05:36:02 INFO - 'MAIL': '/var/mail/cltbld', 05:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:02 INFO - 'MOZ_NO_REMOTE': '1', 05:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:02 INFO - 'NO_EM_RESTART': '1', 05:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:02 INFO - 'SHELL': '/bin/bash', 05:36:02 INFO - 'SHLVL': '1', 05:36:02 INFO - 'TERM': 'linux', 05:36:02 INFO - 'TMOUT': '86400', 05:36:02 INFO - 'USER': 'cltbld', 05:36:02 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', 05:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:02 INFO - '_': '/tools/buildbot/bin/python'} 05:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:02 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 05:36:02 INFO - Cleaning up... 05:36:02 INFO - Return code: 0 05:36:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f125e0eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf976c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10497c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dd70>, '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 0x108eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', '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 05:36:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:36:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:36:02 INFO - Using env: {'DISPLAY': ':0', 05:36:02 INFO - 'HOME': '/home/cltbld', 05:36:02 INFO - 'LANG': 'en_US.UTF-8', 05:36:02 INFO - 'LANGUAGE': 'en_US:en', 05:36:02 INFO - 'LOGNAME': 'cltbld', 05:36:02 INFO - 'MAIL': '/var/mail/cltbld', 05:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:02 INFO - 'MOZ_NO_REMOTE': '1', 05:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:02 INFO - 'NO_EM_RESTART': '1', 05:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:02 INFO - 'SHELL': '/bin/bash', 05:36:02 INFO - 'SHLVL': '1', 05:36:02 INFO - 'TERM': 'linux', 05:36:02 INFO - 'TMOUT': '86400', 05:36:02 INFO - 'USER': 'cltbld', 05:36:02 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', 05:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:02 INFO - '_': '/tools/buildbot/bin/python'} 05:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:02 INFO - Downloading/unpacking psutil>=0.7.1 05:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:04 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:36:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:36:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:36:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:04 INFO - Installing collected packages: psutil 05:36:04 INFO - Running setup.py install for psutil 05:36:04 INFO - building 'psutil._psutil_linux' extension 05:36:04 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 05:36:04 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 05:36:05 INFO - building 'psutil._psutil_posix' extension 05:36:05 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 05:36:05 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 05:36:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:05 INFO - Successfully installed psutil 05:36:05 INFO - Cleaning up... 05:36:05 INFO - Return code: 0 05:36:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:36: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')]} 05:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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', '--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 0x7f125e0eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf976c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10497c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dd70>, '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 0x108eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', '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 05:36:05 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 05:36:05 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 05:36:05 INFO - Using env: {'DISPLAY': ':0', 05:36:05 INFO - 'HOME': '/home/cltbld', 05:36:05 INFO - 'LANG': 'en_US.UTF-8', 05:36:05 INFO - 'LANGUAGE': 'en_US:en', 05:36:05 INFO - 'LOGNAME': 'cltbld', 05:36:05 INFO - 'MAIL': '/var/mail/cltbld', 05:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:05 INFO - 'MOZ_NO_REMOTE': '1', 05:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:05 INFO - 'NO_EM_RESTART': '1', 05:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:05 INFO - 'SHELL': '/bin/bash', 05:36:05 INFO - 'SHLVL': '1', 05:36:05 INFO - 'TERM': 'linux', 05:36:05 INFO - 'TMOUT': '86400', 05:36:05 INFO - 'USER': 'cltbld', 05:36:05 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', 05:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:05 INFO - '_': '/tools/buildbot/bin/python'} 05:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:36:05 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 05:36:05 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 05:36:05 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 05:36:05 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 05:36:05 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 05:36:05 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 05:36:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:36:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:36:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:36:07 INFO - Installing collected packages: mozsystemmonitor 05:36:07 INFO - Running setup.py install for mozsystemmonitor 05:36:07 INFO - Successfully installed mozsystemmonitor 05:36:07 INFO - Cleaning up... 05:36:07 INFO - Return code: 0 05:36:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:07 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 0x7f125e0eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf976c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10497c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dd70>, '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 0x108eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', '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 05:36:07 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 05:36:07 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 05:36:07 INFO - Using env: {'DISPLAY': ':0', 05:36:07 INFO - 'HOME': '/home/cltbld', 05:36:07 INFO - 'LANG': 'en_US.UTF-8', 05:36:07 INFO - 'LANGUAGE': 'en_US:en', 05:36:07 INFO - 'LOGNAME': 'cltbld', 05:36:07 INFO - 'MAIL': '/var/mail/cltbld', 05:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:07 INFO - 'MOZ_NO_REMOTE': '1', 05:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:07 INFO - 'NO_EM_RESTART': '1', 05:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:07 INFO - 'SHELL': '/bin/bash', 05:36:07 INFO - 'SHLVL': '1', 05:36:07 INFO - 'TERM': 'linux', 05:36:07 INFO - 'TMOUT': '86400', 05:36:07 INFO - 'USER': 'cltbld', 05:36:07 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', 05:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:07 INFO - '_': '/tools/buildbot/bin/python'} 05:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:07 INFO - Downloading/unpacking blobuploader==1.2.4 05:36:07 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 05:36:07 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 05:36:07 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 05:36:07 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 05:36:07 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 05:36:07 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 05:36:09 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:36:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:36:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:36:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:09 INFO - Downloading docopt-0.6.1.tar.gz 05:36:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:36:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:10 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:10 INFO - Running setup.py install for blobuploader 05:36:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:36:10 INFO - Running setup.py install for requests 05:36:10 INFO - Running setup.py install for docopt 05:36:10 INFO - Successfully installed blobuploader requests docopt 05:36:10 INFO - Cleaning up... 05:36:10 INFO - Return code: 0 05:36:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:10 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 0x7f125e0eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf976c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10497c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dd70>, '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 0x108eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', '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 05:36:10 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 05:36:10 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 05:36:10 INFO - Using env: {'DISPLAY': ':0', 05:36:10 INFO - 'HOME': '/home/cltbld', 05:36:10 INFO - 'LANG': 'en_US.UTF-8', 05:36:10 INFO - 'LANGUAGE': 'en_US:en', 05:36:10 INFO - 'LOGNAME': 'cltbld', 05:36:10 INFO - 'MAIL': '/var/mail/cltbld', 05:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:10 INFO - 'MOZ_NO_REMOTE': '1', 05:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:10 INFO - 'NO_EM_RESTART': '1', 05:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:10 INFO - 'SHELL': '/bin/bash', 05:36:10 INFO - 'SHLVL': '1', 05:36:10 INFO - 'TERM': 'linux', 05:36:10 INFO - 'TMOUT': '86400', 05:36:10 INFO - 'USER': 'cltbld', 05:36:10 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', 05:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:10 INFO - '_': '/tools/buildbot/bin/python'} 05:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:10 INFO - Running setup.py (path:/tmp/pip-_sslol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:10 INFO - Running setup.py (path:/tmp/pip-4HLZZ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:10 INFO - Running setup.py (path:/tmp/pip-OdhfOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:11 INFO - Running setup.py (path:/tmp/pip-GUyyIQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:11 INFO - Running setup.py (path:/tmp/pip-vO0XCI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:11 INFO - Running setup.py (path:/tmp/pip-lXmbHa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:11 INFO - Running setup.py (path:/tmp/pip-y_9Ccd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:11 INFO - Running setup.py (path:/tmp/pip-FUXXWi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:11 INFO - Running setup.py (path:/tmp/pip-2J4Cfb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:11 INFO - Running setup.py (path:/tmp/pip-Cwrdyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:11 INFO - Running setup.py (path:/tmp/pip-wzl9Sy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:11 INFO - Running setup.py (path:/tmp/pip-skSTQu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:11 INFO - Running setup.py (path:/tmp/pip-nyABN7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:11 INFO - Running setup.py (path:/tmp/pip-wq2G4c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:11 INFO - Running setup.py (path:/tmp/pip-6BckTN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:11 INFO - Running setup.py (path:/tmp/pip-fw8Dgl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:11 INFO - Running setup.py (path:/tmp/pip-lCFXR8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:12 INFO - Running setup.py install for manifestparser 05:36:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:36:12 INFO - Running setup.py install for mozcrash 05:36:12 INFO - Running setup.py install for mozdebug 05:36:12 INFO - Running setup.py install for mozdevice 05:36:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:36:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:36:12 INFO - Running setup.py install for mozfile 05:36:12 INFO - Running setup.py install for mozhttpd 05:36:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:36:12 INFO - Running setup.py install for mozinfo 05:36:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:36:12 INFO - Running setup.py install for mozInstall 05:36:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:36:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:36:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:36:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:36:12 INFO - Running setup.py install for mozleak 05:36:12 INFO - Running setup.py install for mozlog 05:36:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:36:13 INFO - Running setup.py install for moznetwork 05:36:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:36:13 INFO - Running setup.py install for mozprocess 05:36:13 INFO - Running setup.py install for mozprofile 05:36:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:36:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:36:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:36:13 INFO - Running setup.py install for mozrunner 05:36:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:36:13 INFO - Running setup.py install for mozscreenshot 05:36:13 INFO - Running setup.py install for moztest 05:36:13 INFO - Running setup.py install for mozversion 05:36:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:36:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:13 INFO - Cleaning up... 05:36:13 INFO - Return code: 0 05:36:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f125e0eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf976c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10497c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dd70>, '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 0x108eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', '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 05:36:13 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 05:36:13 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 05:36:13 INFO - Using env: {'DISPLAY': ':0', 05:36:13 INFO - 'HOME': '/home/cltbld', 05:36:13 INFO - 'LANG': 'en_US.UTF-8', 05:36:13 INFO - 'LANGUAGE': 'en_US:en', 05:36:13 INFO - 'LOGNAME': 'cltbld', 05:36:13 INFO - 'MAIL': '/var/mail/cltbld', 05:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:13 INFO - 'MOZ_NO_REMOTE': '1', 05:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:13 INFO - 'NO_EM_RESTART': '1', 05:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:13 INFO - 'SHELL': '/bin/bash', 05:36:13 INFO - 'SHLVL': '1', 05:36:13 INFO - 'TERM': 'linux', 05:36:13 INFO - 'TMOUT': '86400', 05:36:13 INFO - 'USER': 'cltbld', 05:36:13 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', 05:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:13 INFO - '_': '/tools/buildbot/bin/python'} 05:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:14 INFO - Running setup.py (path:/tmp/pip-rbRcgE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:14 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)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:14 INFO - Running setup.py (path:/tmp/pip-1LQHTh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:14 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)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:14 INFO - Running setup.py (path:/tmp/pip-MtIVG7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:14 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)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:14 INFO - Running setup.py (path:/tmp/pip-DBG3vM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:14 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)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:14 INFO - Running setup.py (path:/tmp/pip-47ssqd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:14 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)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:14 INFO - Running setup.py (path:/tmp/pip-p7R2RT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:14 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)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:14 INFO - Running setup.py (path:/tmp/pip-lgNT42-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:14 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)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:14 INFO - Running setup.py (path:/tmp/pip-lawnIb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:14 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)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:14 INFO - Running setup.py (path:/tmp/pip-jJvxWR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:14 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)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:14 INFO - Running setup.py (path:/tmp/pip-kJ89LR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:14 INFO - Running setup.py (path:/tmp/pip-HUFL8l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:14 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)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:14 INFO - Running setup.py (path:/tmp/pip-GregeP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:14 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)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:14 INFO - Running setup.py (path:/tmp/pip-Y1Kn3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:14 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)) 05:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:14 INFO - Running setup.py (path:/tmp/pip-VVx8DV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:15 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)) 05:36:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:15 INFO - Running setup.py (path:/tmp/pip-Waaaxm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:15 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)) 05:36:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:15 INFO - Running setup.py (path:/tmp/pip-_Odh5n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:15 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)) 05:36:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:15 INFO - Running setup.py (path:/tmp/pip-NxkrQZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:15 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)) 05:36:15 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)) 05:36:15 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)) 05:36:15 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)) 05:36:15 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)) 05:36:15 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)) 05:36:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:17 INFO - Downloading blessings-1.5.1.tar.gz 05:36:17 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 05:36:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:17 INFO - Installing collected packages: blessings 05:36:17 INFO - Running setup.py install for blessings 05:36:17 INFO - Successfully installed blessings 05:36:17 INFO - Cleaning up... 05:36:17 INFO - Return code: 0 05:36:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:36:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:36:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:36:17 INFO - Reading from file tmpfile_stdout 05:36:17 INFO - Current package versions: 05:36:17 INFO - argparse == 1.2.1 05:36:17 INFO - blessings == 1.5.1 05:36:17 INFO - blobuploader == 1.2.4 05:36:17 INFO - docopt == 0.6.1 05:36:17 INFO - manifestparser == 1.1 05:36:17 INFO - mozInstall == 1.12 05:36:17 INFO - mozcrash == 0.16 05:36:17 INFO - mozdebug == 0.1 05:36:17 INFO - mozdevice == 0.47 05:36:17 INFO - mozfile == 1.2 05:36:17 INFO - mozhttpd == 0.7 05:36:17 INFO - mozinfo == 0.9 05:36:17 INFO - mozleak == 0.1 05:36:17 INFO - mozlog == 3.0 05:36:17 INFO - moznetwork == 0.27 05:36:17 INFO - mozprocess == 0.22 05:36:17 INFO - mozprofile == 0.27 05:36:17 INFO - mozrunner == 6.11 05:36:17 INFO - mozscreenshot == 0.1 05:36:17 INFO - mozsystemmonitor == 0.0 05:36:17 INFO - moztest == 0.7 05:36:17 INFO - mozversion == 1.4 05:36:17 INFO - psutil == 3.1.1 05:36:17 INFO - requests == 1.2.3 05:36:17 INFO - wsgiref == 0.1.2 05:36:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f125e0eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf976c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10497c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dd70>, '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 0x108eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', '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 05:36:17 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 05:36:17 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 05:36:17 INFO - Using env: {'DISPLAY': ':0', 05:36:17 INFO - 'HOME': '/home/cltbld', 05:36:17 INFO - 'LANG': 'en_US.UTF-8', 05:36:17 INFO - 'LANGUAGE': 'en_US:en', 05:36:17 INFO - 'LOGNAME': 'cltbld', 05:36:17 INFO - 'MAIL': '/var/mail/cltbld', 05:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:17 INFO - 'MOZ_NO_REMOTE': '1', 05:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:17 INFO - 'NO_EM_RESTART': '1', 05:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:17 INFO - 'SHELL': '/bin/bash', 05:36:17 INFO - 'SHLVL': '1', 05:36:17 INFO - 'TERM': 'linux', 05:36:17 INFO - 'TMOUT': '86400', 05:36:17 INFO - 'USER': 'cltbld', 05:36:17 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', 05:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:17 INFO - '_': '/tools/buildbot/bin/python'} 05:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:17 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)) 05:36:17 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)) 05:36:17 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)) 05:36:17 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)) 05:36:17 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)) 05:36:17 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)) 05:36:17 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)) 05:36:17 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)) 05:36:17 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)) 05:36:17 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)) 05:36:17 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)) 05:36:17 INFO - Cleaning up... 05:36:17 INFO - Return code: 0 05:36:17 INFO - Running post-action listener: _resource_record_post_action 05:36:17 INFO - Running post-action listener: _start_resource_monitoring 05:36:17 INFO - Starting resource monitoring. 05:36:17 INFO - ##### 05:36:17 INFO - ##### Running install step. 05:36:17 INFO - ##### 05:36:17 INFO - Running pre-action listener: _resource_record_pre_action 05:36:17 INFO - Running main action method: install 05:36:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:36:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:36:18 INFO - Reading from file tmpfile_stdout 05:36:18 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:36:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:36:18 INFO - Reading from file tmpfile_stdout 05:36:18 INFO - Output received: 05:36:18 INFO - Usage: mozinstall [options] installer 05:36:18 INFO - Options: 05:36:18 INFO - -h, --help show this help message and exit 05:36:18 INFO - -d DEST, --destination=DEST 05:36:18 INFO - Directory to install application into. [default: 05:36:18 INFO - "/builds/slave/test-pgo"] 05:36:18 INFO - --app=APP Application being installed. [default: firefox] 05:36:18 INFO - mkdir: /builds/slave/test-pgo/build/application 05:36:18 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'] 05:36:18 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 05:36:32 INFO - Reading from file tmpfile_stdout 05:36:32 INFO - Output received: 05:36:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:36:32 INFO - Running post-action listener: _resource_record_post_action 05:36:32 INFO - ##### 05:36:32 INFO - ##### Running run-tests step. 05:36:32 INFO - ##### 05:36:32 INFO - Running pre-action listener: _resource_record_pre_action 05:36:32 INFO - Running main action method: run_tests 05:36:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:36:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:36:32 INFO - Python 2.7.3 05:36:32 INFO - Return code: 0 05:36:32 INFO - grabbing minidump binary from tooltool 05:36:32 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')]} 05:36:32 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 0x108dd70>, '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 0x108eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:36:32 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 05:36:32 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 05:36:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:32 INFO - Return code: 0 05:36:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:36:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:36:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:36:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:36:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:36:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:36:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 05:36:32 INFO - Using env: {'DISPLAY': ':0', 05:36:32 INFO - 'HOME': '/home/cltbld', 05:36:32 INFO - 'LANG': 'en_US.UTF-8', 05:36:32 INFO - 'LANGUAGE': 'en_US:en', 05:36:32 INFO - 'LOGNAME': 'cltbld', 05:36:32 INFO - 'MAIL': '/var/mail/cltbld', 05:36:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:36:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:32 INFO - 'MOZ_NO_REMOTE': '1', 05:36:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:32 INFO - 'NO_EM_RESTART': '1', 05:36:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:36:32 INFO - 'SHELL': '/bin/bash', 05:36:32 INFO - 'SHLVL': '1', 05:36:32 INFO - 'TERM': 'linux', 05:36:32 INFO - 'TMOUT': '86400', 05:36:32 INFO - 'USER': 'cltbld', 05:36:32 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687', 05:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:32 INFO - '_': '/tools/buildbot/bin/python'} 05:36:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 05:36:32 INFO - mozversion INFO | application_buildid: 20151120030227 05:36:32 INFO - mozversion INFO | application_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 05:36:32 INFO - mozversion INFO | application_display_name: Nightly 05:36:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:32 INFO - mozversion INFO | application_name: Firefox 05:36:32 INFO - mozversion INFO | application_remotingname: firefox 05:36:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:36:32 INFO - mozversion INFO | application_vendor: Mozilla 05:36:32 INFO - mozversion INFO | application_version: 45.0a1 05:36:32 INFO - mozversion INFO | platform_buildid: 20151120030227 05:36:32 INFO - mozversion INFO | platform_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 05:36:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:36:32 INFO - mozversion INFO | platform_version: 45.0a1 05:36:32 INFO - 2015-11-20 05:36:32,852 DEBUG : using testdate: 1448026592 05:36:32 INFO - 2015-11-20 05:36:32,852 DEBUG : actual date: 1448026592 05:36:32 INFO - 2015-11-20 05:36:32,862 INFO : starting webserver on 'localhost:53821' 05:36:32 INFO - 2015-11-20 05:36:32,863 INFO : Starting test suite talos-linux64-ix-035 05:36:32 INFO - 2015-11-20 05:36:32,863 INFO : Starting test dromaeo_css 05:36:32 INFO - 2015-11-20 05:36:32,863 DEBUG : operating with platform_type : linux_ 05:36:32 INFO - 2015-11-20 05:36:32,864 INFO : Initialising browser for dromaeo_css test... 05:36:32 INFO - 2015-11-20 05:36:32,876 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGxXJHj/profile http://localhost:53821/getInfo.html 05:36:36 INFO - 2015-11-20 05:36:36,562 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:36:36 INFO - 2015-11-20 05:36:36,562 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:36:36 INFO - 2015-11-20 05:36:36,562 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:36:36 INFO - 2015-11-20 05:36:36,562 DEBUG : BROWSER_OUTPUT: __metrics 05:36:36 INFO - 2015-11-20 05:36:36,881 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:38 INFO - 2015-11-20 05:36:38,094 INFO : Browser initialized. 05:36:38 INFO - 2015-11-20 05:36:38,095 INFO : Running cycle 1/1 for dromaeo_css test... 05:36:38 INFO - 2015-11-20 05:36:38,095 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGxXJHj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:36:49 INFO - 2015-11-20 05:36:49,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 141426688 05:36:49 INFO - 2015-11-20 05:36:49,856 DEBUG : BROWSER_OUTPUT: 05:37:41 INFO - 2015-11-20 05:37:41,502 DEBUG : BROWSER_OUTPUT: 1448026661499 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] 05:39:50 INFO - 2015-11-20 05:39:50,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53821/tests/dromaeo/cssquery-ext.html) 05:39:51 INFO - 2015-11-20 05:39:51,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 242540544 05:39:51 INFO - 2015-11-20 05:39:51,511 DEBUG : BROWSER_OUTPUT: 05:42:53 INFO - 2015-11-20 05:42:53,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/dromaeo/cssquery-ext.html (next: http://localhost:53821/tests/dromaeo/cssquery-jquery.html) 05:42:54 INFO - 2015-11-20 05:42:54,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 226078720 05:42:54 INFO - 2015-11-20 05:42:54,386 DEBUG : BROWSER_OUTPUT: 05:45:56 INFO - 2015-11-20 05:45:56,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53821/tests/dromaeo/cssquery-mootools.html) 05:45:56 INFO - 2015-11-20 05:45:56,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 213192704 05:45:56 INFO - 2015-11-20 05:45:56,928 DEBUG : BROWSER_OUTPUT: 05:48:58 INFO - 2015-11-20 05:48:58,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53821/tests/dromaeo/cssquery-prototype.html) 05:48:59 INFO - 2015-11-20 05:48:59,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 198926336 05:48:59 INFO - 2015-11-20 05:48:59,414 DEBUG : BROWSER_OUTPUT: 05:52:01 INFO - 2015-11-20 05:52:01,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53821/tests/dromaeo/cssquery-yui.html) 05:52:02 INFO - 2015-11-20 05:52:02,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 201654272 05:52:02 INFO - 2015-11-20 05:52:02,417 DEBUG : BROWSER_OUTPUT: 05:55:04 INFO - 2015-11-20 05:55:04,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/dromaeo/cssquery-yui.html (next: http://localhost:53821/tests/dromaeo/cssquery-dojo.html) 05:55:04 INFO - 2015-11-20 05:55:04,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 246259712 05:55:04 INFO - 2015-11-20 05:55:04,927 DEBUG : BROWSER_OUTPUT: 05:55:04 INFO - 2015-11-20 05:55:04,927 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:55:04 INFO - 2015-11-20 05:55:04,928 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:55:04 INFO - 2015-11-20 05:55:04,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:55:04 INFO - 2015-11-20 05:55:04,930 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:55:04 INFO - 2015-11-20 05:55:04,931 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3158.447271727447;3255.4302996975525;3302.3725492156486;3308.057203696947;3329.999999999999;5323.574114070875;5439.374471935728;5452.509274165324;5513.917291240635;5523.25436066131;5495.450454954513;5500.064988951878;5568.7215639217975;5578.163275508676;5588.580856435763;5087.694738315704;5095.235714642796;5127.769250383742;5137.280780690707;5155.226715992593;4923.286123512089;5152.92270615941;5170.457102004292;5190.039842629126;5248.47515248474;4992.126377883874;5006.04885071837;5081.974590127063;5092.949070509321;5140.177571588528;5086.440491545927;5087.872803179913;5117.385913690344;5135.024345374367;5143.305653736773;4873.805047798084;5004.299398084235;5059.4434612193;5083.517065878736;5096.413912400084;5244.895102097975;5339.119045357511;5352.277442545245;5368.91946620801;5379.757910894019;5972.343042265347;5983.1623572699855;5988.9401105989255;5989.3711160327975;5990.191324171225;5696.430356964312;5879.265091863517;5997.190379298782;6013.759449622054;6014.488768454687;5586.692731899784;5589.105743081169;5595;5597.272354593917;5626.352969408488;6022.066579680157;6036.486898613579;6038;6038.547108966845;6047.697615119227;5766.971165144148;5772.913406298909;5862.384449632812;5916.2013128228;5920.79277225295;5930.911036334458;5934.465898069195;5939.495142912814;5945.613535120204;5998.490128339053;5869.530437564985;5882.911756323659;5918.260217472816;5920.496757775637;5925.792597259076;5737.08206686928;5852.268466441695;5932;5955.255593050869;6084.60450070744;4595.609373203249;4597.42532183477;4600.171969045537;4603.562661547147;4634.374359461497;4096.32410652239;4098.159877225162;4100.528439229527;4105.34314509677;4141.213169497786;5356.143017117321;5466.808661696821;5638.830835074954;5715.085586306171;5748.885022299614;5955.34491205967;6006.849828754316;6015.849603759853;6030.4572588467245;6031.306399763996;5424.538914192259;5644.717764111861;5659.349174844946;5664.348599911063;5670;5088.491150884956;5160.148575485078;5163.66436181647;5185.325907632059;5199.922001169985;6076.848078797977;6080.2399700037495;6083.756649733961;6087.178230938855;6092.786752463642;5746.770129194785;5822.650640961556;5876.44173803488;5879.412058794086;5879.823605291848;6115.541334399849;6140;6209.348018457997;6214.5960512566535;6226.906596401148;5846.323781850032;5867.20792692981;5925.466707996301;5928.644281343133;5982.312034116132;5746.942530574808;5893.2044174035955;6023.216981792339;6023.548233882389;6028;5819.970900145472;5876.559258055578;5879.235699359056;5888.263967004124;5897.911531326948;5853.560982926212;5871.1486834409625;5873.324567674772;5876.853078673067;5878.764849406147;5507.118860982224;5568.721563921707;5630.690312032878;5761.56788240892;5781.4218578141845;5786.508146807569;5786.681732504584;5792;5796.971015144897;5811.94188058114;5659.745311460912;5732.914006289992;5734.283214598176;5785.929603023455;5811.941880581309 05:55:04 INFO - 2015-11-20 05:55:04,932 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.3011800308614;584.5761822678559;599.0265818045676;610.9816705498833;620.7982405718143;32076.99999999997;32746.508802367953;40792.38811417831;40978.38532422016;41109.7944510277;43541.56458435415;44275.557244427546;44275.77862110693;44507.55492445075;44518;7748.457607967444;8754.606042728077;8917.127403245326;8928.866067009;8931.73204803857;7815.882761758578;10457.947710261476;10684.14526837855;10689.518971646256;10694.679159625184;10374;10454.843177352346;10465.581376744922;10469.057784799366;10476.895231047669;7860.253275938805;8004.479708818966;10372.118369938564;10460.320079194827;10464.790704185949;10203.234757393151;10279.845802312972;10316.58733650653;10320.690379288633;10325.122364599018;41233.793831030955;41664;41732;41778.373324400156;41799;3351.8827490433887;3417.624061353249;3543.698785603201;3589.94615080774;4041.3937909313545;30444.8477757612;30747.69252307493;31205.843970780228;31552.368952621047;32348.35303293921;3925.60743925608;3931.6854651628087;3931.8034098295257;4002.3396139637216;4024.6579040781567;270158;271995;293638.99999999785;391216;396737;49694.50305496971;49759.502404976214;49789;50127.24809127866;50143.24785128226;52429.475705243225;52632.21051684228;52636;52648.473515264355;52649;14968.775468367983;15240.085594864344;15255;15276.541703748682;15326.846731532765;11730.296182229093;11942;11942.880571194351;11958.222715523463;12025;20486;20611.58776824455;20689.27587534429;20689.793102068787;20744;7478.663460144307;7665.6933722650465;7708.267714567107;7797.727079552302;7811.648475818602;952.7951490429591;983.4836710726926;1010.7927874785652;1073.0021080395152;1132.17351333527;26191.476170476482;26672.866635666698;26710.19869403921;27047.729522704914;27059.864700676764;1038.1953985661173;1043.7286305560458;1049.3231865446744;1054.4674939155677;1054.947252637365;13180.406881690347;13276.203427794364;13288.667783305495;13316.800247996287;13354.666133346744;303719;307090;310500;310857;311051;52533.47466525362;52604;52705.2094218587;52717;52769.736151319;1339.8325209348832;1340.3499302838115;1348.6493511686836;1354.410831288373;1361.203695837926;26344.473110538067;27510.17469475919;27656.446871062064;27720.168394948185;27842.582361265002;43941.560584393745;44703.55296447124;45894.77052614716;49855.501444985086;50799.238011429115;220895;221739;221762;223465;223990;28148.296292592848;31344.52983205208;31706.04881853548;31744.365112697156;31763.364732704755;32924.22467840426;34592.82703586466;43802;44331.77834110809;45015.77492112519;36304.81847590745;37418;37552;37724.245515088995;38824.6705197689;36878;37155.442668360534;37787.244255114194;37892.24215515729;38121.42817857679;33347;33502.49746253759;33521.49717754284;33534.32931341311;36037.45943810898;31317.843410783713;33505.49741753827;33965.32069358649;34512;34598.30803383868;23157.305280841603;23197.188098416475;23407.882960585768;23414.76585234194;23688 05:55:04 INFO - 2015-11-20 05:55:04,936 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.74421288778524;358.98743543975957;359.17748356264156;359.86145334046387;362.07851019156243;14208.928955355208;14407.063540869836;16389.83610163898;16625.334986600537;17411.651766964667;10839.891601083988;11121.888781112186;16256;17478.65042699145;17488.125593720328;4896.069746748115;5000.049990501811;5001.249812528114;5001.724905130216;5002.674826136307;3657.2868290683327;3751.3622684143625;4925.33507976424;4957.405111386639;5380.408155102955;5413.188021796723;5436;5454.290942177511;5455.727213639302;5456.781728730866;5423.267858839065;5427.267318911956;5498.45015498449;5604;5608.971955140199;4890.608751299887;4901.877453063702;4933.975330123362;4942.950570494285;4959.578435832958;19754.925732797994;19796;20192.49518762028;20952.266670666453;21072.473188170265;2022;2028.7464066991627;2055.3833849845137;2076.356329537848;2115.9471013224793;9575.569099390545;9997.050280223368;12398.81401778965;13264.867351326557;13372.598822035354;1758.0594382005565;1763.6296377760686;1804.476701756489;1818.3090425638172;1829.1585870499587;55086;55955.16067258995;63462.365376346104;66424.6678766608;67400.66299668519;9754.804903901882;10134.493275336352;10261.94869025665;10380.377177369382;10385.584576617002;13448.865511344762;13473.326333683277;13493.595192144252;13501.459941602227;13514.93242533781;7145.749898753519;7512.39900807934;7539.472236943361;7583.090029196532;7642.426817988673;7342.15565209997;7346.926530734731;7362.484626076123;7386.704531818775;7390.334869861738;3943.921121577552;4072.816723247461;4116.58834116586;4138.8344466221015;4146.502419709594;1752.5443384720065;1794.318159099534;1796.1468302556443;1848.9167987440596;1897.9881325794702;424.898024474124;436.58088235294474;857.8455877942031;953.2071031876529;984.4880662055691;9895.65365212214;10273.434961077213;10352.585896564053;10411.843822342671;10561.841572376421;402.96776257899296;415.9313713237282;417.2031419987869;452.377980277119;465.2579136277632;5621.915671264935;5874.353821079678;5901.232839730807;5950.256217972754;5990.251218597676;508466;514076;514845;517874;520488;78096;78123.60938195387;78241;81109.59445202736;83519.99999999878;473.7418107131622;476.0977946790812;476.46873735785044;477.9665423420397;478.3685535093712;10093.848592271268;10095.54570044335;10103.54534045955;10303.587856485656;10341.276110672181;35312.64687353094;35598;36123.458148127276;36640.49299274511;37458.2508349826;48051;48708.75645621891;50096.74951625364;51336.229956551426;52779;9433.386829856037;9760.902390976284;9790.216782657228;9918.950405247928;9996.550155243178;17216.311347545958;17418.30326786914;17620.82379176192;17707.557311067325;17761.200745966205;10918.290311129751;11104.73042140845;12268.44791984345;14105.929470352583;14164.78752818688;13154.276514791778;13884.09753366028;13906.304684765519;13942.721145577234;13961.860381396056;13295.401706923018;13353;13562.79655805144;13589.45642174302;13823.654408639864;8980.550972451481;9179.908200917906;9393.718188454357;9403.34176607631;9408.905910940803;9567.521623918637;13302.201867887958;14120.858791411954;14506.637334066732;14507.202103883965 05:55:04 INFO - 2015-11-20 05:55:04,936 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1508.3966413434619;1684.082175214508;1687.051455568818;1708.7351460523623;1739.295585287958;7124.643767811608;7345.118585769708;7878.64546095425;8009;8021;7897.328727058192;7932.0481542214875;7941.801454963629;7955.204479552041;7971.242731940456;2071.3785864240745;2114.9577008459823;2305.700258966332;2326.941826454335;2328.371339738278;2314.1206341590173;2346.2843832631042;2354.21133920137;2355.858648481088;2356.0458014504065;2251.7072780538506;2288.8512246703995;2299.4481324482085;2301.735300440446;2302.8503147295455;2033.3086750504826;2070.3892351756267;2251.4146321956246;2300.1949317738827;2338.0414030247603;2317.571249318881;2318.8840557972203;2323.256557901472;2326.0463210083954;2326.790588846995;7830.530168189927;7997.280244777998;7997.560134192617;8003.1996800320085;8006.879896801553;4716.29255611661;4785.880352991168;4823.059503396839;4823.372961515016;4831.685940413862;3213.389456003352;3242.789218700777;3290.226796702773;3313.0557791029682;3330.7501937354796;1088.1186239146316;1096.4188979840696;1126.1722633864103;1152.9481173347135;1157.6584907452323;10997.285176463503;11074.944625276903;11084.889151108466;11091.778164436746;11103.777924441547;4234.534201237861;4375.081232941055;4385.51759306476;4412.84555040572;4451.1765323415275;9455.76360590977;9474.336796424184;9478.431294122374;9482.620695172116;9489.952550237205;4859.125357435695;4877.244027175793;4886.706797592155;4887.926681099786;4888.291197776302;4399.054203346296;4431.7340959542535;4439.66702497314;4448.1770872388715;4465.464144302639;3772.434134879735;3807.695384369244;3811.618838116166;3837.827297771551;3841.654251117413;1188.9346085965356;1194.7252132009687;1196.611101392051;1197.2098415046028;1198.101423932051;1294.2428679222571;1317.855035946045;1336.4654138344545;1349.871762182591;1350.2506109109538;7313.414926805843;7400.777976660709;7454.962725186339;7472.364848987788;7474.103107627119;449.25872310686975;450.38747303666986;470.11148928525114;470.6658272626474;476.20949224287517;5390.8921821563345;5525.254090697785;6041.2750469943885;6183.381661833871;6193.102000209944;9278.304127190488;9406.05939406054;9406.858897116548;9794.902050979399;9882.950585247028;9733.318667693193;9733.56198971048;9752.756181095387;9757.804843903225;9758.853617195748;7474.925250747532;7527.887081693779;7614.58119803405;7637.930689703446;7662.96168519165;7456.105267367951;7517;7523.699052037857;7532.7740167795055;7534.020577325132;8235.917640823514;8542.78643033929;8564.143585641386;8656.091110433314;8657.653693852175;8748.69379571712;8834.514101724468;8973.28213742886;8992;9001.594928228114;7181.712731490891;7256.310650488195;7267.818304542428;7267.963660181666;7275.163356214103;7794.844103117793;7857.685692572461;7912.248336408032;7918.881216781638;7919.881201782093;7188.964055179691;7256.818579535554;7289.708411663686;7292.854142917218;7306.634668266459;7219.927800721925;7265.673044713107;7326.560406375635;7450.813729656802;7458.142313634002;7302.488825782357;7350.70597176107;7355.668994895135;7356.080489938758;7360.926390736024;6487.286398496068;6534.575252608565;6543.5419520633095;6558.114654521769;6608.339166083353;6166.845828854135;6267.749290028348;6710.463162946855;6720.731170753115;6723.2604413515455 05:55:04 INFO - 2015-11-20 05:55:04,938 DEBUG : BROWSER_OUTPUT: |4;prototype.html;329.69173822475983;329.749390463248;335.62577725835695;337.35901786605433;337.4011130243817;6159.815205543835;6168.0439531872635;6179.660118693476;6211.378862113786;6211.5341349398805;5850;5952.166696662471;5966.701664916758;6093.482054025413;6119.2350956130485;4666.976665116669;4677.251639737643;4686.437627484706;4699.7415142167165;4701.670883038189;4415.183191109639;4683.929741053887;4693.88265293367;4695.788689508963;4697.835575754849;4468.173387923229;4474.731516109027;4543.4093567836135;4567.725936443824;4584.426946631671;4510.639148868116;4567.657425693086;4572.291294849287;4574.268117101248;4582.129395414877;4028.8589899353383;4033.7983100845136;4039.151778126597;4039.515258169009;4041.6564592009713;5704.80033198836;5787.131930210502;5787.536997040227;5798.362180160179;5799.159121927297;5368.651037682538;5369.570434365241;5369.785208591652;5373.2208829719475;5375.3280839895015;6510.707018184193;6511.153550038512;6512.348765123497;6516.739330426777;6519.152510173694;4435.778211089465;4440.378347031418;4442.400275962736;4453.265211240174;4455.131249406367;6580.309067547886;6632.63520506372;6705.530612857102;6714.764983225564;6717.9664101680155;4479.507254202035;4480.462344518679;4481.4174157359985;4483.058557702919;4488.730676159441;4538.977305113519;4539.773011349419;4539.931901021488;4542.818287268472;4543.6365090793315;5302.761375738101;5307.65500242483;5308.442613525524;5315.963387139471;5317.627766056339;6388.425041746265;6536.967315163393;6539.313372095957;6542.8364290893105;6546.574472659262;1606.3735143294125;1624.919428579981;1627.1864067966017;1630.2582325042076;1630.9102999334914;1046.100353695821;1076.5532304093713;1084.38732116354;1094.015386152469;1097.1716354152722;6289.962156244169;6313.43179113882;6321.1150438938585;6324.241091069009;6326.2092238470195;6497.837554061091;6655.168103987002;6719.529632925746;6734.595924244561;6740.056392105109;6233.563650544509;6259.467945224706;6268.843278917972;6337.366263373626;6349.333320001333;3624.5106910566737;3643.872464463731;3657.030886814996;3657.451382292624;3665.8533658653887;6848.212455567574;7024.613646249505;7031.613261270679;7036.6129862857015;7042;6946.548474349152;6978.057962175041;6981.2669669683955;6984.266652001568;6992.510524263253;7035.12060992376;7035.401990830836;7036.683349249296;7041.859162816715;7058.6823592938445;6619;6786.558873673195;6787.151606049244;6796.626185559841;6798.388145066968;6708.26209116987;6708.563943343667;6715.865682686416;6722.563033402813;6727.697253623501;6859.245482996766;6868.862622747417;6877.828054298482;6884.862302753817;7022.964885175541;4490.348899409632;4621.32990716351;4655.9301610475195;4665.323528088476;4673.64947628936;6623.1389919312105;6694.866102678016;6696.5647232929705;6737.528373014038;6739.797806065826;6500.349965003651;6508.121403610452;6543.574667646588;6561.934380656323;6562;6347.841303967438;6463.676816159079;6491.772787952399;6494.415502604788;6541.443977261986;6405.839854003687;6410.358964103739;6413.743450261937;6417.037444383193;6434.967825160844;6566.868662626816;6567.802965911031;6572.605643661395;6574.046763219402;6593.868122637425;6273;6389.744410223539;6391.201099862517;6402.487800976004;6424.710888010144 05:55:04 INFO - 2015-11-20 05:55:04,939 DEBUG : BROWSER_OUTPUT: |5;yui.html;760.1448370583093;834.5451728807799;838.9370797190212;856.1224744636748;858.2190206911707;13277.601671949846;13663.180209187443;13685.726285474284;13697.86302136977;13703.794443083338;13454.859809815067;13509.392077356519;13585.796213056812;13610.183388996642;13615.659608509792;816.3673153306175;830.0205757206494;830.5681045856181;830.7466222802043;831.0276975938136;827.065416079829;831.4138532334689;834.2075028722708;834.3200291762224;834.7620928035511;862.2843040276587;870.9651613935466;871.3595507302127;871.376965469689;871.5337294547419;867.7873920889359;868.2099289646424;869.256785448442;869.4783130121939;869.752120645613;634.8761991411676;635.0696230023038;635.2567496029657;635.3075148088559;635.6758053392757;12460.75078498425;12467.875321246853;12476.064295177806;12545.498180072786;12567.811482827765;10975.615853445091;11051.594294990518;11061.557537698482;11139.220254582182;11172.385518796464;9644.517774111266;9838.114569688762;9938.105570498617;10104.292699510963;10358;3495.2834668892815;3538.097785064818;3587.4798154267746;3594.245208506217;3708.1471261609713;46367.53632463666;46383.53616463826;46649.30026049612;46653.533464665255;48067.27899081482;8607.18231767981;8627.61175747093;8776.122387761301;9057.230135438429;9147;16793.91603041977;16840.32638694463;16882.07148606814;16889.746653800205;17019.659606807796;7760.573168475675;7836;7960.960195198987;8015.757557578585;8146.063202731643;4206.789660516962;4211.136716973013;4247.150569886036;4258.850940217078;4369.541198174146;3017.562453444238;3068.800527965675;3077.615298087739;3082.799618024821;3093.922651933675;561.831450564829;564.2833601326292;570.1704020649944;590.4361334925136;591.9822405327847;593.1073734030257;594.8512871782054;611.39471922797;611.8378629663143;652.1098700274092;8502.362322825813;8614.39699221061;8712;8911.598978046004;9226.446413215228;628.4815027602156;632.8860805055134;679.7213142611506;695.5374675840509;695.8677851208254;4009.639132478091;4043.9191216175514;4118.567550407224;4251.618224077126;4421.955780442218;58389;58657.41342586605;58686.4131358681;58951.410485894594;59108.40891591115;43344;43476.78261608672;47316;50871.491285086675;52048.73975630097;45315.320270195974;45765.771171144595;45860;46695.5330446698;47359.28961065587;8529.189726975927;8561.871571926302;9087.227585655293;9273.814523709623;9484.193843523377;34420.311593768485;35917.64082359143;36446.27107457889;36480.635193648784;37414.25171496609;46263.30605040994;46735.76632116954;46772.532274676814;46873.53126468691;47305.29042064303;10612.840807387742;11069.889301106887;11110.777784444428;11141.2201145919;11149.386783726974;11701.414929253673;11764.647060588197;11787.292762433939;11804.291742495478;11927.701807454536;10972.451377431256;11268.549258029587;11303.660890173307;11323.716907077389;11348.602798901999;10806.13550915909;10877.18421118435;10897.455127243447;10908.236423450282;10908.61819836302;11292.378919159197;11344.432778361213;11410.657680269605;11430.714232144262;11477.426128693698;9628.951855240679;9719.708408747749;9740.366876153028;9779.60881564758;10051.648192313234;9521.571529281338;9558.904410955802;9774.706758797247;9774.80450390974;9783.315167938175 05:55:04 INFO - 2015-11-20 05:55:04,939 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:55:04 INFO - 2015-11-20 05:55:04,939 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:55:04 INFO - 2015-11-20 05:55:04,939 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,780 05:55:04 INFO - 2015-11-20 05:55:04,939 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:55:04 INFO - 2015-11-20 05:55:04,940 DEBUG : BROWSER_OUTPUT: __startTimestamp1448027704927__endTimestamp 05:55:04 INFO - 2015-11-20 05:55:04,940 DEBUG : BROWSER_OUTPUT: 05:55:04 INFO - 2015-11-20 05:55:04,940 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:55:04 INFO - 2015-11-20 05:55:04,940 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:55:04 INFO - 2015-11-20 05:55:04,940 DEBUG : BROWSER_OUTPUT: 05:55:04 INFO - 2015-11-20 05:55:04,940 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5520.85 Median:5746.77 stddev:609.73 (10.6%) stddev-sans-first:582.76 05:55:04 INFO - 2015-11-20 05:55:04,940 DEBUG : BROWSER_OUTPUT: Values: 3158.4 3255.4 3302.4 3308.1 3330.0 5323.6 5439.4 5452.5 5513.9 5523.3 5495.5 5500.1 5568.7 5578.2 5588.6 5087.7 5095.2 5127.8 5137.3 5155.2 4923.3 5152.9 5170.5 5190.0 5248.5 4992.1 5006.0 5082.0 5092.9 5140.2 5086.4 5087.9 5117.4 5135.0 5143.3 4873.8 5004.3 5059.4 5083.5 5096.4 5244.9 5339.1 5352.3 5368.9 5379.8 5972.3 5983.2 5988.9 5989.4 5990.2 5696.4 5879.3 5997.2 6013.8 6014.5 5586.7 5589.1 5595.0 5597.3 5626.4 6022.1 6036.5 6038.0 6038.5 6047.7 5767.0 5772.9 5862.4 5916.2 5920.8 5930.9 5934.5 5939.5 5945.6 5998.5 5869.5 5882.9 5918.3 5920.5 5925.8 5737.1 5852.3 5932.0 5955.3 6084.6 4595.6 4597.4 4600.2 4603.6 4634.4 4096.3 4098.2 4100.5 4105.3 4141.2 5356.1 5466.8 5638.8 5715.1 5748.9 5955.3 6006.8 6015.8 6030.5 6031.3 5424.5 5644.7 5659.3 5664.3 5670.0 5088.5 5160.1 5163.7 5185.3 5199.9 6076.8 6080.2 6083.8 6087.2 6092.8 5746.8 5822.7 5876.4 5879.4 5879.8 6115.5 6140.0 6209.3 6214.6 6226.9 5846.3 5867.2 5925.5 5928.6 5982.3 5746.9 5893.2 6023.2 6023.5 6028.0 5820.0 5876.6 5879.2 5888.3 5897.9 5853.6 5871.1 5873.3 5876.9 5878.8 5507.1 5568.7 5630.7 5761.6 5781.4 5786.5 5786.7 5792.0 5797.0 5811.9 5659.7 5732.9 5734.3 5785.9 5811.9 05:55:04 INFO - 2015-11-20 05:55:04,940 DEBUG : BROWSER_OUTPUT: 05:55:04 INFO - 2015-11-20 05:55:04,941 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45365.44 Median:32835.37 stddev:76035.58 (231.6%) stddev-sans-first:76174.46 05:55:04 INFO - 2015-11-20 05:55:04,941 DEBUG : BROWSER_OUTPUT: Values: 561.3 584.6 599.0 611.0 620.8 32077.0 32746.5 40792.4 40978.4 41109.8 43541.6 44275.6 44275.8 44507.6 44518.0 7748.5 8754.6 8917.1 8928.9 8931.7 7815.9 10457.9 10684.1 10689.5 10694.7 10374.0 10454.8 10465.6 10469.1 10476.9 7860.3 8004.5 10372.1 10460.3 10464.8 10203.2 10279.8 10316.6 10320.7 10325.1 41233.8 41664.0 41732.0 41778.4 41799.0 3351.9 3417.6 3543.7 3589.9 4041.4 30444.8 30747.7 31205.8 31552.4 32348.4 3925.6 3931.7 3931.8 4002.3 4024.7 270158.0 271995.0 293639.0 391216.0 396737.0 49694.5 49759.5 49789.0 50127.2 50143.2 52429.5 52632.2 52636.0 52648.5 52649.0 14968.8 15240.1 15255.0 15276.5 15326.8 11730.3 11942.0 11942.9 11958.2 12025.0 20486.0 20611.6 20689.3 20689.8 20744.0 7478.7 7665.7 7708.3 7797.7 7811.6 952.8 983.5 1010.8 1073.0 1132.2 26191.5 26672.9 26710.2 27047.7 27059.9 1038.2 1043.7 1049.3 1054.5 1054.9 13180.4 13276.2 13288.7 13316.8 13354.7 303719.0 307090.0 310500.0 310857.0 311051.0 52533.5 52604.0 52705.2 52717.0 52769.7 1339.8 1340.3 1348.6 1354.4 1361.2 26344.5 27510.2 27656.4 27720.2 27842.6 43941.6 44703.6 45894.8 49855.5 50799.2 220895.0 221739.0 221762.0 223465.0 223990.0 28148.3 31344.5 31706.0 31744.4 31763.4 32924.2 34592.8 43802.0 44331.8 45015.8 36304.8 37418.0 37552.0 37724.2 38824.7 36878.0 37155.4 37787.2 37892.2 38121.4 33347.0 33502.5 33521.5 33534.3 36037.5 31317.8 33505.5 33965.3 34512.0 34598.3 23157.3 23197.2 23407.9 23414.8 23688.0 05:55:04 INFO - 2015-11-20 05:55:04,941 DEBUG : BROWSER_OUTPUT: 05:55:04 INFO - 2015-11-20 05:55:04,941 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27700.18 Median:4127.71 stddev:84370.92 (2044.0%) stddev-sans-first:84582.62 05:55:04 INFO - 2015-11-20 05:55:04,943 DEBUG : BROWSER_OUTPUT: Values: 357.7 359.0 359.2 359.9 362.1 14208.9 14407.1 16389.8 16625.3 17411.7 10839.9 11121.9 16256.0 17478.7 17488.1 4896.1 5000.0 5001.2 5001.7 5002.7 3657.3 3751.4 4925.3 4957.4 5380.4 5413.2 5436.0 5454.3 5455.7 5456.8 5423.3 5427.3 5498.5 5604.0 5609.0 4890.6 4901.9 4934.0 4943.0 4959.6 19754.9 19796.0 20192.5 20952.3 21072.5 2022.0 2028.7 2055.4 2076.4 2115.9 9575.6 9997.1 12398.8 13264.9 13372.6 1758.1 1763.6 1804.5 1818.3 1829.2 55086.0 55955.2 63462.4 66424.7 67400.7 9754.8 10134.5 10261.9 10380.4 10385.6 13448.9 13473.3 13493.6 13501.5 13514.9 7145.7 7512.4 7539.5 7583.1 7642.4 7342.2 7346.9 7362.5 7386.7 7390.3 3943.9 4072.8 4116.6 4138.8 4146.5 1752.5 1794.3 1796.1 1848.9 1898.0 424.9 436.6 857.8 953.2 984.5 9895.7 10273.4 10352.6 10411.8 10561.8 403.0 415.9 417.2 452.4 465.3 5621.9 5874.4 5901.2 5950.3 5990.3 508466.0 514076.0 514845.0 517874.0 520488.0 78096.0 78123.6 78241.0 81109.6 83520.0 473.7 476.1 476.5 478.0 478.4 10093.8 10095.5 10103.5 10303.6 10341.3 35312.6 35598.0 36123.5 36640.5 37458.3 48051.0 48708.8 50096.7 51336.2 52779.0 9433.4 9760.9 9790.2 9919.0 9996.6 17216.3 17418.3 17620.8 17707.6 17761.2 10918.3 11104.7 12268.4 14105.9 14164.8 13154.3 13884.1 13906.3 13942.7 13961.9 13295.4 13353.0 13562.8 13589.5 13823.7 8980.6 9179.9 9393.7 9403.3 9408.9 9567.5 13302.2 14120.9 14506.6 14507.2 05:55:04 INFO - 2015-11-20 05:55:04,943 DEBUG : BROWSER_OUTPUT: 05:55:04 INFO - 2015-11-20 05:55:04,943 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5615.24 Median:6230.43 stddev:2943.05 (47.2%) stddev-sans-first:2935.11 05:55:04 INFO - 2015-11-20 05:55:04,943 DEBUG : BROWSER_OUTPUT: Values: 1508.4 1684.1 1687.1 1708.7 1739.3 7124.6 7345.1 7878.6 8009.0 8021.0 7897.3 7932.0 7941.8 7955.2 7971.2 2071.4 2115.0 2305.7 2326.9 2328.4 2314.1 2346.3 2354.2 2355.9 2356.0 2251.7 2288.9 2299.4 2301.7 2302.9 2033.3 2070.4 2251.4 2300.2 2338.0 2317.6 2318.9 2323.3 2326.0 2326.8 7830.5 7997.3 7997.6 8003.2 8006.9 4716.3 4785.9 4823.1 4823.4 4831.7 3213.4 3242.8 3290.2 3313.1 3330.8 1088.1 1096.4 1126.2 1152.9 1157.7 10997.3 11074.9 11084.9 11091.8 11103.8 4234.5 4375.1 4385.5 4412.8 4451.2 9455.8 9474.3 9478.4 9482.6 9490.0 4859.1 4877.2 4886.7 4887.9 4888.3 4399.1 4431.7 4439.7 4448.2 4465.5 3772.4 3807.7 3811.6 3837.8 3841.7 1188.9 1194.7 1196.6 1197.2 1198.1 1294.2 1317.9 1336.5 1349.9 1350.3 7313.4 7400.8 7455.0 7472.4 7474.1 449.3 450.4 470.1 470.7 476.2 5390.9 5525.3 6041.3 6183.4 6193.1 9278.3 9406.1 9406.9 9794.9 9883.0 9733.3 9733.6 9752.8 9757.8 9758.9 7474.9 7527.9 7614.6 7637.9 7663.0 7456.1 7517.0 7523.7 7532.8 7534.0 8235.9 8542.8 8564.1 8656.1 8657.7 8748.7 8834.5 8973.3 8992.0 9001.6 7181.7 7256.3 7267.8 7268.0 7275.2 7794.8 7857.7 7912.2 7918.9 7919.9 7189.0 7256.8 7289.7 7292.9 7306.6 7219.9 7265.7 7326.6 7450.8 7458.1 7302.5 7350.7 7355.7 7356.1 7360.9 6487.3 6534.6 6543.5 6558.1 6608.3 6166.8 6267.7 6710.5 6720.7 6723.3 05:55:04 INFO - 2015-11-20 05:55:04,943 DEBUG : BROWSER_OUTPUT: 05:55:04 INFO - 2015-11-20 05:55:04,943 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5424.90 Median:6246.52 stddev:1660.52 (26.6%) stddev-sans-first:1620.54 05:55:04 INFO - 2015-11-20 05:55:04,944 DEBUG : BROWSER_OUTPUT: Values: 329.7 329.7 335.6 337.4 337.4 6159.8 6168.0 6179.7 6211.4 6211.5 5850.0 5952.2 5966.7 6093.5 6119.2 4667.0 4677.3 4686.4 4699.7 4701.7 4415.2 4683.9 4693.9 4695.8 4697.8 4468.2 4474.7 4543.4 4567.7 4584.4 4510.6 4567.7 4572.3 4574.3 4582.1 4028.9 4033.8 4039.2 4039.5 4041.7 5704.8 5787.1 5787.5 5798.4 5799.2 5368.7 5369.6 5369.8 5373.2 5375.3 6510.7 6511.2 6512.3 6516.7 6519.2 4435.8 4440.4 4442.4 4453.3 4455.1 6580.3 6632.6 6705.5 6714.8 6718.0 4479.5 4480.5 4481.4 4483.1 4488.7 4539.0 4539.8 4539.9 4542.8 4543.6 5302.8 5307.7 5308.4 5316.0 5317.6 6388.4 6537.0 6539.3 6542.8 6546.6 1606.4 1624.9 1627.2 1630.3 1630.9 1046.1 1076.6 1084.4 1094.0 1097.2 6290.0 6313.4 6321.1 6324.2 6326.2 6497.8 6655.2 6719.5 6734.6 6740.1 6233.6 6259.5 6268.8 6337.4 6349.3 3624.5 3643.9 3657.0 3657.5 3665.9 6848.2 7024.6 7031.6 7036.6 7042.0 6946.5 6978.1 6981.3 6984.3 6992.5 7035.1 7035.4 7036.7 7041.9 7058.7 6619.0 6786.6 6787.2 6796.6 6798.4 6708.3 6708.6 6715.9 6722.6 6727.7 6859.2 6868.9 6877.8 6884.9 7023.0 4490.3 4621.3 4655.9 4665.3 4673.6 6623.1 6694.9 6696.6 6737.5 6739.8 6500.3 6508.1 6543.6 6561.9 6562.0 6347.8 6463.7 6491.8 6494.4 6541.4 6405.8 6410.4 6413.7 6417.0 6435.0 6566.9 6567.8 6572.6 6574.0 6593.9 6273.0 6389.7 6391.2 6402.5 6424.7 05:55:04 INFO - 2015-11-20 05:55:04,944 DEBUG : BROWSER_OUTPUT: 05:55:04 INFO - 2015-11-20 05:55:04,945 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13663.51 Median:46823.03 stddev:15887.76 (33.9%) stddev-sans-first:15902.78 05:55:04 INFO - 2015-11-20 05:55:04,945 DEBUG : BROWSER_OUTPUT: Values: 760.1 834.5 838.9 856.1 858.2 13277.6 13663.2 13685.7 13697.9 13703.8 13454.9 13509.4 13585.8 13610.2 13615.7 816.4 830.0 830.6 830.7 831.0 827.1 831.4 834.2 834.3 834.8 862.3 871.0 871.4 871.4 871.5 867.8 868.2 869.3 869.5 869.8 634.9 635.1 635.3 635.3 635.7 12460.8 12467.9 12476.1 12545.5 12567.8 10975.6 11051.6 11061.6 11139.2 11172.4 9644.5 9838.1 9938.1 10104.3 10358.0 3495.3 3538.1 3587.5 3594.2 3708.1 46367.5 46383.5 46649.3 46653.5 48067.3 8607.2 8627.6 8776.1 9057.2 9147.0 16793.9 16840.3 16882.1 16889.7 17019.7 7760.6 7836.0 7961.0 8015.8 8146.1 4206.8 4211.1 4247.2 4258.9 4369.5 3017.6 3068.8 3077.6 3082.8 3093.9 561.8 564.3 570.2 590.4 592.0 593.1 594.9 611.4 611.8 652.1 8502.4 8614.4 8712.0 8911.6 9226.4 628.5 632.9 679.7 695.5 695.9 4009.6 4043.9 4118.6 4251.6 4422.0 58389.0 58657.4 58686.4 58951.4 59108.4 43344.0 43476.8 47316.0 50871.5 52048.7 45315.3 45765.8 45860.0 46695.5 47359.3 8529.2 8561.9 9087.2 9273.8 9484.2 34420.3 35917.6 36446.3 36480.6 37414.3 46263.3 46735.8 46772.5 46873.5 47305.3 10612.8 11069.9 11110.8 11141.2 11149.4 11701.4 11764.6 11787.3 11804.3 11927.7 10972.5 11268.5 11303.7 11323.7 11348.6 10806.1 10877.2 10897.5 10908.2 10908.6 11292.4 11344.4 11410.7 11430.7 11477.4 9629.0 9719.7 9740.4 9779.6 10051.6 9521.6 9558.9 9774.7 9774.8 9783.3 05:55:04 INFO - 2015-11-20 05:55:04,945 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:55:04 INFO - 2015-11-20 05:55:04,945 DEBUG : BROWSER_OUTPUT: 05:55:05 INFO - 2015-11-20 05:55:05,625 INFO : Browser exited with error code: 0 05:55:05 INFO - 2015-11-20 05:55:05,648 INFO : Completed test dromaeo_css (00:18:32) 05:55:05 INFO - 2015-11-20 05:55:05,649 INFO : Starting test kraken 05:55:05 INFO - 2015-11-20 05:55:05,649 DEBUG : operating with platform_type : linux_ 05:55:05 INFO - 2015-11-20 05:55:05,649 INFO : Initialising browser for kraken test... 05:55:05 INFO - 2015-11-20 05:55:05,655 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpz9jjxg/profile http://localhost:53821/getInfo.html 05:55:09 INFO - 2015-11-20 05:55:09,347 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:55:09 INFO - 2015-11-20 05:55:09,348 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:55:09 INFO - 2015-11-20 05:55:09,348 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:55:09 INFO - 2015-11-20 05:55:09,348 DEBUG : BROWSER_OUTPUT: __metrics 05:55:09 INFO - 2015-11-20 05:55:09,489 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:10 INFO - 2015-11-20 05:55:10,625 INFO : Browser initialized. 05:55:10 INFO - 2015-11-20 05:55:10,626 INFO : Running cycle 1/1 for kraken test... 05:55:10 INFO - 2015-11-20 05:55:10,626 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpz9jjxg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:55:22 INFO - 2015-11-20 05:55:22,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 142143488 05:55:22 INFO - 2015-11-20 05:55:22,379 DEBUG : BROWSER_OUTPUT: 05:55:24 INFO - 2015-11-20 05:55:24,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53821/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:25 INFO - 2015-11-20 05:55:25,392 DEBUG : BROWSER_OUTPUT: RSS: Main: 178376704 05:55:25 INFO - 2015-11-20 05:55:25,392 DEBUG : BROWSER_OUTPUT: 05:55:27 INFO - 2015-11-20 05:55:27,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53821/tests/kraken/driver.html?testName=audio-dft) 05:55:28 INFO - 2015-11-20 05:55:28,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 169271296 05:55:28 INFO - 2015-11-20 05:55:28,545 DEBUG : BROWSER_OUTPUT: 05:55:31 INFO - 2015-11-20 05:55:31,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53821/tests/kraken/driver.html?testName=audio-fft) 05:55:31 INFO - 2015-11-20 05:55:31,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 151830528 05:55:31 INFO - 2015-11-20 05:55:31,929 DEBUG : BROWSER_OUTPUT: 05:55:33 INFO - 2015-11-20 05:55:33,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53821/tests/kraken/driver.html?testName=audio-oscillator) 05:55:34 INFO - 2015-11-20 05:55:34,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 154759168 05:55:34 INFO - 2015-11-20 05:55:34,471 DEBUG : BROWSER_OUTPUT: 05:55:36 INFO - 2015-11-20 05:55:36,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53821/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:37 INFO - 2015-11-20 05:55:37,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 154546176 05:55:37 INFO - 2015-11-20 05:55:37,177 DEBUG : BROWSER_OUTPUT: 05:55:40 INFO - 2015-11-20 05:55:40,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53821/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:40 INFO - 2015-11-20 05:55:40,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 155357184 05:55:40 INFO - 2015-11-20 05:55:40,624 DEBUG : BROWSER_OUTPUT: 05:55:44 INFO - 2015-11-20 05:55:44,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53821/tests/kraken/driver.html?testName=imaging-desaturate) 05:55:44 INFO - 2015-11-20 05:55:44,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 157663232 05:55:44 INFO - 2015-11-20 05:55:44,584 DEBUG : BROWSER_OUTPUT: 05:55:47 INFO - 2015-11-20 05:55:47,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53821/tests/kraken/driver.html?testName=json-parse-financial) 05:55:47 INFO - 2015-11-20 05:55:47,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 157380608 05:55:47 INFO - 2015-11-20 05:55:47,899 DEBUG : BROWSER_OUTPUT: 05:55:49 INFO - 2015-11-20 05:55:49,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53821/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:55:50 INFO - 2015-11-20 05:55:50,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 166404096 05:55:50 INFO - 2015-11-20 05:55:50,023 DEBUG : BROWSER_OUTPUT: 05:55:51 INFO - 2015-11-20 05:55:51,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53821/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:55:52 INFO - 2015-11-20 05:55:52,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 164810752 05:55:52 INFO - 2015-11-20 05:55:52,422 DEBUG : BROWSER_OUTPUT: 05:55:54 INFO - 2015-11-20 05:55:54,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53821/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:55:55 INFO - 2015-11-20 05:55:55,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 175525888 05:55:55 INFO - 2015-11-20 05:55:55,062 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53821/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:55:58 INFO - 2015-11-20 05:55:58,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 183930880 05:55:58 INFO - 2015-11-20 05:55:58,043 DEBUG : BROWSER_OUTPUT: 05:56:00 INFO - 2015-11-20 05:56:00,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53821/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:01 INFO - 2015-11-20 05:56:01,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 182476800 05:56:01 INFO - 2015-11-20 05:56:01,151 DEBUG : BROWSER_OUTPUT: 05:56:02 INFO - 2015-11-20 05:56:02,819 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53821/tests/kraken/driver.html?testName=ai-astar) 05:56:03 INFO - 2015-11-20 05:56:03,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 241893376 05:56:03 INFO - 2015-11-20 05:56:03,069 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,069 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:56:03 INFO - 2015-11-20 05:56:03,070 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:56:03 INFO - 2015-11-20 05:56:03,070 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:56:03 INFO - 2015-11-20 05:56:03,070 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:56:03 INFO - 2015-11-20 05:56:03,070 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;108;102;108;110;110;99;108;113;109 05:56:03 INFO - 2015-11-20 05:56:03,070 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;123;148;167;134;146;146;125;164;132 05:56:03 INFO - 2015-11-20 05:56:03,070 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;159;159;159;161;160;163;161;160 05:56:03 INFO - 2015-11-20 05:56:03,071 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;80;92;71;72;71;100;91;72 05:56:03 INFO - 2015-11-20 05:56:03,071 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;140;89;91;90;143;90;90;137 05:56:03 INFO - 2015-11-20 05:56:03,071 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;110;110;110;109;109 05:56:03 INFO - 2015-11-20 05:56:03,071 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;144;145;145;145;145;145;145;145 05:56:03 INFO - 2015-11-20 05:56:03,071 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;95;95;96;95;95;95 05:56:03 INFO - 2015-11-20 05:56:03,071 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;61;61;62;61;61;68;59;59 05:56:03 INFO - 2015-11-20 05:56:03,071 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;68;68;69;69;71;68;69 05:56:03 INFO - 2015-11-20 05:56:03,071 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;84;94;86;85;85;92;84;87 05:56:03 INFO - 2015-11-20 05:56:03,072 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;121;113;118;120;123;122;115;127;126 05:56:03 INFO - 2015-11-20 05:56:03,072 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;149;150;149;150;139;148;150;148;148 05:56:03 INFO - 2015-11-20 05:56:03,072 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;67;68;66;67;66;69;68;65;68 05:56:03 INFO - 2015-11-20 05:56:03,072 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:56:03 INFO - 2015-11-20 05:56:03,072 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:56:03 INFO - 2015-11-20 05:56:03,072 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,906 05:56:03 INFO - 2015-11-20 05:56:03,072 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:56:03 INFO - 2015-11-20 05:56:03,073 DEBUG : BROWSER_OUTPUT: __startTimestamp1448027763067__endTimestamp 05:56:03 INFO - 2015-11-20 05:56:03,073 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,076 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:56:03 INFO - 2015-11-20 05:56:03,076 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:56:03 INFO - 2015-11-20 05:56:03,077 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,077 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:109.50 stddev:4.06 (3.7%) stddev-sans-first:4.30 05:56:03 INFO - 2015-11-20 05:56:03,077 DEBUG : BROWSER_OUTPUT: Values: 107.0 108.0 102.0 108.0 110.0 110.0 99.0 108.0 113.0 109.0 05:56:03 INFO - 2015-11-20 05:56:03,077 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,077 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.00 Median:146.00 stddev:14.87 (10.2%) stddev-sans-first:15.75 05:56:03 INFO - 2015-11-20 05:56:03,077 DEBUG : BROWSER_OUTPUT: Values: 145.0 123.0 148.0 167.0 134.0 146.0 146.0 125.0 164.0 132.0 05:56:03 INFO - 2015-11-20 05:56:03,077 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,077 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 05:56:03 INFO - 2015-11-20 05:56:03,077 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 159.0 159.0 159.0 161.0 160.0 163.0 161.0 160.0 05:56:03 INFO - 2015-11-20 05:56:03,078 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,078 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:72.00 stddev:11.02 (15.3%) stddev-sans-first:11.29 05:56:03 INFO - 2015-11-20 05:56:03,078 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 80.0 92.0 71.0 72.0 71.0 100.0 91.0 72.0 05:56:03 INFO - 2015-11-20 05:56:03,078 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,078 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:90.00 stddev:24.27 (27.0%) stddev-sans-first:25.05 05:56:03 INFO - 2015-11-20 05:56:03,078 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 140.0 89.0 91.0 90.0 143.0 90.0 90.0 137.0 05:56:03 INFO - 2015-11-20 05:56:03,078 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,078 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 05:56:03 INFO - 2015-11-20 05:56:03,078 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 110.0 110.0 110.0 109.0 109.0 05:56:03 INFO - 2015-11-20 05:56:03,078 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,079 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 05:56:03 INFO - 2015-11-20 05:56:03,079 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 05:56:03 INFO - 2015-11-20 05:56:03,079 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,079 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:56:03 INFO - 2015-11-20 05:56:03,079 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 05:56:03 INFO - 2015-11-20 05:56:03,079 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,079 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.00 stddev:2.57 (4.2%) stddev-sans-first:2.69 05:56:03 INFO - 2015-11-20 05:56:03,079 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 61.0 61.0 62.0 61.0 61.0 68.0 59.0 59.0 05:56:03 INFO - 2015-11-20 05:56:03,079 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,079 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 05:56:03 INFO - 2015-11-20 05:56:03,080 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 68.0 68.0 69.0 69.0 71.0 68.0 69.0 05:56:03 INFO - 2015-11-20 05:56:03,080 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,080 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.50 stddev:3.69 (4.3%) stddev-sans-first:3.70 05:56:03 INFO - 2015-11-20 05:56:03,080 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 84.0 94.0 86.0 85.0 85.0 92.0 84.0 87.0 05:56:03 INFO - 2015-11-20 05:56:03,080 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,080 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:121.50 stddev:4.86 (4.0%) stddev-sans-first:4.67 05:56:03 INFO - 2015-11-20 05:56:03,080 DEBUG : BROWSER_OUTPUT: Values: 114.0 121.0 113.0 118.0 120.0 123.0 122.0 115.0 127.0 126.0 05:56:03 INFO - 2015-11-20 05:56:03,080 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,080 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.10 Median:149.00 stddev:4.09 (2.7%) stddev-sans-first:3.44 05:56:03 INFO - 2015-11-20 05:56:03,080 DEBUG : BROWSER_OUTPUT: Values: 140.0 149.0 150.0 149.0 150.0 139.0 148.0 150.0 148.0 148.0 05:56:03 INFO - 2015-11-20 05:56:03,080 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,081 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.34 (2.0%) stddev-sans-first:1.27 05:56:03 INFO - 2015-11-20 05:56:03,081 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 68.0 66.0 67.0 66.0 69.0 68.0 65.0 68.0 05:56:03 INFO - 2015-11-20 05:56:03,081 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:56:03 INFO - 2015-11-20 05:56:03,081 DEBUG : BROWSER_OUTPUT: 05:56:03 INFO - 2015-11-20 05:56:03,929 INFO : Browser exited with error code: 0 05:56:03 INFO - 2015-11-20 05:56:03,980 INFO : Completed test kraken (00:00:58) 05:56:03 INFO - 2015-11-20 05:56:03,980 INFO : Starting test v8_7 05:56:03 INFO - 2015-11-20 05:56:03,980 DEBUG : operating with platform_type : linux_ 05:56:03 INFO - 2015-11-20 05:56:03,981 INFO : Initialising browser for v8_7 test... 05:56:03 INFO - 2015-11-20 05:56:03,987 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaC3dZ9/profile http://localhost:53821/getInfo.html 05:56:07 INFO - 2015-11-20 05:56:07,631 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:56:07 INFO - 2015-11-20 05:56:07,631 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:56:07 INFO - 2015-11-20 05:56:07,631 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:56:07 INFO - 2015-11-20 05:56:07,631 DEBUG : BROWSER_OUTPUT: __metrics 05:56:07 INFO - 2015-11-20 05:56:07,712 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:56:08 INFO - 2015-11-20 05:56:08,957 INFO : Browser initialized. 05:56:08 INFO - 2015-11-20 05:56:08,958 INFO : Running cycle 1/1 for v8_7 test... 05:56:08 INFO - 2015-11-20 05:56:08,958 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaC3dZ9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:56:20 INFO - 2015-11-20 05:56:20,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 141307904 05:56:20 INFO - 2015-11-20 05:56:20,735 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53821/tests/v8_7/run.html (next: http://localhost:53821/tests/v8_7/run.html) 05:56:42 INFO - 2015-11-20 05:56:42,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 628834304 05:56:42 INFO - 2015-11-20 05:56:42,410 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: |0;Richards;162.78691193228065 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.55252918287937 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.2253280091272 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1937.984496124031 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: |5;Earley;788.8100866824271 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: |6;Boyer;12072.289156626506 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: |7;RegExp;25300 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: |8;Splay;651.9480519480519 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:56:42 INFO - 2015-11-20 05:56:42,411 DEBUG : BROWSER_OUTPUT: __startTimestamp1448027802403__endTimestamp 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.79 Median:162.79 stddev:0.00 (0.0%) 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: Values: 162.8 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.55 Median:194.55 stddev:0.00 (0.0%) 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: Values: 194.6 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.23 Median:285.23 stddev:0.00 (0.0%) 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: Values: 285.2 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: Values: 5045.2 05:56:42 INFO - 2015-11-20 05:56:42,412 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1937.98 Median:1937.98 stddev:0.00 (0.0%) 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: Values: 1938.0 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.81 Median:788.81 stddev:0.00 (0.0%) 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: Values: 788.8 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: Values: 12072.3 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25300.00 Median:25300.00 stddev:0.00 (0.0%) 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: Values: 25300.0 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:651.95 Median:651.95 stddev:0.00 (0.0%) 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: Values: 651.9 05:56:42 INFO - 2015-11-20 05:56:42,413 DEBUG : BROWSER_OUTPUT: 05:56:42 INFO - 2015-11-20 05:56:42,414 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:56:42 INFO - 2015-11-20 05:56:42,414 DEBUG : BROWSER_OUTPUT: Values: 4830.9 05:56:42 INFO - 2015-11-20 05:56:42,414 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:56:42 INFO - 2015-11-20 05:56:42,414 DEBUG : BROWSER_OUTPUT: 05:56:43 INFO - 2015-11-20 05:56:43,297 INFO : Browser exited with error code: 0 05:56:43 INFO - 2015-11-20 05:56:43,314 INFO : Completed test v8_7 (00:00:39) 05:56:43 INFO - 2015-11-20 05:56:43,378 INFO : Completed test suite (00:20:10) 05:56:43 INFO - 2015-11-20 05:56:43,378 DEBUG : Working with test: dromaeo_css 05:56:43 INFO - 2015-11-20 05:56:43,378 DEBUG : Generating results file: dromaeo_css 05:56:43 INFO - 2015-11-20 05:56:43,379 DEBUG : Working with test: kraken 05:56:43 INFO - 2015-11-20 05:56:43,379 DEBUG : Generating results file: kraken 05:56:43 INFO - 2015-11-20 05:56:43,379 INFO : javascript benchmark 05:56:43 INFO - 2015-11-20 05:56:43,380 DEBUG : Working with test: v8_7 05:56:43 INFO - 2015-11-20 05:56:43,380 DEBUG : Generating results file: v8_7 05:56:43 INFO - 2015-11-20 05:56:43,380 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:56:43 INFO - 2015-11-20 05:56:43,436 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 05:56:43 INFO - 2015-11-20 05:56:43,436 DEBUG : process_Request line: dromaeo_css 6947.80 graph.html#tests=[[72,1,35]] 05:56:43 INFO - 2015-11-20 05:56:43,436 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:56:43 INFO - 2015-11-20 05:56:43,469 DEBUG : process_Request line: kraken 1494.90 graph.html#tests=[[232,1,35]] 05:56:43 INFO - 2015-11-20 05:56:43,469 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:56:43 INFO - 2015-11-20 05:56:43,499 DEBUG : process_Request line: v8_7 19803.13 graph.html#tests=[[230,1,35]] 05:56:43 INFO - 2015-11-20 05:56:43,500 INFO : javascript benchmark 05:56:43 INFO - 2015-11-20 05:56:43,504 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3158.447271727447, 3255.4302996975525, 3302.3725492156486, 3308.057203696947, 3329.999999999999, 5323.574114070875, 5439.374471935728, 5452.509274165324, 5513.917291240635, 5523.25436066131, 5495.450454954513, 5500.064988951878, 5568.7215639217975, 5578.163275508676, 5588.580856435763, 5087.694738315704, 5095.235714642796, 5127.769250383742, 5137.280780690707, 5155.226715992593, 4923.286123512089, 5152.92270615941, 5170.457102004292, 5190.039842629126, 5248.47515248474, 4992.126377883874, 5006.04885071837, 5081.974590127063, 5092.949070509321, 5140.177571588528, 5086.440491545927, 5087.872803179913, 5117.385913690344, 5135.024345374367, 5143.305653736773, 4873.805047798084, 5004.299398084235, 5059.4434612193, 5083.517065878736, 5096.413912400084, 5244.895102097975, 5339.119045357511, 5352.277442545245, 5368.91946620801, 5379.757910894019, 5972.343042265347, 5983.1623572699855, 5988.9401105989255, 5989.3711160327975, 5990.191324171225, 5696.430356964312, 5879.265091863517, 5997.190379298782, 6013.759449622054, 6014.488768454687, 5586.692731899784, 5589.105743081169, 5595.0, 5597.272354593917, 5626.352969408488, 6022.066579680157, 6036.486898613579, 6038.0, 6038.547108966845, 6047.697615119227, 5766.971165144148, 5772.913406298909, 5862.384449632812, 5916.2013128228, 5920.79277225295, 5930.911036334458, 5934.465898069195, 5939.495142912814, 5945.613535120204, 5998.490128339053, 5869.530437564985, 5882.911756323659, 5918.260217472816, 5920.496757775637, 5925.792597259076, 5737.08206686928, 5852.268466441695, 5932.0, 5955.255593050869, 6084.60450070744, 4595.609373203249, 4597.42532183477, 4600.171969045537, 4603.562661547147, 4634.374359461497, 4096.32410652239, 4098.159877225162, 4100.528439229527, 4105.34314509677, 4141.213169497786, 5356.143017117321, 5466.808661696821, 5638.830835074954, 5715.085586306171, 5748.885022299614, 5955.34491205967, 6006.849828754316, 6015.849603759853, 6030.4572588467245, 6031.306399763996, 5424.538914192259, 5644.717764111861, 5659.349174844946, 5664.348599911063, 5670.0, 5088.491150884956, 5160.148575485078, 5163.66436181647, 5185.325907632059, 5199.922001169985, 6076.848078797977, 6080.2399700037495, 6083.756649733961, 6087.178230938855, 6092.786752463642, 5746.770129194785, 5822.650640961556, 5876.44173803488, 5879.412058794086, 5879.823605291848, 6115.541334399849, 6140.0, 6209.348018457997, 6214.5960512566535, 6226.906596401148, 5846.323781850032, 5867.20792692981, 5925.466707996301, 5928.644281343133, 5982.312034116132, 5746.942530574808, 5893.2044174035955, 6023.216981792339, 6023.548233882389, 6028.0, 5819.970900145472, 5876.559258055578, 5879.235699359056, 5888.263967004124, 5897.911531326948, 5853.560982926212, 5871.1486834409625, 5873.324567674772, 5876.853078673067, 5878.764849406147, 5507.118860982224, 5568.721563921707, 5630.690312032878, 5761.56788240892, 5781.4218578141845, 5786.508146807569, 5786.681732504584, 5792.0, 5796.971015144897, 5811.94188058114, 5659.745311460912, 5732.914006289992, 5734.283214598176, 5785.929603023455, 5811.941880581309], "unit": "ms", "name": "dojo.html", "value": 5481.24241775793}, {"lowerIsBetter": false, "replicates": [561.3011800308614, 584.5761822678559, 599.0265818045676, 610.9816705498833, 620.7982405718143, 32076.99999999997, 32746.508802367953, 40792.38811417831, 40978.38532422016, 41109.7944510277, 43541.56458435415, 44275.557244427546, 44275.77862110693, 44507.55492445075, 44518.0, 7748.457607967444, 8754.606042728077, 8917.127403245326, 8928.866067009, 8931.73204803857, 7815.882761758578, 10457.947710261476, 10684.14526837855, 10689.518971646256, 10694.679159625184, 10374.0, 10454.843177352346, 10465.581376744922, 10469.057784799366, 10476.895231047669, 7860.253275938805, 8004.479708818966, 10372.118369938564, 10460.320079194827, 10464.790704185949, 10203.234757393151, 10279.845802312972, 10316.58733650653, 10320.690379288633, 10325.122364599018, 41233.793831030955, 41664.0, 41732.0, 41778.373324400156, 41799.0, 3351.8827490433887, 3417.624061353249, 3543.698785603201, 3589.94615080774, 4041.3937909313545, 30444.8477757612, 30747.69252307493, 31205.843970780228, 31552.368952621047, 32348.35303293921, 3925.60743925608, 3931.6854651628087, 3931.8034098295257, 4002.3396139637216, 4024.6579040781567, 270158.0, 271995.0, 293638.99999999785, 391216.0, 396737.0, 49694.50305496971, 49759.502404976214, 49789.0, 50127.24809127866, 50143.24785128226, 52429.475705243225, 52632.21051684228, 52636.0, 52648.473515264355, 52649.0, 14968.775468367983, 15240.085594864344, 15255.0, 15276.541703748682, 15326.846731532765, 11730.296182229093, 11942.0, 11942.880571194351, 11958.222715523463, 12025.0, 20486.0, 20611.58776824455, 20689.27587534429, 20689.793102068787, 20744.0, 7478.663460144307, 7665.6933722650465, 7708.267714567107, 7797.727079552302, 7811.648475818602, 952.7951490429591, 983.4836710726926, 1010.7927874785652, 1073.0021080395152, 1132.17351333527, 26191.476170476482, 26672.866635666698, 26710.19869403921, 27047.729522704914, 27059.864700676764, 1038.1953985661173, 1043.7286305560458, 1049.3231865446744, 1054.4674939155677, 1054.947252637365, 13180.406881690347, 13276.203427794364, 13288.667783305495, 13316.800247996287, 13354.666133346744, 303719.0, 307090.0, 310500.0, 310857.0, 311051.0, 52533.47466525362, 52604.0, 52705.2094218587, 52717.0, 52769.736151319, 1339.8325209348832, 1340.3499302838115, 1348.6493511686836, 1354.410831288373, 1361.203695837926, 26344.473110538067, 27510.17469475919, 27656.446871062064, 27720.168394948185, 27842.582361265002, 43941.560584393745, 44703.55296447124, 45894.77052614716, 49855.501444985086, 50799.238011429115, 220895.0, 221739.0, 221762.0, 223465.0, 223990.0, 28148.296292592848, 31344.52983205208, 31706.04881853548, 31744.365112697156, 31763.364732704755, 32924.22467840426, 34592.82703586466, 43802.0, 44331.77834110809, 45015.77492112519, 36304.81847590745, 37418.0, 37552.0, 37724.245515088995, 38824.6705197689, 36878.0, 37155.442668360534, 37787.244255114194, 37892.24215515729, 38121.42817857679, 33347.0, 33502.49746253759, 33521.49717754284, 33534.32931341311, 36037.45943810898, 31317.843410783713, 33505.49741753827, 33965.32069358649, 34512.0, 34598.30803383868, 23157.305280841603, 23197.188098416475, 23407.882960585768, 23414.76585234194, 23688.0], "unit": "ms", "name": "ext.html", "value": 18540.934283733233}, {"lowerIsBetter": false, "replicates": [357.74421288778524, 358.98743543975957, 359.17748356264156, 359.86145334046387, 362.07851019156243, 14208.928955355208, 14407.063540869836, 16389.83610163898, 16625.334986600537, 17411.651766964667, 10839.891601083988, 11121.888781112186, 16256.0, 17478.65042699145, 17488.125593720328, 4896.069746748115, 5000.049990501811, 5001.249812528114, 5001.724905130216, 5002.674826136307, 3657.2868290683327, 3751.3622684143625, 4925.33507976424, 4957.405111386639, 5380.408155102955, 5413.188021796723, 5436.0, 5454.290942177511, 5455.727213639302, 5456.781728730866, 5423.267858839065, 5427.267318911956, 5498.45015498449, 5604.0, 5608.971955140199, 4890.608751299887, 4901.877453063702, 4933.975330123362, 4942.950570494285, 4959.578435832958, 19754.925732797994, 19796.0, 20192.49518762028, 20952.266670666453, 21072.473188170265, 2022.0, 2028.7464066991627, 2055.3833849845137, 2076.356329537848, 2115.9471013224793, 9575.569099390545, 9997.050280223368, 12398.81401778965, 13264.867351326557, 13372.598822035354, 1758.0594382005565, 1763.6296377760686, 1804.476701756489, 1818.3090425638172, 1829.1585870499587, 55086.0, 55955.16067258995, 63462.365376346104, 66424.6678766608, 67400.66299668519, 9754.804903901882, 10134.493275336352, 10261.94869025665, 10380.377177369382, 10385.584576617002, 13448.865511344762, 13473.326333683277, 13493.595192144252, 13501.459941602227, 13514.93242533781, 7145.749898753519, 7512.39900807934, 7539.472236943361, 7583.090029196532, 7642.426817988673, 7342.15565209997, 7346.926530734731, 7362.484626076123, 7386.704531818775, 7390.334869861738, 3943.921121577552, 4072.816723247461, 4116.58834116586, 4138.8344466221015, 4146.502419709594, 1752.5443384720065, 1794.318159099534, 1796.1468302556443, 1848.9167987440596, 1897.9881325794702, 424.898024474124, 436.58088235294474, 857.8455877942031, 953.2071031876529, 984.4880662055691, 9895.65365212214, 10273.434961077213, 10352.585896564053, 10411.843822342671, 10561.841572376421, 402.96776257899296, 415.9313713237282, 417.2031419987869, 452.377980277119, 465.2579136277632, 5621.915671264935, 5874.353821079678, 5901.232839730807, 5950.256217972754, 5990.251218597676, 508466.0, 514076.0, 514845.0, 517874.0, 520488.0, 78096.0, 78123.60938195387, 78241.0, 81109.59445202736, 83519.99999999878, 473.7418107131622, 476.0977946790812, 476.46873735785044, 477.9665423420397, 478.3685535093712, 10093.848592271268, 10095.54570044335, 10103.54534045955, 10303.587856485656, 10341.276110672181, 35312.64687353094, 35598.0, 36123.458148127276, 36640.49299274511, 37458.2508349826, 48051.0, 48708.75645621891, 50096.74951625364, 51336.229956551426, 52779.0, 9433.386829856037, 9760.902390976284, 9790.216782657228, 9918.950405247928, 9996.550155243178, 17216.311347545958, 17418.30326786914, 17620.82379176192, 17707.557311067325, 17761.200745966205, 10918.290311129751, 11104.73042140845, 12268.44791984345, 14105.929470352583, 14164.78752818688, 13154.276514791778, 13884.09753366028, 13906.304684765519, 13942.721145577234, 13961.860381396056, 13295.401706923018, 13353.0, 13562.79655805144, 13589.45642174302, 13823.654408639864, 8980.550972451481, 9179.908200917906, 9393.718188454357, 9403.34176607631, 9408.905910940803, 9567.521623918637, 13302.201867887958, 14120.858791411954, 14506.637334066732, 14507.202103883965], "unit": "ms", "name": "jquery.html", "value": 7974.768337841286}, {"lowerIsBetter": false, "replicates": [1508.3966413434619, 1684.082175214508, 1687.051455568818, 1708.7351460523623, 1739.295585287958, 7124.643767811608, 7345.118585769708, 7878.64546095425, 8009.0, 8021.0, 7897.328727058192, 7932.0481542214875, 7941.801454963629, 7955.204479552041, 7971.242731940456, 2071.3785864240745, 2114.9577008459823, 2305.700258966332, 2326.941826454335, 2328.371339738278, 2314.1206341590173, 2346.2843832631042, 2354.21133920137, 2355.858648481088, 2356.0458014504065, 2251.7072780538506, 2288.8512246703995, 2299.4481324482085, 2301.735300440446, 2302.8503147295455, 2033.3086750504826, 2070.3892351756267, 2251.4146321956246, 2300.1949317738827, 2338.0414030247603, 2317.571249318881, 2318.8840557972203, 2323.256557901472, 2326.0463210083954, 2326.790588846995, 7830.530168189927, 7997.280244777998, 7997.560134192617, 8003.1996800320085, 8006.879896801553, 4716.29255611661, 4785.880352991168, 4823.059503396839, 4823.372961515016, 4831.685940413862, 3213.389456003352, 3242.789218700777, 3290.226796702773, 3313.0557791029682, 3330.7501937354796, 1088.1186239146316, 1096.4188979840696, 1126.1722633864103, 1152.9481173347135, 1157.6584907452323, 10997.285176463503, 11074.944625276903, 11084.889151108466, 11091.778164436746, 11103.777924441547, 4234.534201237861, 4375.081232941055, 4385.51759306476, 4412.84555040572, 4451.1765323415275, 9455.76360590977, 9474.336796424184, 9478.431294122374, 9482.620695172116, 9489.952550237205, 4859.125357435695, 4877.244027175793, 4886.706797592155, 4887.926681099786, 4888.291197776302, 4399.054203346296, 4431.7340959542535, 4439.66702497314, 4448.1770872388715, 4465.464144302639, 3772.434134879735, 3807.695384369244, 3811.618838116166, 3837.827297771551, 3841.654251117413, 1188.9346085965356, 1194.7252132009687, 1196.611101392051, 1197.2098415046028, 1198.101423932051, 1294.2428679222571, 1317.855035946045, 1336.4654138344545, 1349.871762182591, 1350.2506109109538, 7313.414926805843, 7400.777976660709, 7454.962725186339, 7472.364848987788, 7474.103107627119, 449.25872310686975, 450.38747303666986, 470.11148928525114, 470.6658272626474, 476.20949224287517, 5390.8921821563345, 5525.254090697785, 6041.2750469943885, 6183.381661833871, 6193.102000209944, 9278.304127190488, 9406.05939406054, 9406.858897116548, 9794.902050979399, 9882.950585247028, 9733.318667693193, 9733.56198971048, 9752.756181095387, 9757.804843903225, 9758.853617195748, 7474.925250747532, 7527.887081693779, 7614.58119803405, 7637.930689703446, 7662.96168519165, 7456.105267367951, 7517.0, 7523.699052037857, 7532.7740167795055, 7534.020577325132, 8235.917640823514, 8542.78643033929, 8564.143585641386, 8656.091110433314, 8657.653693852175, 8748.69379571712, 8834.514101724468, 8973.28213742886, 8992.0, 9001.594928228114, 7181.712731490891, 7256.310650488195, 7267.818304542428, 7267.963660181666, 7275.163356214103, 7794.844103117793, 7857.685692572461, 7912.248336408032, 7918.881216781638, 7919.881201782093, 7188.964055179691, 7256.818579535554, 7289.708411663686, 7292.854142917218, 7306.634668266459, 7219.927800721925, 7265.673044713107, 7326.560406375635, 7450.813729656802, 7458.142313634002, 7302.488825782357, 7350.70597176107, 7355.668994895135, 7356.080489938758, 7360.926390736024, 6487.286398496068, 6534.575252608565, 6543.5419520633095, 6558.114654521769, 6608.339166083353, 6166.845828854135, 6267.749290028348, 6710.463162946855, 6720.731170753115, 6723.2604413515455], "unit": "ms", "name": "mootools.html", "value": 4528.140762585506}, {"lowerIsBetter": false, "replicates": [329.69173822475983, 329.749390463248, 335.62577725835695, 337.35901786605433, 337.4011130243817, 6159.815205543835, 6168.0439531872635, 6179.660118693476, 6211.378862113786, 6211.5341349398805, 5850.0, 5952.166696662471, 5966.701664916758, 6093.482054025413, 6119.2350956130485, 4666.976665116669, 4677.251639737643, 4686.437627484706, 4699.7415142167165, 4701.670883038189, 4415.183191109639, 4683.929741053887, 4693.88265293367, 4695.788689508963, 4697.835575754849, 4468.173387923229, 4474.731516109027, 4543.4093567836135, 4567.725936443824, 4584.426946631671, 4510.639148868116, 4567.657425693086, 4572.291294849287, 4574.268117101248, 4582.129395414877, 4028.8589899353383, 4033.7983100845136, 4039.151778126597, 4039.515258169009, 4041.6564592009713, 5704.80033198836, 5787.131930210502, 5787.536997040227, 5798.362180160179, 5799.159121927297, 5368.651037682538, 5369.570434365241, 5369.785208591652, 5373.2208829719475, 5375.3280839895015, 6510.707018184193, 6511.153550038512, 6512.348765123497, 6516.739330426777, 6519.152510173694, 4435.778211089465, 4440.378347031418, 4442.400275962736, 4453.265211240174, 4455.131249406367, 6580.309067547886, 6632.63520506372, 6705.530612857102, 6714.764983225564, 6717.9664101680155, 4479.507254202035, 4480.462344518679, 4481.4174157359985, 4483.058557702919, 4488.730676159441, 4538.977305113519, 4539.773011349419, 4539.931901021488, 4542.818287268472, 4543.6365090793315, 5302.761375738101, 5307.65500242483, 5308.442613525524, 5315.963387139471, 5317.627766056339, 6388.425041746265, 6536.967315163393, 6539.313372095957, 6542.8364290893105, 6546.574472659262, 1606.3735143294125, 1624.919428579981, 1627.1864067966017, 1630.2582325042076, 1630.9102999334914, 1046.100353695821, 1076.5532304093713, 1084.38732116354, 1094.015386152469, 1097.1716354152722, 6289.962156244169, 6313.43179113882, 6321.1150438938585, 6324.241091069009, 6326.2092238470195, 6497.837554061091, 6655.168103987002, 6719.529632925746, 6734.595924244561, 6740.056392105109, 6233.563650544509, 6259.467945224706, 6268.843278917972, 6337.366263373626, 6349.333320001333, 3624.5106910566737, 3643.872464463731, 3657.030886814996, 3657.451382292624, 3665.8533658653887, 6848.212455567574, 7024.613646249505, 7031.613261270679, 7036.6129862857015, 7042.0, 6946.548474349152, 6978.057962175041, 6981.2669669683955, 6984.266652001568, 6992.510524263253, 7035.12060992376, 7035.401990830836, 7036.683349249296, 7041.859162816715, 7058.6823592938445, 6619.0, 6786.558873673195, 6787.151606049244, 6796.626185559841, 6798.388145066968, 6708.26209116987, 6708.563943343667, 6715.865682686416, 6722.563033402813, 6727.697253623501, 6859.245482996766, 6868.862622747417, 6877.828054298482, 6884.862302753817, 7022.964885175541, 4490.348899409632, 4621.32990716351, 4655.9301610475195, 4665.323528088476, 4673.64947628936, 6623.1389919312105, 6694.866102678016, 6696.5647232929705, 6737.528373014038, 6739.797806065826, 6500.349965003651, 6508.121403610452, 6543.574667646588, 6561.934380656323, 6562.0, 6347.841303967438, 6463.676816159079, 6491.772787952399, 6494.415502604788, 6541.443977261986, 6405.839854003687, 6410.358964103739, 6413.743450261937, 6417.037444383193, 6434.967825160844, 6566.868662626816, 6567.802965911031, 6572.605643661395, 6574.046763219402, 6593.868122637425, 6273.0, 6389.744410223539, 6391.201099862517, 6402.487800976004, 6424.710888010144], "unit": "ms", "name": "prototype.html", "value": 4880.682191604308}, {"lowerIsBetter": false, "replicates": [760.1448370583093, 834.5451728807799, 838.9370797190212, 856.1224744636748, 858.2190206911707, 13277.601671949846, 13663.180209187443, 13685.726285474284, 13697.86302136977, 13703.794443083338, 13454.859809815067, 13509.392077356519, 13585.796213056812, 13610.183388996642, 13615.659608509792, 816.3673153306175, 830.0205757206494, 830.5681045856181, 830.7466222802043, 831.0276975938136, 827.065416079829, 831.4138532334689, 834.2075028722708, 834.3200291762224, 834.7620928035511, 862.2843040276587, 870.9651613935466, 871.3595507302127, 871.376965469689, 871.5337294547419, 867.7873920889359, 868.2099289646424, 869.256785448442, 869.4783130121939, 869.752120645613, 634.8761991411676, 635.0696230023038, 635.2567496029657, 635.3075148088559, 635.6758053392757, 12460.75078498425, 12467.875321246853, 12476.064295177806, 12545.498180072786, 12567.811482827765, 10975.615853445091, 11051.594294990518, 11061.557537698482, 11139.220254582182, 11172.385518796464, 9644.517774111266, 9838.114569688762, 9938.105570498617, 10104.292699510963, 10358.0, 3495.2834668892815, 3538.097785064818, 3587.4798154267746, 3594.245208506217, 3708.1471261609713, 46367.53632463666, 46383.53616463826, 46649.30026049612, 46653.533464665255, 48067.27899081482, 8607.18231767981, 8627.61175747093, 8776.122387761301, 9057.230135438429, 9147.0, 16793.91603041977, 16840.32638694463, 16882.07148606814, 16889.746653800205, 17019.659606807796, 7760.573168475675, 7836.0, 7960.960195198987, 8015.757557578585, 8146.063202731643, 4206.789660516962, 4211.136716973013, 4247.150569886036, 4258.850940217078, 4369.541198174146, 3017.562453444238, 3068.800527965675, 3077.615298087739, 3082.799618024821, 3093.922651933675, 561.831450564829, 564.2833601326292, 570.1704020649944, 590.4361334925136, 591.9822405327847, 593.1073734030257, 594.8512871782054, 611.39471922797, 611.8378629663143, 652.1098700274092, 8502.362322825813, 8614.39699221061, 8712.0, 8911.598978046004, 9226.446413215228, 628.4815027602156, 632.8860805055134, 679.7213142611506, 695.5374675840509, 695.8677851208254, 4009.639132478091, 4043.9191216175514, 4118.567550407224, 4251.618224077126, 4421.955780442218, 58389.0, 58657.41342586605, 58686.4131358681, 58951.410485894594, 59108.40891591115, 43344.0, 43476.78261608672, 47316.0, 50871.491285086675, 52048.73975630097, 45315.320270195974, 45765.771171144595, 45860.0, 46695.5330446698, 47359.28961065587, 8529.189726975927, 8561.871571926302, 9087.227585655293, 9273.814523709623, 9484.193843523377, 34420.311593768485, 35917.64082359143, 36446.27107457889, 36480.635193648784, 37414.25171496609, 46263.30605040994, 46735.76632116954, 46772.532274676814, 46873.53126468691, 47305.29042064303, 10612.840807387742, 11069.889301106887, 11110.777784444428, 11141.2201145919, 11149.386783726974, 11701.414929253673, 11764.647060588197, 11787.292762433939, 11804.291742495478, 11927.701807454536, 10972.451377431256, 11268.549258029587, 11303.660890173307, 11323.716907077389, 11348.602798901999, 10806.13550915909, 10877.18421118435, 10897.455127243447, 10908.236423450282, 10908.61819836302, 11292.378919159197, 11344.432778361213, 11410.657680269605, 11430.714232144262, 11477.426128693698, 9628.951855240679, 9719.708408747749, 9740.366876153028, 9779.60881564758, 10051.648192313234, 9521.571529281338, 9558.904410955802, 9774.706758797247, 9774.80450390974, 9783.315167938175], "unit": "ms", "name": "yui.html", "value": 6279.419135420773}], "name": "dromaeo_css", "value": 6947.802349749278}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 108.0, 102.0, 108.0, 110.0, 110.0, 99.0, 108.0, 113.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [145.0, 123.0, 148.0, 167.0, 134.0, 146.0, 146.0, 125.0, 164.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 159.0, 159.0, 159.0, 161.0, 160.0, 163.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 80.0, 92.0, 71.0, 72.0, 71.0, 100.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [89.0, 90.0, 140.0, 89.0, 91.0, 90.0, 143.0, 90.0, 90.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 61.0, 62.0, 61.0, 61.0, 68.0, 59.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 61.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 71.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 94.0, 86.0, 85.0, 85.0, 92.0, 84.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [114.0, 121.0, 113.0, 118.0, 120.0, 123.0, 122.0, 115.0, 127.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [140.0, 149.0, 150.0, 149.0, 150.0, 139.0, 148.0, 150.0, 148.0, 148.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.1}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 66.0, 67.0, 66.0, 69.0, 68.0, 65.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1494.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.78691193228065], "unit": "score", "name": "Richards", "value": 216.86018600000003}, {"lowerIsBetter": false, "replicates": [194.55252918287937], "unit": "score", "name": "DeltaBlue", "value": 339.84651999999994}, {"lowerIsBetter": false, "replicates": [285.2253280091272], "unit": "score", "name": "Encrypt", "value": 933.2305859999998}, {"lowerIsBetter": false, "replicates": [5045.226130653266], "unit": "score", "name": "Decrypt", "value": 52.75898306772911}, {"lowerIsBetter": false, "replicates": [1937.984496124031], "unit": "score", "name": "RayTrace", "value": 381.83432400000015}, {"lowerIsBetter": false, "replicates": [788.8100866824271], "unit": "score", "name": "Earley", "value": 844.8966503496501}, {"lowerIsBetter": false, "replicates": [12072.289156626506], "unit": "score", "name": "Boyer", "value": 55.20601696606782}, {"lowerIsBetter": false, "replicates": [25300.0], "unit": "score", "name": "RegExp", "value": 36.007312252964404}, {"lowerIsBetter": false, "replicates": [651.9480519480519], "unit": "score", "name": "Splay", "value": 124.99615537848611}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19803.128214789533}]} 05:56:43 INFO - RETURN: dromaeo_css: 6947.80 05:56:43 INFO - RETURN: kraken: 1494.90 05:56:43 INFO - RETURN: v8_7: 19803.13 05:56:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19803.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1494.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6947.80"}}} 05:56:43 INFO - Return code: 0 05:56:43 INFO - # TBPL SUCCESS # 05:56:43 INFO - Running post-action listener: _resource_record_post_action 05:56:43 INFO - Running post-run listener: _resource_record_post_run 05:56:44 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 497393664; Read time: 4; Write time: 454348 05:56:44 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 188383232; Read time: 0; Write time: 188380 05:56:44 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 267145216; Read time: 4; Write time: 175788 05:56:44 INFO - Running post-run listener: _upload_blobber_files 05:56:44 INFO - Blob upload gear active. 05:56:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:56:44 INFO - Copying logs to upload dir... 05:56:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.278609 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-20 05:56:44.561963) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:56:44.565514) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009981 build_url: 'https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:56:44.616028) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:56:44.616362) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448024770.663851-1340345687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:56:44.665958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 05:56:44.669298) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 05:56:44.669636) ========= ========= Total master_lag: 0.59 =========