builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1447336368.84 results: success (0) buildid: 20151112043002 builduid: a3d13aa182504984aad4155033c259ab revision: 3cc3b1968524248450c465c4ea2ee5596ffa65f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:48.844054) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:48.844659) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:48.844970) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006618 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:48.870910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:48.871252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:48.892332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:48.892624) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:48.947139) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:48.947741) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:48.948097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:48.948385) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 05:52:49-- 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% 83.4M=0s 2015-11-12 05:52:49 (83.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100099 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:49.063230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:49.063724) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022262 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:49.117733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:49.118065) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3cc3b1968524248450c465c4ea2ee5596ffa65f2 --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 3cc3b1968524248450c465c4ea2ee5596ffa65f2 --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=fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 05:52:50,062 truncating revision to first 12 chars 2015-11-12 05:52:50,062 Setting DEBUG logging. 2015-11-12 05:52:50,062 attempt 1/10 2015-11-12 05:52:50,062 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3cc3b1968524?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 05:52:50,313 unpacking tar archive at: mozilla-central-3cc3b1968524/testing/mozharness/ program finished with exit code 0 elapsedTime=0.496402 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:49.627685) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:49.627988) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:49.637210) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:49.637612) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:49.638071) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-12 05:52:49.638492) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:52:50 INFO - MultiFileLogger online at 20151112 05:52:50 in /builds/slave/test-pgo 05:52:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:52:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:52:50 INFO - {'append_to_log': False, 05:52:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:52:50 INFO - 'blob_upload_branch': 'Firefox', 05:52:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:52:50 INFO - 'branch': 'Firefox', 05:52:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:50 INFO - 'config_files': ('talos/linux_config.py',), 05:52:50 INFO - 'default_actions': ('clobber', 05:52:50 INFO - 'read-buildbot-config', 05:52:50 INFO - 'download-and-extract', 05:52:50 INFO - 'populate-webroot', 05:52:50 INFO - 'create-virtualenv', 05:52:50 INFO - 'install', 05:52:50 INFO - 'run-tests'), 05:52:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:50 INFO - 'download_minidump_stackwalk': True, 05:52:50 INFO - 'download_symbols': 'ondemand', 05:52:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:50 INFO - 'installer_path': 'installer.exe', 05:52:50 INFO - 'log_level': 'info', 05:52:50 INFO - 'log_name': 'talos', 05:52:50 INFO - 'log_to_console': True, 05:52:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:52:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:52:50 INFO - 'opt_config_files': (), 05:52:50 INFO - 'pip_index': False, 05:52:50 INFO - 'sps_profile': False, 05:52:50 INFO - 'sps_profile_interval': 0, 05:52:50 INFO - 'suite': 'dromaeojs-e10s', 05:52:50 INFO - 'system_bits': '64', 05:52:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:50 INFO - 'title': 'talos-linux64-ix-020', 05:52:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:50 INFO - 'use_talos_json': True, 05:52:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:52:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:50 INFO - 'work_dir': 'build'} 05:52:50 INFO - ##### 05:52:50 INFO - ##### Running clobber step. 05:52:50 INFO - ##### 05:52:50 INFO - Running pre-action listener: _resource_record_pre_action 05:52:50 INFO - Running main action method: clobber 05:52:50 INFO - rmtree: /builds/slave/test-pgo/build 05:52:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:52:51 INFO - Running post-action listener: _resource_record_post_action 05:52:51 INFO - ##### 05:52:51 INFO - ##### Running read-buildbot-config step. 05:52:51 INFO - ##### 05:52:51 INFO - Running pre-action listener: _resource_record_pre_action 05:52:51 INFO - Running main action method: read_buildbot_config 05:52:51 INFO - Using buildbot properties: 05:52:51 INFO - { 05:52:51 INFO - "properties": { 05:52:51 INFO - "buildnumber": 26, 05:52:51 INFO - "product": "firefox", 05:52:51 INFO - "script_repo_revision": "production", 05:52:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:52:51 INFO - "repository": "", 05:52:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:52:51 INFO - "buildid": "20151112043002", 05:52:51 INFO - "slavename": "talos-linux64-ix-020", 05:52:51 INFO - "pgo_build": "True", 05:52:51 INFO - "basedir": "/builds/slave/test-pgo", 05:52:51 INFO - "project": "", 05:52:51 INFO - "platform": "ubuntu64_hw", 05:52:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:52:51 INFO - "slavebuilddir": "test", 05:52:51 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:52:51 INFO - "branch": "mozilla-central", 05:52:51 INFO - "repo_path": "mozilla-central", 05:52:51 INFO - "stage_platform": "linux64-pgo", 05:52:51 INFO - "builduid": "a3d13aa182504984aad4155033c259ab", 05:52:51 INFO - "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2" 05:52:51 INFO - }, 05:52:51 INFO - "sourcestamp": { 05:52:51 INFO - "repository": "", 05:52:51 INFO - "hasPatch": false, 05:52:51 INFO - "project": "", 05:52:51 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:52:51 INFO - "changes": [ 05:52:51 INFO - { 05:52:51 INFO - "category": null, 05:52:51 INFO - "files": [ 05:52:51 INFO - { 05:52:51 INFO - "url": null, 05:52:51 INFO - "name": "https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:52:51 INFO - } 05:52:51 INFO - ], 05:52:51 INFO - "repository": "", 05:52:51 INFO - "rev": "3cc3b1968524248450c465c4ea2ee5596ffa65f2", 05:52:51 INFO - "who": "sendchange", 05:52:51 INFO - "when": 1447336282, 05:52:51 INFO - "number": 6653497, 05:52:51 INFO - "comments": "", 05:52:51 INFO - "project": "", 05:52:51 INFO - "at": "Thu 12 Nov 2015 05:51:22", 05:52:51 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:52:51 INFO - "revlink": "", 05:52:51 INFO - "properties": [ 05:52:51 INFO - [ 05:52:51 INFO - "buildid", 05:52:51 INFO - "20151112043002", 05:52:51 INFO - "Change" 05:52:51 INFO - ], 05:52:51 INFO - [ 05:52:51 INFO - "builduid", 05:52:51 INFO - "a3d13aa182504984aad4155033c259ab", 05:52:51 INFO - "Change" 05:52:51 INFO - ], 05:52:51 INFO - [ 05:52:51 INFO - "pgo_build", 05:52:51 INFO - "True", 05:52:51 INFO - "Change" 05:52:51 INFO - ] 05:52:51 INFO - ], 05:52:51 INFO - "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2" 05:52:51 INFO - } 05:52:51 INFO - ], 05:52:51 INFO - "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2" 05:52:51 INFO - } 05:52:51 INFO - } 05:52:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:52:51 INFO - Running post-action listener: _resource_record_post_action 05:52:51 INFO - ##### 05:52:51 INFO - ##### Running download-and-extract step. 05:52:51 INFO - ##### 05:52:51 INFO - Running pre-action listener: _resource_record_pre_action 05:52:51 INFO - Running main action method: download_and_extract 05:52:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:51 INFO - https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:52:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/test_packages.json 05:52:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/test_packages.json 05:52:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:52:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:52:51 INFO - Downloaded 1302 bytes. 05:52:51 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:52:51 INFO - Using the following test package requirements: 05:52:51 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:51 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:52:51 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:51 INFO - u'jsshell-linux-x86_64.zip'], 05:52:51 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:52:51 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:51 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:52:51 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:52:51 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:52:51 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:51 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:52:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:51 INFO - https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/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:52:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/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:52:52 INFO - Downloaded 22438691 bytes. 05:52:52 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:52:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:52 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:52:53 INFO - Return code: 0 05:52:53 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:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:53 INFO - https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/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:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/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:52:55 INFO - Downloaded 22438691 bytes. 05:52:55 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:52:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:55 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:52:56 INFO - Return code: 0 05:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:56 INFO - https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:52:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/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:52:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/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:52:57 INFO - Downloaded 11131693 bytes. 05:52:57 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:52:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:57 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:52:57 INFO - Return code: 0 05:52: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:52:57 INFO - https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:52:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:52:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:52:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/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:52:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/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:53:00 INFO - Downloaded 57167715 bytes. 05:53:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:53:00 INFO - mkdir: /builds/slave/test-pgo/properties 05:53:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:53:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:53:00 INFO - Contents: 05:53:00 INFO - build_url:https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:53:00 INFO - Running post-action listener: _resource_record_post_action 05:53:00 INFO - Running post-action listener: set_extra_try_arguments 05:53:00 INFO - ##### 05:53:00 INFO - ##### Running populate-webroot step. 05:53:00 INFO - ##### 05:53:00 INFO - Running pre-action listener: _resource_record_pre_action 05:53:00 INFO - Running main action method: populate_webroot 05:53:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:53:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:53:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:53:00 INFO - '../fennec_ids.txt'], 05:53:00 INFO - 'tests': ['tcheck2']}, 05:53:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:53:00 INFO - '--tppagecycles', 05:53:00 INFO - '7'], 05:53:00 INFO - 'tests': ['tsvgm']}}, 05:53:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:53:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:53:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:53:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:53:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:53:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:53:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:00 INFO - 'talos_options': ['--e10s'], 05:53:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:00 INFO - 'tests': ['damp', 'tps']}, 05:53:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:00 INFO - 'talos_options': ['--e10s'], 05:53:00 INFO - 'tests': ['damp', 'tps']}, 05:53:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:53:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:53:00 INFO - 'other': {'tests': ['a11yr', 05:53:00 INFO - 'ts_paint', 05:53:00 INFO - 'tpaint', 05:53:00 INFO - 'sessionrestore', 05:53:00 INFO - 'sessionrestore_no_auto_restore']}, 05:53:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:53:00 INFO - 'tests': ['a11yr', 05:53:00 INFO - 'ts_paint', 05:53:00 INFO - 'tpaint', 05:53:00 INFO - 'sessionrestore', 05:53:00 INFO - 'sessionrestore_no_auto_restore']}, 05:53:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:53:00 INFO - 'tests': ['a11yr', 05:53:00 INFO - 'ts_paint', 05:53:00 INFO - 'tpaint', 05:53:00 INFO - 'sessionrestore', 05:53:00 INFO - 'sessionrestore_no_auto_restore']}, 05:53:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:53:00 INFO - 'tests': ['a11yr', 05:53:00 INFO - 'ts_paint', 05:53:00 INFO - 'tpaint', 05:53:00 INFO - 'sessionrestore', 05:53:00 INFO - 'sessionrestore_no_auto_restore']}, 05:53:00 INFO - 'other_l64': {'tests': ['a11yr', 05:53:00 INFO - 'ts_paint', 05:53:00 INFO - 'tpaint', 05:53:00 INFO - 'sessionrestore', 05:53:00 INFO - 'sessionrestore_no_auto_restore']}, 05:53:00 INFO - 'other_nol64': {'tests': ['a11yr', 05:53:00 INFO - 'ts_paint', 05:53:00 INFO - 'tpaint', 05:53:00 INFO - 'sessionrestore', 05:53:00 INFO - 'sessionrestore_no_auto_restore']}, 05:53:00 INFO - 'svgr': {'tests': ['tsvgx', 05:53:00 INFO - 'tsvgr_opacity', 05:53:00 INFO - 'tart', 05:53:00 INFO - 'tscrollx', 05:53:00 INFO - 'cart']}, 05:53:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:53:00 INFO - 'tests': ['tsvgx', 05:53:00 INFO - 'tsvgr_opacity', 05:53:00 INFO - 'tart', 05:53:00 INFO - 'tscrollx', 05:53:00 INFO - 'cart']}, 05:53:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:00 INFO - 'tests': ['tp5o']}, 05:53:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:00 INFO - 'talos_options': ['--e10s'], 05:53:00 INFO - 'tests': ['tp5o']}, 05:53:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:00 INFO - 'talos_options': ['--xperf_path', 05:53:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:00 INFO - 'tests': ['tp5n']}, 05:53:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:00 INFO - 'talos_options': ['--e10s', 05:53:00 INFO - '--xperf_path', 05:53:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:00 INFO - 'tests': ['tp5n']}}, 05:53:00 INFO - 'talos.zip': {'path': '', 05:53:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:53:00 INFO - Running post-action listener: _resource_record_post_action 05:53:00 INFO - ##### 05:53:00 INFO - ##### Running create-virtualenv step. 05:53:00 INFO - ##### 05:53:00 INFO - Running pre-action listener: _resource_record_pre_action 05:53:00 INFO - Running main action method: create_virtualenv 05:53:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:53:00 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:53:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:53:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:53:00 INFO - Using real prefix '/usr' 05:53:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:53:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:53:02 INFO - Installing pip.................done. 05:53:02 INFO - Return code: 0 05:53:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fe456d4cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21776c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22386e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ea90>, '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 0x22c0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c12e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', '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:53:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --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:53:02 INFO - Using env: {'DISPLAY': ':0', 05:53:02 INFO - 'HOME': '/home/cltbld', 05:53:02 INFO - 'LANG': 'en_US.UTF-8', 05:53:02 INFO - 'LANGUAGE': 'en_US:en', 05:53:02 INFO - 'LOGNAME': 'cltbld', 05:53:02 INFO - 'MAIL': '/var/mail/cltbld', 05:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:02 INFO - 'MOZ_NO_REMOTE': '1', 05:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:02 INFO - 'NO_EM_RESTART': '1', 05:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:02 INFO - 'SHELL': '/bin/bash', 05:53:02 INFO - 'SHLVL': '1', 05:53:02 INFO - 'TERM': 'linux', 05:53:02 INFO - 'TMOUT': '86400', 05:53:02 INFO - 'USER': 'cltbld', 05:53:02 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', 05:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:02 INFO - '_': '/tools/buildbot/bin/python'} 05:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53: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:53:02 INFO - Cleaning up... 05:53:02 INFO - Return code: 0 05:53:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fe456d4cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21776c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22386e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ea90>, '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 0x22c0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c12e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', '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:53:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --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:53:02 INFO - Using env: {'DISPLAY': ':0', 05:53:02 INFO - 'HOME': '/home/cltbld', 05:53:02 INFO - 'LANG': 'en_US.UTF-8', 05:53:02 INFO - 'LANGUAGE': 'en_US:en', 05:53:02 INFO - 'LOGNAME': 'cltbld', 05:53:02 INFO - 'MAIL': '/var/mail/cltbld', 05:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:02 INFO - 'MOZ_NO_REMOTE': '1', 05:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:02 INFO - 'NO_EM_RESTART': '1', 05:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:02 INFO - 'SHELL': '/bin/bash', 05:53:02 INFO - 'SHLVL': '1', 05:53:02 INFO - 'TERM': 'linux', 05:53:02 INFO - 'TMOUT': '86400', 05:53:02 INFO - 'USER': 'cltbld', 05:53:02 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', 05:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:02 INFO - '_': '/tools/buildbot/bin/python'} 05:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:03 INFO - Downloading/unpacking psutil>=0.7.1 05:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:04 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:53: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:53:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:04 INFO - Installing collected packages: psutil 05:53:04 INFO - Running setup.py install for psutil 05:53:04 INFO - building 'psutil._psutil_linux' extension 05:53: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:53: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:53:05 INFO - building 'psutil._psutil_posix' extension 05:53: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:53: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:53:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:05 INFO - Successfully installed psutil 05:53:05 INFO - Cleaning up... 05:53:05 INFO - Return code: 0 05:53:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:53: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:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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 0x7fe456d4cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21776c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22386e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ea90>, '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 0x22c0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c12e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', '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:53: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:53: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:53:05 INFO - Using env: {'DISPLAY': ':0', 05:53:05 INFO - 'HOME': '/home/cltbld', 05:53:05 INFO - 'LANG': 'en_US.UTF-8', 05:53:05 INFO - 'LANGUAGE': 'en_US:en', 05:53:05 INFO - 'LOGNAME': 'cltbld', 05:53:05 INFO - 'MAIL': '/var/mail/cltbld', 05:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:05 INFO - 'MOZ_NO_REMOTE': '1', 05:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:05 INFO - 'NO_EM_RESTART': '1', 05:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:05 INFO - 'SHELL': '/bin/bash', 05:53:05 INFO - 'SHLVL': '1', 05:53:05 INFO - 'TERM': 'linux', 05:53:05 INFO - 'TMOUT': '86400', 05:53:05 INFO - 'USER': 'cltbld', 05:53:05 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', 05:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:05 INFO - '_': '/tools/buildbot/bin/python'} 05:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:53: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:53: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:53: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:53: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:53: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:53: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:53:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:53:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53: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:53:07 INFO - Installing collected packages: mozsystemmonitor 05:53:07 INFO - Running setup.py install for mozsystemmonitor 05:53:07 INFO - Successfully installed mozsystemmonitor 05:53:07 INFO - Cleaning up... 05:53:07 INFO - Return code: 0 05:53:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:53: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:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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 0x7fe456d4cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21776c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22386e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ea90>, '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 0x22c0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c12e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', '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:53: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:53: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:53:07 INFO - Using env: {'DISPLAY': ':0', 05:53:07 INFO - 'HOME': '/home/cltbld', 05:53:07 INFO - 'LANG': 'en_US.UTF-8', 05:53:07 INFO - 'LANGUAGE': 'en_US:en', 05:53:07 INFO - 'LOGNAME': 'cltbld', 05:53:07 INFO - 'MAIL': '/var/mail/cltbld', 05:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:07 INFO - 'MOZ_NO_REMOTE': '1', 05:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:07 INFO - 'NO_EM_RESTART': '1', 05:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:07 INFO - 'SHELL': '/bin/bash', 05:53:07 INFO - 'SHLVL': '1', 05:53:07 INFO - 'TERM': 'linux', 05:53:07 INFO - 'TMOUT': '86400', 05:53:07 INFO - 'USER': 'cltbld', 05:53:07 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', 05:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:07 INFO - '_': '/tools/buildbot/bin/python'} 05:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:07 INFO - Downloading/unpacking blobuploader==1.2.4 05:53: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:53: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:53: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:53: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:53: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:53: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:53:09 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53: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:53:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:53:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53: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:53: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:53: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:53: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:53: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:53: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:53:09 INFO - Downloading docopt-0.6.1.tar.gz 05:53: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:53:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:10 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:10 INFO - Running setup.py install for blobuploader 05:53:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:53:10 INFO - Running setup.py install for requests 05:53:10 INFO - Running setup.py install for docopt 05:53:10 INFO - Successfully installed blobuploader requests docopt 05:53:10 INFO - Cleaning up... 05:53:10 INFO - Return code: 0 05:53:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:53: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:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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 0x7fe456d4cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21776c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22386e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ea90>, '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 0x22c0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c12e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', '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:53: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:53: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:53:10 INFO - Using env: {'DISPLAY': ':0', 05:53:10 INFO - 'HOME': '/home/cltbld', 05:53:10 INFO - 'LANG': 'en_US.UTF-8', 05:53:10 INFO - 'LANGUAGE': 'en_US:en', 05:53:10 INFO - 'LOGNAME': 'cltbld', 05:53:10 INFO - 'MAIL': '/var/mail/cltbld', 05:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:10 INFO - 'MOZ_NO_REMOTE': '1', 05:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:10 INFO - 'NO_EM_RESTART': '1', 05:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:10 INFO - 'SHELL': '/bin/bash', 05:53:10 INFO - 'SHLVL': '1', 05:53:10 INFO - 'TERM': 'linux', 05:53:10 INFO - 'TMOUT': '86400', 05:53:10 INFO - 'USER': 'cltbld', 05:53:10 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', 05:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:10 INFO - '_': '/tools/buildbot/bin/python'} 05:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:53:10 INFO - Running setup.py (path:/tmp/pip-NJDunf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:53:10 INFO - Running setup.py (path:/tmp/pip-C27mWz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:53:10 INFO - Running setup.py (path:/tmp/pip-F8pilx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:53:11 INFO - Running setup.py (path:/tmp/pip-7wyHw1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:53:11 INFO - Running setup.py (path:/tmp/pip-HAZ9MK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:53:11 INFO - Running setup.py (path:/tmp/pip-MwfpR3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:53:11 INFO - Running setup.py (path:/tmp/pip-F9BTgi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:53:11 INFO - Running setup.py (path:/tmp/pip-n5H5ON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:53:11 INFO - Running setup.py (path:/tmp/pip-6jdBu5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:53:11 INFO - Running setup.py (path:/tmp/pip-qXLpcT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:53:11 INFO - Running setup.py (path:/tmp/pip-6EbYwr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:53:11 INFO - Running setup.py (path:/tmp/pip-CMQl5E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:53:11 INFO - Running setup.py (path:/tmp/pip-Gwjnmo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:53:11 INFO - Running setup.py (path:/tmp/pip-NA6V4L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:53:11 INFO - Running setup.py (path:/tmp/pip-h8QBAN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:53:11 INFO - Running setup.py (path:/tmp/pip-V6SJuy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:53:11 INFO - Running setup.py (path:/tmp/pip-rnFKVM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:53:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:12 INFO - Running setup.py install for manifestparser 05:53:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:53:12 INFO - Running setup.py install for mozcrash 05:53:12 INFO - Running setup.py install for mozdebug 05:53:12 INFO - Running setup.py install for mozdevice 05:53:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:53:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:53:12 INFO - Running setup.py install for mozfile 05:53:12 INFO - Running setup.py install for mozhttpd 05:53:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:53:12 INFO - Running setup.py install for mozinfo 05:53:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:53:12 INFO - Running setup.py install for mozInstall 05:53:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:53:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:53:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:53:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:53:12 INFO - Running setup.py install for mozleak 05:53:12 INFO - Running setup.py install for mozlog 05:53:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:53:13 INFO - Running setup.py install for moznetwork 05:53:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:53:13 INFO - Running setup.py install for mozprocess 05:53:13 INFO - Running setup.py install for mozprofile 05:53:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:53:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:53:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:53:13 INFO - Running setup.py install for mozrunner 05:53:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:53:13 INFO - Running setup.py install for mozscreenshot 05:53:13 INFO - Running setup.py install for moztest 05:53:13 INFO - Running setup.py install for mozversion 05:53:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:53:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:13 INFO - Cleaning up... 05:53:13 INFO - Return code: 0 05:53:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:53: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:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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 0x7fe456d4cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21776c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22386e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ea90>, '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 0x22c0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c12e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', '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:53: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:53: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:53:13 INFO - Using env: {'DISPLAY': ':0', 05:53:13 INFO - 'HOME': '/home/cltbld', 05:53:13 INFO - 'LANG': 'en_US.UTF-8', 05:53:13 INFO - 'LANGUAGE': 'en_US:en', 05:53:13 INFO - 'LOGNAME': 'cltbld', 05:53:13 INFO - 'MAIL': '/var/mail/cltbld', 05:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:13 INFO - 'MOZ_NO_REMOTE': '1', 05:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:13 INFO - 'NO_EM_RESTART': '1', 05:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:13 INFO - 'SHELL': '/bin/bash', 05:53:13 INFO - 'SHLVL': '1', 05:53:13 INFO - 'TERM': 'linux', 05:53:13 INFO - 'TMOUT': '86400', 05:53:13 INFO - 'USER': 'cltbld', 05:53:13 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', 05:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:13 INFO - '_': '/tools/buildbot/bin/python'} 05:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:53:14 INFO - Running setup.py (path:/tmp/pip-_3h81y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:53:14 INFO - Running setup.py (path:/tmp/pip-aoyky7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:53:14 INFO - Running setup.py (path:/tmp/pip-HEU_gF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:53:14 INFO - Running setup.py (path:/tmp/pip-3Ifl67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:53:14 INFO - Running setup.py (path:/tmp/pip-pDYLCO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:53:14 INFO - Running setup.py (path:/tmp/pip-2EupSt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:53:14 INFO - Running setup.py (path:/tmp/pip-gAo_XU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:53:14 INFO - Running setup.py (path:/tmp/pip-oiBbiA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:53:14 INFO - Running setup.py (path:/tmp/pip-d_ORiN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:53:14 INFO - Running setup.py (path:/tmp/pip-TuOAP5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:53:14 INFO - Running setup.py (path:/tmp/pip-ONevLt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:53:14 INFO - Running setup.py (path:/tmp/pip-kFQ6Fn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:53:14 INFO - Running setup.py (path:/tmp/pip-mUB657-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:53: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:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:53:14 INFO - Running setup.py (path:/tmp/pip-z5aQZR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:53: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:53:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:53:15 INFO - Running setup.py (path:/tmp/pip-y8KRav-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:53: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:53:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:53:15 INFO - Running setup.py (path:/tmp/pip-68QsBy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:53: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:53:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:53:15 INFO - Running setup.py (path:/tmp/pip-JPbPU7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53:16 INFO - Downloading blessings-1.5.1.tar.gz 05:53:16 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:53:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:16 INFO - Installing collected packages: blessings 05:53:16 INFO - Running setup.py install for blessings 05:53:17 INFO - Successfully installed blessings 05:53:17 INFO - Cleaning up... 05:53:17 INFO - Return code: 0 05:53:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:53:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:53:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:53:17 INFO - Reading from file tmpfile_stdout 05:53:17 INFO - Current package versions: 05:53:17 INFO - argparse == 1.2.1 05:53:17 INFO - blessings == 1.5.1 05:53:17 INFO - blobuploader == 1.2.4 05:53:17 INFO - docopt == 0.6.1 05:53:17 INFO - manifestparser == 1.1 05:53:17 INFO - mozInstall == 1.12 05:53:17 INFO - mozcrash == 0.16 05:53:17 INFO - mozdebug == 0.1 05:53:17 INFO - mozdevice == 0.47 05:53:17 INFO - mozfile == 1.2 05:53:17 INFO - mozhttpd == 0.7 05:53:17 INFO - mozinfo == 0.9 05:53:17 INFO - mozleak == 0.1 05:53:17 INFO - mozlog == 3.0 05:53:17 INFO - moznetwork == 0.27 05:53:17 INFO - mozprocess == 0.22 05:53:17 INFO - mozprofile == 0.27 05:53:17 INFO - mozrunner == 6.11 05:53:17 INFO - mozscreenshot == 0.1 05:53:17 INFO - mozsystemmonitor == 0.0 05:53:17 INFO - moztest == 0.7 05:53:17 INFO - mozversion == 1.4 05:53:17 INFO - psutil == 3.1.1 05:53:17 INFO - requests == 1.2.3 05:53:17 INFO - wsgiref == 0.1.2 05:53:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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 0x7fe456d4cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21776c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22386e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ea90>, '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 0x22c0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c12e0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', '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:53: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:53: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:53:17 INFO - Using env: {'DISPLAY': ':0', 05:53:17 INFO - 'HOME': '/home/cltbld', 05:53:17 INFO - 'LANG': 'en_US.UTF-8', 05:53:17 INFO - 'LANGUAGE': 'en_US:en', 05:53:17 INFO - 'LOGNAME': 'cltbld', 05:53:17 INFO - 'MAIL': '/var/mail/cltbld', 05:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:17 INFO - 'MOZ_NO_REMOTE': '1', 05:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:17 INFO - 'NO_EM_RESTART': '1', 05:53:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:17 INFO - 'SHELL': '/bin/bash', 05:53:17 INFO - 'SHLVL': '1', 05:53:17 INFO - 'TERM': 'linux', 05:53:17 INFO - 'TMOUT': '86400', 05:53:17 INFO - 'USER': 'cltbld', 05:53:17 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', 05:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:17 INFO - '_': '/tools/buildbot/bin/python'} 05:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53:17 INFO - Cleaning up... 05:53:17 INFO - Return code: 0 05:53:17 INFO - Running post-action listener: _resource_record_post_action 05:53:17 INFO - Running post-action listener: _start_resource_monitoring 05:53:17 INFO - Starting resource monitoring. 05:53:17 INFO - ##### 05:53:17 INFO - ##### Running install step. 05:53:17 INFO - ##### 05:53:17 INFO - Running pre-action listener: _resource_record_pre_action 05:53:17 INFO - Running main action method: install 05:53:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:53:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:53:17 INFO - Reading from file tmpfile_stdout 05:53:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:53:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:53:17 INFO - Reading from file tmpfile_stdout 05:53:17 INFO - Output received: 05:53:17 INFO - Usage: mozinstall [options] installer 05:53:17 INFO - Options: 05:53:17 INFO - -h, --help show this help message and exit 05:53:17 INFO - -d DEST, --destination=DEST 05:53:17 INFO - Directory to install application into. [default: 05:53:17 INFO - "/builds/slave/test-pgo"] 05:53:17 INFO - --app=APP Application being installed. [default: firefox] 05:53:17 INFO - mkdir: /builds/slave/test-pgo/build/application 05:53:17 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:53:17 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:53:32 INFO - Reading from file tmpfile_stdout 05:53:32 INFO - Output received: 05:53:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:53:32 INFO - Running post-action listener: _resource_record_post_action 05:53:32 INFO - ##### 05:53:32 INFO - ##### Running run-tests step. 05:53:32 INFO - ##### 05:53:32 INFO - Running pre-action listener: _resource_record_pre_action 05:53:32 INFO - Running main action method: run_tests 05:53:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:53:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:53:32 INFO - Python 2.7.3 05:53:32 INFO - Return code: 0 05:53:32 INFO - grabbing minidump binary from tooltool 05:53: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:53: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 0x226ea90>, '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 0x22c0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c12e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:53: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:53: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:53:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:32 INFO - Return code: 0 05:53:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:53:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:53:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:53:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:53:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:53: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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:53: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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost 05:53:32 INFO - Using env: {'DISPLAY': ':0', 05:53:32 INFO - 'HOME': '/home/cltbld', 05:53:32 INFO - 'LANG': 'en_US.UTF-8', 05:53:32 INFO - 'LANGUAGE': 'en_US:en', 05:53:32 INFO - 'LOGNAME': 'cltbld', 05:53:32 INFO - 'MAIL': '/var/mail/cltbld', 05:53:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:53:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:32 INFO - 'MOZ_NO_REMOTE': '1', 05:53:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:32 INFO - 'NO_EM_RESTART': '1', 05:53: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:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:53:32 INFO - 'SHELL': '/bin/bash', 05:53:32 INFO - 'SHLVL': '1', 05:53:32 INFO - 'TERM': 'linux', 05:53:32 INFO - 'TMOUT': '86400', 05:53:32 INFO - 'USER': 'cltbld', 05:53:32 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298', 05:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:32 INFO - '_': '/tools/buildbot/bin/python'} 05:53: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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] with output_timeout 3600 05:53:32 INFO - mozversion INFO | application_buildid: 20151112043002 05:53:32 INFO - mozversion INFO | application_changeset: 3cc3b1968524248450c465c4ea2ee5596ffa65f2 05:53:32 INFO - mozversion INFO | application_display_name: Nightly 05:53:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:32 INFO - mozversion INFO | application_name: Firefox 05:53:32 INFO - mozversion INFO | application_remotingname: firefox 05:53:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:53:32 INFO - mozversion INFO | application_vendor: Mozilla 05:53:32 INFO - mozversion INFO | application_version: 45.0a1 05:53:32 INFO - mozversion INFO | platform_buildid: 20151112043002 05:53:32 INFO - mozversion INFO | platform_changeset: 3cc3b1968524248450c465c4ea2ee5596ffa65f2 05:53:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:53:32 INFO - mozversion INFO | platform_version: 45.0a1 05:53:32 INFO - 2015-11-12 05:53:32,493 DEBUG : using testdate: 1447336412 05:53:32 INFO - 2015-11-12 05:53:32,493 DEBUG : actual date: 1447336412 05:53:32 INFO - 2015-11-12 05:53:32,506 INFO : starting webserver on 'localhost:34808' 05:53:32 INFO - 2015-11-12 05:53:32,507 INFO : Starting test suite talos-linux64-ix-020.e 05:53:32 INFO - 2015-11-12 05:53:32,507 INFO : Starting test dromaeo_css 05:53:32 INFO - 2015-11-12 05:53:32,507 DEBUG : operating with platform_type : linux_ 05:53:32 INFO - 2015-11-12 05:53:32,507 INFO : Initialising browser for dromaeo_css test... 05:53:32 INFO - 2015-11-12 05:53:32,514 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp626VJn/profile http://localhost:34808/getInfo.html 05:53:44 INFO - 2015-11-12 05:53:44,120 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:53:44 INFO - 2015-11-12 05:53:44,120 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:53:44 INFO - 2015-11-12 05:53:44,120 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:53:44 INFO - 2015-11-12 05:53:44,120 DEBUG : BROWSER_OUTPUT: __metrics 05:53:45 INFO - 2015-11-12 05:53:45,461 INFO : Browser initialized. 05:53:45 INFO - 2015-11-12 05:53:45,462 INFO : Running cycle 1/1 for dromaeo_css test... 05:53:45 INFO - 2015-11-12 05:53:45,462 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp626VJn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:53:57 INFO - 2015-11-12 05:53:57,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 140443648 05:53:57 INFO - 2015-11-12 05:53:57,280 DEBUG : BROWSER_OUTPUT: 05:54:46 INFO - 2015-11-12 05:54:46,915 DEBUG : BROWSER_OUTPUT: 1447336486910 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:56:55 INFO - 2015-11-12 05:56:55,794 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34808/tests/dromaeo/cssquery-ext.html) 05:56:57 INFO - 2015-11-12 05:56:57,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 144703488 05:56:57 INFO - 2015-11-12 05:56:57,000 DEBUG : BROWSER_OUTPUT: 05:59:58 INFO - 2015-11-12 05:59:58,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/dromaeo/cssquery-ext.html (next: http://localhost:34808/tests/dromaeo/cssquery-jquery.html) 05:59:59 INFO - 2015-11-12 05:59:59,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 140537856 05:59:59 INFO - 2015-11-12 05:59:59,535 DEBUG : BROWSER_OUTPUT: 06:03:01 INFO - 2015-11-12 06:03:01,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34808/tests/dromaeo/cssquery-mootools.html) 06:03:01 INFO - 2015-11-12 06:03:01,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 141000704 06:03:01 INFO - 2015-11-12 06:03:01,899 DEBUG : BROWSER_OUTPUT: 06:06:03 INFO - 2015-11-12 06:06:03,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34808/tests/dromaeo/cssquery-prototype.html) 06:06:04 INFO - 2015-11-12 06:06:04,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 140251136 06:06:04 INFO - 2015-11-12 06:06:04,150 DEBUG : BROWSER_OUTPUT: 06:09:06 INFO - 2015-11-12 06:09:06,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34808/tests/dromaeo/cssquery-yui.html) 06:09:07 INFO - 2015-11-12 06:09:07,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 140722176 06:09:07 INFO - 2015-11-12 06:09:07,070 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-12 06:12:09,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/dromaeo/cssquery-yui.html (next: http://localhost:34808/tests/dromaeo/cssquery-dojo.html) 06:12:09 INFO - 2015-11-12 06:12:09,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 142458880 06:12:09 INFO - 2015-11-12 06:12:09,534 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-12 06:12:09,534 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:12:09 INFO - 2015-11-12 06:12:09,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:12:09 INFO - 2015-11-12 06:12:09,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:12:09 INFO - 2015-11-12 06:12:09,535 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:12:09 INFO - 2015-11-12 06:12:09,535 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3195.6964088411605;3231.14374690707;3241.011491495093;3274.81988490633;3280.1963518937864;5199.194124910636;5431.91852122218;5434.538064264532;5445.700486473247;5453.618246722731;5300.310959575259;5337.2527846101575;5366.624336296461;5453.345598528173;5472.863178420542;4963.578095861856;4970.254461830718;5041.72270525121;5064.873378165557;5103.566196873252;4983.626228032894;5048.974755126219;5091.79632814687;5106.157484015152;5111.718855462948;4819.132556139911;4863.221884498499;4926.926096108561;4943.382077240345;5024.572911302544;4918.139325618003;4948.158813001798;4962.528559786814;4987.925181122286;4989.101961646902;4685.2972054191805;4930.457649658535;4938.308636790852;4949.455559888409;4994.375703037121;5186.507281808223;5199.610029247784;5206.583473322163;5225.529702326771;5259.684418934876;5844.503217226541;5852.736626851759;5898;5917.792877249276;5923.7926672566255;5697.77208911643;5782.3350314713925;5882.647041177543;5891.882162356729;5918.733656985403;5413.02565538203;5474.753636086386;5476.91784623231;5491.615586908918;5555.944370569619;5939.198208241918;5962.4633782959745;5969.611975221596;5980.192673989043;5989.861926234002;5515.641483303572;5600.467955544217;5635.887282254332;5772.365039845614;5804.303483581997;5628.493435590816;5702.201691763156;5711.628744131701;5721.713914304268;5761.020626493506;5760.884782304331;5803.738831752581;5817.069268916953;5822.039363505059;5833.474987251083;5633.549316054706;5745.224394706661;5796.101604251347;5802.796902108406;5832.883342333214;4464.3973063635995;4480.260756975063;4492.663050271242;4515.367848501212;4517.209488339593;4000.6799456043445;4002.699797515198;4019.678425725935;4022.27599032177;4030.5969403059457;5322.627416080914;5403.648762830482;5441.564674826004;5550.694711790809;5568;5814.127880817827;5816.970915145397;5829.8251052468495;5838.649681019152;5927.288725352985;5536.75084621193;5545.861353466115;5546.195801608744;5554.972225138848;5557.499825015687;4875.68308059975;4955.2567114933045;4969;5021.874453138627;5077.974610126926;6102.481289090389;6128.785492507741;6140.631562106288;6171.506279497629;6172;5557;5910.438508341873;5938.049912014057;5949.851253718692;5961.612495187799;5851.502622277154;5890.4698577128265;5891.469767720926;5896.439838215363;5908.202392676933;5644.717764111696;5691.943080569307;5824.388439213822;5832.300123985149;5876.764929402947;5774.595778295647;5824.708764561839;5833.79581714638;5835.503982161564;5848.795292164754;5527.115661494303;5664.631798933056;5695.544356451391;5700.942990570041;5709.800156994652;5511.779528818803;5554.444555544414;5579.218909352775;5592.077307244259;5620.297462817148;5500.064988951808;5527.336719593674;5530.5022547969265;5539.750711218086;5540.058190107611;5533.916991245215;5600.523955463831;5619.747111380079;5666.631668941505;5704.458076482728;5591.30108736408;5685.459881311269;5698.6580805151825;5702.287214098238;5747.08046712524 06:12:09 INFO - 2015-11-12 06:12:09,535 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.8068729482436;600.5525883217002;600.8678090820018;608.540551883328;608.7869245763981;40078.19843603126;41008.38487422691;41055;41105.58894411055;41213.587864121386;43740.562594374045;44010.33984490235;44227;44276.557234427644;44384.77807610966;8766.298696104312;8793.780155496132;8865.246454051414;8875.911240887574;8911.95544022279;8649.351298652595;8749.693760718375;8750.649974001033;8756.124387561256;8759.693410730593;8720.476771393736;8783.95608021959;8792.428492148021;8851.822963540757;8866.335024873128;8729.563521823884;8745.256653184455;8758.211760941515;8797.824043519126;8825.382223244376;8733.25767309773;8789;8865.601047952858;8870.689525866628;8872.73381798547;40782;41060.38409423861;41095.7945210275;41196.1760764786;41437.585624143976;3455.6371580983887;3561.1631266652316;3825.8087095645383;3879.1465877506903;3995.1011022519992;29744.36405997669;30116;30374.696253037408;30410;30475.542866857017;3232.3696879108584;3272.787268827519;3273.852676629557;3361.697447229761;3386.2211691311136;266515;266673;266836;266873;267608;57322.42677573171;58414.41585584175;59556.404435955956;68662.31337686659;69371.65314173397;61484;61943;62084.65407421527;62096.68951655303;62267;14452.855471445151;14636.341364638616;14677.192754398611;14722.55832325032;14734.263286835616;10766.354018758899;10817.296875703054;10818.621348252773;10931.344119352865;10946.397948112772;19876.304329348404;20582.691259631116;20614.175432982513;20633.690494642593;20798.168073277204;7349.816254593571;7582.658780354897;7632.389408847279;7689.231076892266;7692.461527693008;893.2496702769705;915.3775432705824;934.1685899549407;1048.5596049659162;1064.9627263045757;29313.56029659557;30553.23616909595;30800.845995770327;32316.515252271234;32621.51067733986;980.9362391444675;1010.7422607235255;1022.3967858963099;1041.3075304922293;1113.7939481196004;14251;14256.144631322153;14299;14534.127952322895;14564.85435145635;336994;343242;343919;344316;345025;52638.21042684363;52809.47190528122;53022;53110.73444632829;53125.73437132867;1293.4761421624257;1326.4362645875658;1326.6484381638872;1353.8646135386382;1358.551677946295;26881.327966800985;27543.449131016867;27916.44167116687;27984;28072.578911316756;46376.53623463722;46459.767701161276;46631.06737865156;46930;47186.52813471821;316018;318259;318301;318836;320655;31838.204044899063;32487.350252995282;32979.83510082434;33008.1747956303;33292.167695807795;40402.59597403988;42816.14367712691;44598.10803783971;44765.77617111894;45211.54788452205;33402.66597333996;36048.8197559021;36384.818075909454;36543.81728091343;36744.448833266986;36708.26583468369;36766.816165919;36869.44695829511;37078.629213707514;37134.8143259282;35118;36117.27765444729;36203;36295.45556816597;36349.636503634625;31820.5226921601;33284;33407.665923341425;33846.15384615404;33939.66060339464;25679.871600641876;26584.468310633292;26726.331841704112;26805.597916031664;26893.731062689905 06:12:09 INFO - 2015-11-12 06:12:09,536 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.17942194686384;356.7181926278237;356.819805997971;357.3567578358954;360.71503512225337;11323.490442930068;11606.477708503116;16605.916970415146;17164.91417542912;17928.19323130459;13368.064235503518;13391.330433478335;13485.39315730792;16679.83320166798;16874.325026998904;6130.172426722403;6303.086052522382;6329.430351268385;6501.577397469149;6502.837429064288;6398.3684160539;6449.290578036413;6464.095026696266;6654.700538475756;7008.123984501937;6249.531285153609;6517.837054073662;6518.771842985497;6975.2675969023285;7000.29997000301;6267.185265915402;6379.872402551946;6390.169277993878;6423.164988551505;6489.935100649028;6186.257649082139;6222.533310001768;6229.3459186785185;6229.719662615148;6443.613383197023;22208.222712204995;22636.207732729275;22971.655425168636;23021.884890575606;24094.759052409427;2139.9786002139936;2198.626233540302;2230.509287956647;2236.3402796175005;2508.4606809536035;13708.588742337746;13878.444862205499;14664;14702.338394772261;15093.094414335175;1942.630900128971;1949.561348696546;1963.990180049105;1977.980220197794;2018.2028098900998;69224;69228;70435;70923.29076709218;72388.63805680991;15918.442854500037;16295.674086518204;16305;16319.91840040816;16399;24386;24397.26808195757;24432.877835610707;24727.25818225456;24748.257552273462;8840.248578870867;8934.642614295486;8946.105389461001;8973.551322433852;8984.281257499384;7379.926200738031;7505.474616776883;7522.3605993491165;7553.848923021509;7558.093028836574;8023.7994050148045;8073.717419890276;8099.230573095547;8120.959395203105;8137.267645911778;1154.543955137716;1191.5591231244496;3147.826869522198;3219.6780321967617;3224.3081671486016;412.72966207134374;415.96880233982574;436.6637688979468;505.24970418927865;517;10520.526576304084;10728.570857165781;10848.294860834021;10998.890011099948;11015.724606884733;422.6111976981185;481.03552377483624;487.04296058245717;487.2301763214113;502.53515498164785;6286.685665716695;6499.642519661369;6556.4427023702565;6630.1380820494;6645.767398141139;543304;552459;555706;572508;578192;73159;74594.62702686452;76529;76961.61519192481;76968;544.0723566319416;549.4148731600752;551.0659432262357;551.4485514485515;552.0504731861192;10586.570812940154;10843.566257349934;10906.691197056403;11045.116390688565;11069.114470842153;32700.50949235716;32805.17987050343;33252.33495330031;34958.82520587381;35415.645843541235;25104.246872593852;25477.235682929542;25812.483750325264;40105.99735006648;47997.5200248007;14346.856531434552;14692.559223223321;14800.48198313054;14868.702625947637;15170.544883653509;19395.030248487237;19452.319168829024;19629.50926226856;20179.394618161477;20281.898590506953;9694.806103878023;9759.414435133915;10007.449590272605;10054.396736195851;10151.89848101539;9930.106290433896;10192.13366863825;10219.802742410417;10264.897351026395;10526.578936842441;10113.140383067228;10400.167986560906;10515.15878729715;10592.629257975934;10734.516946737573;15041.247937602857;15072.321745521258;15163.924180379028;15339.309731061905;15429;15542.84457155414;15605.843941560439;15834.445794397141;15870.60323491922;16205.75691364654 06:12:09 INFO - 2015-11-12 06:12:09,536 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1422.374155371637;1693.4327000454848;1735.4186347573561;1758.5515693498164;1774.9882566936847;7395.149557800854;7750.069991601016;7799.766007019784;7836.17720139385;7880.4089693272945;7822.8044298892555;7878.29095381417;7885.304659498207;7924.049114106316;7933.404994625412;2215.490437199441;2224.3104637562406;2239.9104035838627;2243.921462748804;2247.9438014049697;2262.061244583496;2263.7962583367494;2299.1033496936125;2302.458922153293;2308.0652335803943;2153.5154590217235;2222.1777942161343;2228.197848774448;2229.565234779219;2243.8990245438995;2213.612617791896;2236.552689462106;2271.159670921761;2273.602119629075;2279.4985103277254;2225.543763528473;2253.4479052632046;2254.0645632062674;2261.547690461914;2269.8184145268337;7338.15611204713;7441.962790186014;7456.217097204824;7470.47706660534;7485.214052524516;4345.065810850682;4413.977930110329;4419.359192917009;4441.067375851075;4455.04216593434;2987.521996480553;3001.294695746498;3053.923651908698;3074.9077527674203;3087.9073627791204;952.2239374909495;957.8036502516967;982.7690492734201;992.533509250651;993.3692105512979;10393.22050846182;10441.112505437048;10452.529636166315;10465.058144767008;10500.317479363817;3914.784686842251;3920.725549211528;3979.840806367713;3997.600239975979;4073.165001174752;8456.957715211507;8464;8514.403991720521;8520.233179013794;8529.061803201643;4516.909661806745;4533.52397998212;4541.2733962565835;4548.363229147922;4554.294084416921;4102.384642303678;4125.731827431207;4130;4139.958600413957;4143.02638879863;3464.5149679044953;3478.617352091268;3507.2459421224557;3507.316073365669;3521.2781379817075;1081.4376524207369;1081.534939975818;1086.3590481615884;1089.3518356577824;1095.917806164541;1018.0328687746522;1020.1125021231576;1064.3401091323274;1135.239389608964;1269.3082270162784;7005.824854378681;7133.785986420416;7139.785806425815;7140.892886606705;7143.321384468467;1029.5006921642996;1039.5789705169418;1049.3546468921559;1051.8527406163143;1051.9421431821324;5506.531944784738;5526.834194974157;5534.225208470817;5541.750621222055;5559.527440167631;8871.955640221757;8981.832361792925;8994.910050899407;9156.633734650673;9306.208972237435;9059.048799876049;9108.681196158102;9197.586108625128;9228.630854765868;9306.441613503212;7074.7170113195925;7135.821604459827;7181;7231.421486281085;7233.674484648203;6798.592084474947;6865.176178858569;6893.965530172317;6910.136232970879;6938.548994315353;7685.423593230418;7977.80055498594;8009.239122283374;8035.196480351918;8130.430869839054;8169.428140030141;8267.503949763033;8291.792705182419;8296.668133274601;8456.450330728483;6809.693563789542;6827;6851.486138539729;6899.827504312231;6973.651317434006;7457.366123879531;7502.174760776201;7530.209328020479;7532.284432978859;7540.773776786705;6925.342092501204;7082.2917708230825;7161.498695091502;7240.420766338786;7258.491905566771;6303.401176888188;6307.779227727007;6907.171139463297;6925.722971081101;7026.262242464468;7013.228544860163;7043.859122817413;7072.611006394698;7094.858102838018;7103.147622285359;6318.684065796784;6334.968325158345;6353.396427339396;6357.205349331333;6362.172917520693;6449;6492.870142597216;6500.382463665944;6501.967490162708;6511.186101737283 06:12:09 INFO - 2015-11-12 06:12:09,539 DEBUG : BROWSER_OUTPUT: |4;prototype.html;311.20797570183885;317.53164082977605;327.5125422416744;333.0757148911771;334.83258370814576;6071.180390647261;6073;6079.027355623101;6091.6345019298815;6150.323464418911;5965.642061476304;5966.67183304918;5990.281166260044;6040.30536488304;6053.303870054945;4538.364628951941;4540.59134677879;4543.4093567836135;4548.272276435771;4556.179887620227;4549.181147393468;4552.317152427129;4552.9089418211615;4565.269556870901;4570.588647021767;4443.577860103285;4490.3040028795585;4509.030558429937;4553.908921821561;4569.405977222957;4551.089782043605;4553.840615578439;4558.225101732697;4564.680472366936;4573.474050484204;3913.6086391360923;3915.4126880967797;3915.9216815663813;3927.6661483773914;3929.489166408377;5776.508996735282;5782.710864456761;5784.623999440065;5789.334226563957;5793.594448388614;5142.04872098663;5224.529792318672;5234;5264.210368444726;5277.102892508283;6228.065790131472;6312.558120931537;6320.178376810985;6324.7470101195895;6331.303556608769;4297.978510107429;4305.074409002048;4313.115811258715;4326.134773045404;4326.545712700153;6431.389018043325;6507;6561.3438656134485;6563.770268040644;6576.04647326135;4420.336949457543;4471.32930060487;4473.955260447354;4480.439945006874;4482.9775851121185;4515.367848501212;4520.796564154621;4533.455985281787;4539.6368290536675;4540.318952157203;5258.158694608845;5260.92108618371;5261.210818377274;5267.868303292448;5278.81524146653;6293.96853015732;6417.647029413333;6428.100065990765;6429.260635026938;6443.130177425987;1608.4692051622937;1611.9032858028556;1635.255958538862;1650.3893559383105;1650.5543503254055;1109.755853712182;1121.3272036777869;1121.545773961547;1129.8079326514512;1137.5449820072038;6044;6048.274207095177;6091.604045737013;6096.237970253718;6112;6423.743050277936;6444.516661250425;6446.226452825597;6452.322506136882;6469.514786390945;6049.274087109487;6154.78458253959;6155.353687862799;6158.938410615837;6160.8767824643255;3659.0852286928266;3680.0431887709387;3682.5580930288;3684.521012268388;3688.5942546319884;6790.626515541594;6795.626240556817;6805.591664500146;6827.078344423439;6830.043793868862;6617.569857959217;6624.470042396597;6629.966850165815;6662.367075127855;6695.230048544382;6713.12729345182;6758.526903116833;6815.965920170466;6830.93169068303;6844.5208835382045;6583.8478266302245;6591.373819487141;6596.90104648421;6598.3401659833635;6617.371349721769;6424.51816113784;6513.348665133449;6518.902216466851;6532.640704761284;6551.541392102507;6827.52207345481;6829;6839.589624622538;6849.965750171217;6853.0405743195;4388.495323037764;4439.045605194899;4442.977785111054;4448.955510444855;4471.0610771737;6489.091527186103;6606.8017959461295;6662.600243985376;6663.200415950117;6691.76578819739;6379.840503987438;6397.424231819158;6400.359964003563;6402.03969404593;6403.871922561616;6331.113644089924;6356.269029061532;6395.072714456284;6395.360463953567;6418.871622567616;6172.598781079216;6290.779822706183;6296.118543403835;6311.873762524816;6312.4634406074165;6377.681115944277;6429.7106630200815;6457.225132983884;6547.1161393211305;6551.148350714377;6365.745370185326;6390.233172019387;6391.296957334596;6397.712102955471;6404.135441715309 06:12:09 INFO - 2015-11-12 06:12:09,541 DEBUG : BROWSER_OUTPUT: |5;yui.html;859.965601375945;861.7242482405633;862.2153840005594;877.0527829943661;880.9339299552535;13768;13999.580012599612;14143.929280353597;14179.149251044944;14207.92896035521;13037.73924521509;13129.934350328258;13158.671033224175;13214.669633259173;13904.93047534761;803.6704950970103;821.0434843407453;822.5106061893164;822.8436597046542;825.5995842016617;814.9714759983402;820.2207902492626;821.8602837517607;822.1737154160061;822.4941660878546;856.1353033436212;863.4991704811194;868.3227082875336;870.2820173356974;871.6208449324564;861.0313397427893;866.9653213871501;867.5228624256665;867.5792240763225;869.1959937058227;623.7847942459844;627.1940556385069;627.7771391156165;627.8116565030518;629.9968500157515;11880.465379057876;11927.224730392496;11967.64097077089;11968.162228643998;12012.69968250792;10913.39976301303;11106.722331941766;11223.607173748962;11248.887511124947;11250.943745281304;8812.16284452976;8950.68672596456;8978;9017.684381046698;9048.230900373475;3300.9834950825093;3378.45944648855;3386.204242003127;3400.064982129934;3470.819921226795;44018.779906100266;45178.09643807106;46439.76780116111;46658.30012549781;47725.284120738215;6883.724651013903;6959.582425054513;6998.265182155902;7024.964875175591;7170.175429825533;11632.709182270512;11634.6509604712;11639.06887449002;11660.533578656929;11704.70738231551;6632.8673426531195;6761.695723692445;6766.221884483249;6786.355296246848;6951.582905025714;4110.34234522475;4118.608732170439;4188.937165942452;4193.30810416284;4239.40648309237;2859.828410295389;2874.8993785217417;2877.784166187544;2883.308006078568;2904.288449329885;439.16558538775945;443.0629219201366;455.28292938621803;455.38522993958554;455.7561704488083;662.5825729790298;668.8296477929151;677.9796606101726;681.2266045266329;705.8164877131983;8839.204471597586;9157.084291570789;9223.53882305882;9245.72262832116;9324.347295689373;557.768526061688;590.8345663214307;644.8097811145723;678.5657179405086;681.6966449929832;4072.6741860651077;4140.710150289511;4158.147579746144;4190.287651099259;4208.726432781859;54094;63198.684006580595;63482;63543;63576.68211658912;51858.22212666813;52604.736976314874;53573.196402054;53642.19536706952;54400.45599544033;45536.544634553895;46001.53998460039;47460.288095678596;47838.76080619644;48340.758296208296;8519.23326900582;8807.823843523222;8956.328275379503;9151.61860270109;9409.482478463477;36413.63586364102;36506.26987460289;36733.81633091818;38650.42024369693;38748.80625596967;47393.52606474029;47624.28563571619;48436.273455898896;48511.51488485211;48714.26928596145;7509.812254693677;7860.449768516149;7902.841943161219;8068.47554908929;8123.959380203298;11805.704857378634;11848.466818992994;11891.227070240408;11910.464029118537;11991.280523168289;10751.677449676523;10978.286411383235;11033.83449248278;11161.553537858395;11439.656810295704;11047.944760276147;11465.31208127515;11910.940445297718;11915.165938384576;11990.940045299718;10948.616798412337;11297.209195356247;11452.255603385753;11725.530978760755;11890.46492907804;9776.462294573867;9885.604575816888;10020.34867733595;10043.89956100459;10212.540435680263;8872.600732967161;8935.553222338987;8970.41692289999;9204.631814727603;9494.667686630935 06:12:09 INFO - 2015-11-12 06:12:09,541 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:12:09 INFO - 2015-11-12 06:12:09,541 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:12:09 INFO - 2015-11-12 06:12:09,541 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,284 06:12:09 INFO - 2015-11-12 06:12:09,541 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:12:09 INFO - 2015-11-12 06:12:09,541 DEBUG : BROWSER_OUTPUT: __startTimestamp1447337529528__endTimestamp 06:12:09 INFO - 2015-11-12 06:12:09,541 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-12 06:12:09,541 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:12:09 INFO - 2015-11-12 06:12:09,541 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:12:09 INFO - 2015-11-12 06:12:09,542 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-12 06:12:09,542 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5397.76 Median:5555.94 stddev:596.19 (10.7%) stddev-sans-first:572.45 06:12:09 INFO - 2015-11-12 06:12:09,543 DEBUG : BROWSER_OUTPUT: Values: 3195.7 3231.1 3241.0 3274.8 3280.2 5199.2 5431.9 5434.5 5445.7 5453.6 5300.3 5337.3 5366.6 5453.3 5472.9 4963.6 4970.3 5041.7 5064.9 5103.6 4983.6 5049.0 5091.8 5106.2 5111.7 4819.1 4863.2 4926.9 4943.4 5024.6 4918.1 4948.2 4962.5 4987.9 4989.1 4685.3 4930.5 4938.3 4949.5 4994.4 5186.5 5199.6 5206.6 5225.5 5259.7 5844.5 5852.7 5898.0 5917.8 5923.8 5697.8 5782.3 5882.6 5891.9 5918.7 5413.0 5474.8 5476.9 5491.6 5555.9 5939.2 5962.5 5969.6 5980.2 5989.9 5515.6 5600.5 5635.9 5772.4 5804.3 5628.5 5702.2 5711.6 5721.7 5761.0 5760.9 5803.7 5817.1 5822.0 5833.5 5633.5 5745.2 5796.1 5802.8 5832.9 4464.4 4480.3 4492.7 4515.4 4517.2 4000.7 4002.7 4019.7 4022.3 4030.6 5322.6 5403.6 5441.6 5550.7 5568.0 5814.1 5817.0 5829.8 5838.6 5927.3 5536.8 5545.9 5546.2 5555.0 5557.5 4875.7 4955.3 4969.0 5021.9 5078.0 6102.5 6128.8 6140.6 6171.5 6172.0 5557.0 5910.4 5938.0 5949.9 5961.6 5851.5 5890.5 5891.5 5896.4 5908.2 5644.7 5691.9 5824.4 5832.3 5876.8 5774.6 5824.7 5833.8 5835.5 5848.8 5527.1 5664.6 5695.5 5700.9 5709.8 5511.8 5554.4 5579.2 5592.1 5620.3 5500.1 5527.3 5530.5 5539.8 5540.1 5533.9 5600.5 5619.7 5666.6 5704.5 5591.3 5685.5 5698.7 5702.3 5747.1 06:12:09 INFO - 2015-11-12 06:12:09,543 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-12 06:12:09,543 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48200.81 Median:36464.32 stddev:81422.24 (223.3%) stddev-sans-first:81572.03 06:12:09 INFO - 2015-11-12 06:12:09,543 DEBUG : BROWSER_OUTPUT: Values: 544.8 600.6 600.9 608.5 608.8 40078.2 41008.4 41055.0 41105.6 41213.6 43740.6 44010.3 44227.0 44276.6 44384.8 8766.3 8793.8 8865.2 8875.9 8912.0 8649.4 8749.7 8750.6 8756.1 8759.7 8720.5 8784.0 8792.4 8851.8 8866.3 8729.6 8745.3 8758.2 8797.8 8825.4 8733.3 8789.0 8865.6 8870.7 8872.7 40782.0 41060.4 41095.8 41196.2 41437.6 3455.6 3561.2 3825.8 3879.1 3995.1 29744.4 30116.0 30374.7 30410.0 30475.5 3232.4 3272.8 3273.9 3361.7 3386.2 266515.0 266673.0 266836.0 266873.0 267608.0 57322.4 58414.4 59556.4 68662.3 69371.7 61484.0 61943.0 62084.7 62096.7 62267.0 14452.9 14636.3 14677.2 14722.6 14734.3 10766.4 10817.3 10818.6 10931.3 10946.4 19876.3 20582.7 20614.2 20633.7 20798.2 7349.8 7582.7 7632.4 7689.2 7692.5 893.2 915.4 934.2 1048.6 1065.0 29313.6 30553.2 30800.8 32316.5 32621.5 980.9 1010.7 1022.4 1041.3 1113.8 14251.0 14256.1 14299.0 14534.1 14564.9 336994.0 343242.0 343919.0 344316.0 345025.0 52638.2 52809.5 53022.0 53110.7 53125.7 1293.5 1326.4 1326.6 1353.9 1358.6 26881.3 27543.4 27916.4 27984.0 28072.6 46376.5 46459.8 46631.1 46930.0 47186.5 316018.0 318259.0 318301.0 318836.0 320655.0 31838.2 32487.4 32979.8 33008.2 33292.2 40402.6 42816.1 44598.1 44765.8 45211.5 33402.7 36048.8 36384.8 36543.8 36744.4 36708.3 36766.8 36869.4 37078.6 37134.8 35118.0 36117.3 36203.0 36295.5 36349.6 31820.5 33284.0 33407.7 33846.2 33939.7 25679.9 26584.5 26726.3 26805.6 26893.7 06:12:09 INFO - 2015-11-12 06:12:09,543 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-12 06:12:09,543 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29744.62 Median:32752.84 stddev:91476.34 (279.3%) stddev-sans-first:91706.33 06:12:09 INFO - 2015-11-12 06:12:09,543 DEBUG : BROWSER_OUTPUT: Values: 352.2 356.7 356.8 357.4 360.7 11323.5 11606.5 16605.9 17164.9 17928.2 13368.1 13391.3 13485.4 16679.8 16874.3 6130.2 6303.1 6329.4 6501.6 6502.8 6398.4 6449.3 6464.1 6654.7 7008.1 6249.5 6517.8 6518.8 6975.3 7000.3 6267.2 6379.9 6390.2 6423.2 6489.9 6186.3 6222.5 6229.3 6229.7 6443.6 22208.2 22636.2 22971.7 23021.9 24094.8 2140.0 2198.6 2230.5 2236.3 2508.5 13708.6 13878.4 14664.0 14702.3 15093.1 1942.6 1949.6 1964.0 1978.0 2018.2 69224.0 69228.0 70435.0 70923.3 72388.6 15918.4 16295.7 16305.0 16319.9 16399.0 24386.0 24397.3 24432.9 24727.3 24748.3 8840.2 8934.6 8946.1 8973.6 8984.3 7379.9 7505.5 7522.4 7553.8 7558.1 8023.8 8073.7 8099.2 8121.0 8137.3 1154.5 1191.6 3147.8 3219.7 3224.3 412.7 416.0 436.7 505.2 517.0 10520.5 10728.6 10848.3 10998.9 11015.7 422.6 481.0 487.0 487.2 502.5 6286.7 6499.6 6556.4 6630.1 6645.8 543304.0 552459.0 555706.0 572508.0 578192.0 73159.0 74594.6 76529.0 76961.6 76968.0 544.1 549.4 551.1 551.4 552.1 10586.6 10843.6 10906.7 11045.1 11069.1 32700.5 32805.2 33252.3 34958.8 35415.6 25104.2 25477.2 25812.5 40106.0 47997.5 14346.9 14692.6 14800.5 14868.7 15170.5 19395.0 19452.3 19629.5 20179.4 20281.9 9694.8 9759.4 10007.4 10054.4 10151.9 9930.1 10192.1 10219.8 10264.9 10526.6 10113.1 10400.2 10515.2 10592.6 10734.5 15041.2 15072.3 15163.9 15339.3 15429.0 15542.8 15605.8 15834.4 15870.6 16205.8 06:12:09 INFO - 2015-11-12 06:12:09,544 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-12 06:12:09,544 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5334.81 Median:6359.69 stddev:2755.47 (43.3%) stddev-sans-first:2747.50 06:12:09 INFO - 2015-11-12 06:12:09,545 DEBUG : BROWSER_OUTPUT: Values: 1422.4 1693.4 1735.4 1758.6 1775.0 7395.1 7750.1 7799.8 7836.2 7880.4 7822.8 7878.3 7885.3 7924.0 7933.4 2215.5 2224.3 2239.9 2243.9 2247.9 2262.1 2263.8 2299.1 2302.5 2308.1 2153.5 2222.2 2228.2 2229.6 2243.9 2213.6 2236.6 2271.2 2273.6 2279.5 2225.5 2253.4 2254.1 2261.5 2269.8 7338.2 7442.0 7456.2 7470.5 7485.2 4345.1 4414.0 4419.4 4441.1 4455.0 2987.5 3001.3 3053.9 3074.9 3087.9 952.2 957.8 982.8 992.5 993.4 10393.2 10441.1 10452.5 10465.1 10500.3 3914.8 3920.7 3979.8 3997.6 4073.2 8457.0 8464.0 8514.4 8520.2 8529.1 4516.9 4533.5 4541.3 4548.4 4554.3 4102.4 4125.7 4130.0 4140.0 4143.0 3464.5 3478.6 3507.2 3507.3 3521.3 1081.4 1081.5 1086.4 1089.4 1095.9 1018.0 1020.1 1064.3 1135.2 1269.3 7005.8 7133.8 7139.8 7140.9 7143.3 1029.5 1039.6 1049.4 1051.9 1051.9 5506.5 5526.8 5534.2 5541.8 5559.5 8872.0 8981.8 8994.9 9156.6 9306.2 9059.0 9108.7 9197.6 9228.6 9306.4 7074.7 7135.8 7181.0 7231.4 7233.7 6798.6 6865.2 6894.0 6910.1 6938.5 7685.4 7977.8 8009.2 8035.2 8130.4 8169.4 8267.5 8291.8 8296.7 8456.5 6809.7 6827.0 6851.5 6899.8 6973.7 7457.4 7502.2 7530.2 7532.3 7540.8 6925.3 7082.3 7161.5 7240.4 7258.5 6303.4 6307.8 6907.2 6925.7 7026.3 7013.2 7043.9 7072.6 7094.9 7103.1 6318.7 6335.0 6353.4 6357.2 6362.2 6449.0 6492.9 6500.4 6502.0 6511.2 06:12:09 INFO - 2015-11-12 06:12:09,545 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-12 06:12:09,545 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5322.40 Median:6085.32 stddev:1608.95 (26.4%) stddev-sans-first:1568.88 06:12:09 INFO - 2015-11-12 06:12:09,545 DEBUG : BROWSER_OUTPUT: Values: 311.2 317.5 327.5 333.1 334.8 6071.2 6073.0 6079.0 6091.6 6150.3 5965.6 5966.7 5990.3 6040.3 6053.3 4538.4 4540.6 4543.4 4548.3 4556.2 4549.2 4552.3 4552.9 4565.3 4570.6 4443.6 4490.3 4509.0 4553.9 4569.4 4551.1 4553.8 4558.2 4564.7 4573.5 3913.6 3915.4 3915.9 3927.7 3929.5 5776.5 5782.7 5784.6 5789.3 5793.6 5142.0 5224.5 5234.0 5264.2 5277.1 6228.1 6312.6 6320.2 6324.7 6331.3 4298.0 4305.1 4313.1 4326.1 4326.5 6431.4 6507.0 6561.3 6563.8 6576.0 4420.3 4471.3 4474.0 4480.4 4483.0 4515.4 4520.8 4533.5 4539.6 4540.3 5258.2 5260.9 5261.2 5267.9 5278.8 6294.0 6417.6 6428.1 6429.3 6443.1 1608.5 1611.9 1635.3 1650.4 1650.6 1109.8 1121.3 1121.5 1129.8 1137.5 6044.0 6048.3 6091.6 6096.2 6112.0 6423.7 6444.5 6446.2 6452.3 6469.5 6049.3 6154.8 6155.4 6158.9 6160.9 3659.1 3680.0 3682.6 3684.5 3688.6 6790.6 6795.6 6805.6 6827.1 6830.0 6617.6 6624.5 6630.0 6662.4 6695.2 6713.1 6758.5 6816.0 6830.9 6844.5 6583.8 6591.4 6596.9 6598.3 6617.4 6424.5 6513.3 6518.9 6532.6 6551.5 6827.5 6829.0 6839.6 6850.0 6853.0 4388.5 4439.0 4443.0 4449.0 4471.1 6489.1 6606.8 6662.6 6663.2 6691.8 6379.8 6397.4 6400.4 6402.0 6403.9 6331.1 6356.3 6395.1 6395.4 6418.9 6172.6 6290.8 6296.1 6311.9 6312.5 6377.7 6429.7 6457.2 6547.1 6551.1 6365.7 6390.2 6391.3 6397.7 6404.1 06:12:09 INFO - 2015-11-12 06:12:09,545 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-12 06:12:09,545 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13629.06 Median:48473.89 stddev:16675.12 (34.4%) stddev-sans-first:16694.33 06:12:09 INFO - 2015-11-12 06:12:09,545 DEBUG : BROWSER_OUTPUT: Values: 860.0 861.7 862.2 877.1 880.9 13768.0 13999.6 14143.9 14179.1 14207.9 13037.7 13129.9 13158.7 13214.7 13904.9 803.7 821.0 822.5 822.8 825.6 815.0 820.2 821.9 822.2 822.5 856.1 863.5 868.3 870.3 871.6 861.0 867.0 867.5 867.6 869.2 623.8 627.2 627.8 627.8 630.0 11880.5 11927.2 11967.6 11968.2 12012.7 10913.4 11106.7 11223.6 11248.9 11250.9 8812.2 8950.7 8978.0 9017.7 9048.2 3301.0 3378.5 3386.2 3400.1 3470.8 44018.8 45178.1 46439.8 46658.3 47725.3 6883.7 6959.6 6998.3 7025.0 7170.2 11632.7 11634.7 11639.1 11660.5 11704.7 6632.9 6761.7 6766.2 6786.4 6951.6 4110.3 4118.6 4188.9 4193.3 4239.4 2859.8 2874.9 2877.8 2883.3 2904.3 439.2 443.1 455.3 455.4 455.8 662.6 668.8 678.0 681.2 705.8 8839.2 9157.1 9223.5 9245.7 9324.3 557.8 590.8 644.8 678.6 681.7 4072.7 4140.7 4158.1 4190.3 4208.7 54094.0 63198.7 63482.0 63543.0 63576.7 51858.2 52604.7 53573.2 53642.2 54400.5 45536.5 46001.5 47460.3 47838.8 48340.8 8519.2 8807.8 8956.3 9151.6 9409.5 36413.6 36506.3 36733.8 38650.4 38748.8 47393.5 47624.3 48436.3 48511.5 48714.3 7509.8 7860.4 7902.8 8068.5 8124.0 11805.7 11848.5 11891.2 11910.5 11991.3 10751.7 10978.3 11033.8 11161.6 11439.7 11047.9 11465.3 11910.9 11915.2 11990.9 10948.6 11297.2 11452.3 11725.5 11890.5 9776.5 9885.6 10020.3 10043.9 10212.5 8872.6 8935.6 8970.4 9204.6 9494.7 06:12:09 INFO - 2015-11-12 06:12:09,547 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:12:09 INFO - 2015-11-12 06:12:09,547 DEBUG : BROWSER_OUTPUT: 06:12:10 INFO - 2015-11-12 06:12:10,273 INFO : Browser exited with error code: 0 06:12:10 INFO - 2015-11-12 06:12:10,292 INFO : Completed test dromaeo_css (00:18:37) 06:12:10 INFO - 2015-11-12 06:12:10,292 INFO : Starting test kraken 06:12:10 INFO - 2015-11-12 06:12:10,292 DEBUG : operating with platform_type : linux_ 06:12:10 INFO - 2015-11-12 06:12:10,292 INFO : Initialising browser for kraken test... 06:12:10 INFO - 2015-11-12 06:12:10,299 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxPvGEI/profile http://localhost:34808/getInfo.html 06:12:15 INFO - 2015-11-12 06:12:15,818 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:12:15 INFO - 2015-11-12 06:12:15,818 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:12:15 INFO - 2015-11-12 06:12:15,818 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:12:15 INFO - 2015-11-12 06:12:15,818 DEBUG : BROWSER_OUTPUT: __metrics 06:12:17 INFO - 2015-11-12 06:12:17,033 INFO : Browser initialized. 06:12:17 INFO - 2015-11-12 06:12:17,034 INFO : Running cycle 1/1 for kraken test... 06:12:17 INFO - 2015-11-12 06:12:17,034 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxPvGEI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:12:28 INFO - 2015-11-12 06:12:28,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 140742656 06:12:28 INFO - 2015-11-12 06:12:28,789 DEBUG : BROWSER_OUTPUT: 06:12:31 INFO - 2015-11-12 06:12:31,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34808/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:31 INFO - 2015-11-12 06:12:31,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 140546048 06:12:31 INFO - 2015-11-12 06:12:31,862 DEBUG : BROWSER_OUTPUT: 06:12:34 INFO - 2015-11-12 06:12:34,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34808/tests/kraken/driver.html?testName=audio-dft) 06:12:35 INFO - 2015-11-12 06:12:35,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 141107200 06:12:35 INFO - 2015-11-12 06:12:35,076 DEBUG : BROWSER_OUTPUT: 06:12:37 INFO - 2015-11-12 06:12:37,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34808/tests/kraken/driver.html?testName=audio-fft) 06:12:38 INFO - 2015-11-12 06:12:38,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 136609792 06:12:38 INFO - 2015-11-12 06:12:38,524 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2015-11-12 06:12:40,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34808/tests/kraken/driver.html?testName=audio-oscillator) 06:12:41 INFO - 2015-11-12 06:12:41,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 135856128 06:12:41 INFO - 2015-11-12 06:12:41,172 DEBUG : BROWSER_OUTPUT: 06:12:43 INFO - 2015-11-12 06:12:43,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34808/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:43 INFO - 2015-11-12 06:12:43,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 136585216 06:12:43 INFO - 2015-11-12 06:12:43,932 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-12 06:12:46,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34808/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:47 INFO - 2015-11-12 06:12:47,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 136937472 06:12:47 INFO - 2015-11-12 06:12:47,506 DEBUG : BROWSER_OUTPUT: 06:12:50 INFO - 2015-11-12 06:12:50,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34808/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:51 INFO - 2015-11-12 06:12:51,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 138309632 06:12:51 INFO - 2015-11-12 06:12:51,496 DEBUG : BROWSER_OUTPUT: 06:12:54 INFO - 2015-11-12 06:12:54,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34808/tests/kraken/driver.html?testName=json-parse-financial) 06:12:54 INFO - 2015-11-12 06:12:54,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 138440704 06:12:54 INFO - 2015-11-12 06:12:54,900 DEBUG : BROWSER_OUTPUT: 06:12:56 INFO - 2015-11-12 06:12:56,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34808/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:57 INFO - 2015-11-12 06:12:57,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 138526720 06:12:57 INFO - 2015-11-12 06:12:57,056 DEBUG : BROWSER_OUTPUT: 06:12:58 INFO - 2015-11-12 06:12:58,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34808/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:59 INFO - 2015-11-12 06:12:59,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 138330112 06:12:59 INFO - 2015-11-12 06:12:59,465 DEBUG : BROWSER_OUTPUT: 06:13:01 INFO - 2015-11-12 06:13:01,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34808/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:02 INFO - 2015-11-12 06:13:02,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 138944512 06:13:02 INFO - 2015-11-12 06:13:02,150 DEBUG : BROWSER_OUTPUT: 06:13:04 INFO - 2015-11-12 06:13:04,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:05 INFO - 2015-11-12 06:13:05,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 138899456 06:13:05 INFO - 2015-11-12 06:13:05,224 DEBUG : BROWSER_OUTPUT: 06:13:07 INFO - 2015-11-12 06:13:07,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:08 INFO - 2015-11-12 06:13:08,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 139632640 06:13:08 INFO - 2015-11-12 06:13:08,398 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34808/tests/kraken/driver.html?testName=ai-astar) 06:13:10 INFO - 2015-11-12 06:13:10,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 138358784 06:13:10 INFO - 2015-11-12 06:13:10,345 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,345 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:13:10 INFO - 2015-11-12 06:13:10,345 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:13:10 INFO - 2015-11-12 06:13:10,345 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:13:10 INFO - 2015-11-12 06:13:10,345 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:13:10 INFO - 2015-11-12 06:13:10,345 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;103;113;110;111;123;110;110;109;110 06:13:10 INFO - 2015-11-12 06:13:10,345 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;126;149;163;125;159;155;125;162;139 06:13:10 INFO - 2015-11-12 06:13:10,345 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;165;162;165;162;163;162;165;175;163 06:13:10 INFO - 2015-11-12 06:13:10,345 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;74;72;73;72;71;147;72;72;72 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;89;131;91;89;91;129;91;91;131 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;111;111;111;111;110;111;111;110;110 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;151;147;146;146;146;147;146;147;146;147 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;96;97;97;98;97;97;97;96 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;62;62;64;62;63;62;62;60;61 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;68;66;67;67;66;68;67 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;86;93;86;94;86;86;94;86 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;124;122;125;124;119;118;125;125;124 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;153;149;149;152;141;152;157;149;145 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;72;71;73;65;66;66;66;67 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,725 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:13:10 INFO - 2015-11-12 06:13:10,346 DEBUG : BROWSER_OUTPUT: __startTimestamp1447337590340__endTimestamp 06:13:10 INFO - 2015-11-12 06:13:10,347 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,348 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:13:10 INFO - 2015-11-12 06:13:10,348 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:13:10 INFO - 2015-11-12 06:13:10,348 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,348 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:110.50 stddev:4.95 (4.5%) stddev-sans-first:5.24 06:13:10 INFO - 2015-11-12 06:13:10,348 DEBUG : BROWSER_OUTPUT: Values: 112.0 103.0 113.0 110.0 111.0 123.0 110.0 110.0 109.0 110.0 06:13:10 INFO - 2015-11-12 06:13:10,348 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,348 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.30 Median:152.50 stddev:15.44 (10.1%) stddev-sans-first:16.28 06:13:10 INFO - 2015-11-12 06:13:10,348 DEBUG : BROWSER_OUTPUT: Values: 150.0 126.0 149.0 163.0 125.0 159.0 155.0 125.0 162.0 139.0 06:13:10 INFO - 2015-11-12 06:13:10,348 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,349 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:4.03 (2.5%) stddev-sans-first:4.09 06:13:10 INFO - 2015-11-12 06:13:10,349 DEBUG : BROWSER_OUTPUT: Values: 161.0 165.0 162.0 165.0 162.0 163.0 162.0 165.0 175.0 163.0 06:13:10 INFO - 2015-11-12 06:13:10,349 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,349 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:72.00 stddev:23.70 (32.9%) stddev-sans-first:24.93 06:13:10 INFO - 2015-11-12 06:13:10,349 DEBUG : BROWSER_OUTPUT: Values: 71.0 74.0 72.0 73.0 72.0 71.0 147.0 72.0 72.0 72.0 06:13:10 INFO - 2015-11-12 06:13:10,349 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,350 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.40 Median:91.00 stddev:19.30 (21.2%) stddev-sans-first:20.02 06:13:10 INFO - 2015-11-12 06:13:10,350 DEBUG : BROWSER_OUTPUT: Values: 91.0 89.0 131.0 91.0 89.0 91.0 129.0 91.0 91.0 131.0 06:13:10 INFO - 2015-11-12 06:13:10,350 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,350 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.70 Median:111.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:13:10 INFO - 2015-11-12 06:13:10,350 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 111.0 111.0 111.0 110.0 111.0 111.0 110.0 110.0 06:13:10 INFO - 2015-11-12 06:13:10,350 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,351 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.52 (1.0%) stddev-sans-first:0.53 06:13:10 INFO - 2015-11-12 06:13:10,351 DEBUG : BROWSER_OUTPUT: Values: 151.0 147.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 06:13:10 INFO - 2015-11-12 06:13:10,351 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,351 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:13:10 INFO - 2015-11-12 06:13:10,351 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 96.0 97.0 97.0 98.0 97.0 97.0 97.0 96.0 06:13:10 INFO - 2015-11-12 06:13:10,351 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,351 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:1.05 (1.7%) stddev-sans-first:1.12 06:13:10 INFO - 2015-11-12 06:13:10,352 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 62.0 64.0 62.0 63.0 62.0 62.0 60.0 61.0 06:13:10 INFO - 2015-11-12 06:13:10,352 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,352 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 06:13:10 INFO - 2015-11-12 06:13:10,352 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 68.0 66.0 67.0 67.0 66.0 68.0 67.0 06:13:10 INFO - 2015-11-12 06:13:10,352 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,352 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:86.00 stddev:3.90 (4.5%) stddev-sans-first:3.84 06:13:10 INFO - 2015-11-12 06:13:10,352 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 86.0 93.0 86.0 94.0 86.0 86.0 94.0 86.0 06:13:10 INFO - 2015-11-12 06:13:10,352 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,352 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.50 stddev:2.70 (2.2%) stddev-sans-first:2.67 06:13:10 INFO - 2015-11-12 06:13:10,352 DEBUG : BROWSER_OUTPUT: Values: 126.0 124.0 122.0 125.0 124.0 119.0 118.0 125.0 125.0 124.0 06:13:10 INFO - 2015-11-12 06:13:10,353 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,353 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:150.50 stddev:5.54 (3.7%) stddev-sans-first:4.66 06:13:10 INFO - 2015-11-12 06:13:10,353 DEBUG : BROWSER_OUTPUT: Values: 139.0 153.0 149.0 149.0 152.0 141.0 152.0 157.0 149.0 145.0 06:13:10 INFO - 2015-11-12 06:13:10,353 DEBUG : BROWSER_OUTPUT: 06:13:10 INFO - 2015-11-12 06:13:10,353 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.50 stddev:2.85 (4.2%) stddev-sans-first:3.02 06:13:10 INFO - 2015-11-12 06:13:10,353 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 72.0 71.0 73.0 65.0 66.0 66.0 66.0 67.0 06:13:10 INFO - 2015-11-12 06:13:10,353 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:13:10 INFO - 2015-11-12 06:13:10,353 DEBUG : BROWSER_OUTPUT: 06:13:11 INFO - 2015-11-12 06:13:11,209 INFO : Browser exited with error code: 0 06:13:11 INFO - 2015-11-12 06:13:11,260 INFO : Completed test kraken (00:01:00) 06:13:11 INFO - 2015-11-12 06:13:11,260 INFO : Starting test v8_7 06:13:11 INFO - 2015-11-12 06:13:11,260 DEBUG : operating with platform_type : linux_ 06:13:11 INFO - 2015-11-12 06:13:11,260 INFO : Initialising browser for v8_7 test... 06:13:11 INFO - 2015-11-12 06:13:11,266 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeHVU6q/profile http://localhost:34808/getInfo.html 06:13:16 INFO - 2015-11-12 06:13:16,701 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:13:16 INFO - 2015-11-12 06:13:16,701 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:13:16 INFO - 2015-11-12 06:13:16,702 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:13:16 INFO - 2015-11-12 06:13:16,702 DEBUG : BROWSER_OUTPUT: __metrics 06:13:17 INFO - 2015-11-12 06:13:17,945 INFO : Browser initialized. 06:13:17 INFO - 2015-11-12 06:13:17,946 INFO : Running cycle 1/1 for v8_7 test... 06:13:17 INFO - 2015-11-12 06:13:17,946 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeHVU6q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:13:29 INFO - 2015-11-12 06:13:29,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 140828672 06:13:29 INFO - 2015-11-12 06:13:29,648 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34808/tests/v8_7/run.html (next: http://localhost:34808/tests/v8_7/run.html) 06:13:51 INFO - 2015-11-12 06:13:51,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 138088448 06:13:51 INFO - 2015-11-12 06:13:51,306 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,307 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:13:51 INFO - 2015-11-12 06:13:51,307 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:13:51 INFO - 2015-11-12 06:13:51,307 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:13:51 INFO - 2015-11-12 06:13:51,308 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:13:51 INFO - 2015-11-12 06:13:51,308 DEBUG : BROWSER_OUTPUT: |0;Richards;163.21201240411295 06:13:51 INFO - 2015-11-12 06:13:51,308 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.8281220026856 06:13:51 INFO - 2015-11-12 06:13:51,308 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.5315315315315 06:13:51 INFO - 2015-11-12 06:13:51,308 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 06:13:51 INFO - 2015-11-12 06:13:51,308 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1055.9662090813094 06:13:51 INFO - 2015-11-12 06:13:51,308 DEBUG : BROWSER_OUTPUT: |5;Earley;708.4217975937721 06:13:51 INFO - 2015-11-12 06:13:51,309 DEBUG : BROWSER_OUTPUT: |6;Boyer;11651.162790697674 06:13:51 INFO - 2015-11-12 06:13:51,309 DEBUG : BROWSER_OUTPUT: |7;RegExp;24926.829268292684 06:13:51 INFO - 2015-11-12 06:13:51,309 DEBUG : BROWSER_OUTPUT: |8;Splay;637.7551020408164 06:13:51 INFO - 2015-11-12 06:13:51,309 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 06:13:51 INFO - 2015-11-12 06:13:51,309 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:13:51 INFO - 2015-11-12 06:13:51,310 DEBUG : BROWSER_OUTPUT: __startTimestamp1447337631306__endTimestamp 06:13:51 INFO - 2015-11-12 06:13:51,310 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,310 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:13:51 INFO - 2015-11-12 06:13:51,310 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:13:51 INFO - 2015-11-12 06:13:51,310 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,311 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.21 Median:163.21 stddev:0.00 (0.0%) 06:13:51 INFO - 2015-11-12 06:13:51,311 DEBUG : BROWSER_OUTPUT: Values: 163.2 06:13:51 INFO - 2015-11-12 06:13:51,311 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,311 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.83 Median:191.83 stddev:0.00 (0.0%) 06:13:51 INFO - 2015-11-12 06:13:51,311 DEBUG : BROWSER_OUTPUT: Values: 191.8 06:13:51 INFO - 2015-11-12 06:13:51,311 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,312 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.53 Median:281.53 stddev:0.00 (0.0%) 06:13:51 INFO - 2015-11-12 06:13:51,312 DEBUG : BROWSER_OUTPUT: Values: 281.5 06:13:51 INFO - 2015-11-12 06:13:51,312 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,312 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 06:13:51 INFO - 2015-11-12 06:13:51,313 DEBUG : BROWSER_OUTPUT: Values: 5040.2 06:13:51 INFO - 2015-11-12 06:13:51,314 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,314 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 06:13:51 INFO - 2015-11-12 06:13:51,314 DEBUG : BROWSER_OUTPUT: Values: 1056.0 06:13:51 INFO - 2015-11-12 06:13:51,314 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,314 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:708.42 Median:708.42 stddev:0.00 (0.0%) 06:13:51 INFO - 2015-11-12 06:13:51,314 DEBUG : BROWSER_OUTPUT: Values: 708.4 06:13:51 INFO - 2015-11-12 06:13:51,314 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,314 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11651.16 Median:11651.16 stddev:0.00 (0.0%) 06:13:51 INFO - 2015-11-12 06:13:51,314 DEBUG : BROWSER_OUTPUT: Values: 11651.2 06:13:51 INFO - 2015-11-12 06:13:51,314 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,315 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24926.83 Median:24926.83 stddev:0.00 (0.0%) 06:13:51 INFO - 2015-11-12 06:13:51,315 DEBUG : BROWSER_OUTPUT: Values: 24926.8 06:13:51 INFO - 2015-11-12 06:13:51,315 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,315 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:637.76 Median:637.76 stddev:0.00 (0.0%) 06:13:51 INFO - 2015-11-12 06:13:51,315 DEBUG : BROWSER_OUTPUT: Values: 637.8 06:13:51 INFO - 2015-11-12 06:13:51,315 DEBUG : BROWSER_OUTPUT: 06:13:51 INFO - 2015-11-12 06:13:51,315 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 06:13:51 INFO - 2015-11-12 06:13:51,315 DEBUG : BROWSER_OUTPUT: Values: 4854.4 06:13:51 INFO - 2015-11-12 06:13:51,316 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:13:51 INFO - 2015-11-12 06:13:51,316 DEBUG : BROWSER_OUTPUT: 06:13:52 INFO - 2015-11-12 06:13:52,249 INFO : Browser exited with error code: 0 06:13:52 INFO - 2015-11-12 06:13:52,264 INFO : Completed test v8_7 (00:00:41) 06:13:52 INFO - 2015-11-12 06:13:52,390 INFO : Completed test suite (00:20:19) 06:13:52 INFO - 2015-11-12 06:13:52,390 DEBUG : Working with test: dromaeo_css 06:13:52 INFO - 2015-11-12 06:13:52,390 DEBUG : Generating results file: dromaeo_css 06:13:52 INFO - 2015-11-12 06:13:52,391 DEBUG : Working with test: kraken 06:13:52 INFO - 2015-11-12 06:13:52,391 DEBUG : Generating results file: kraken 06:13:52 INFO - 2015-11-12 06:13:52,392 INFO : javascript benchmark 06:13:52 INFO - 2015-11-12 06:13:52,392 DEBUG : Working with test: v8_7 06:13:52 INFO - 2015-11-12 06:13:52,392 DEBUG : Generating results file: v8_7 06:13:52 INFO - 2015-11-12 06:13:52,392 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:52 INFO - 2015-11-12 06:13:52,453 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:13:52 INFO - 2015-11-12 06:13:52,453 DEBUG : process_Request line: dromaeo_css 6960.53 graph.html#tests=[[72,1,43]] 06:13:52 INFO - 2015-11-12 06:13:52,454 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:52 INFO - 2015-11-12 06:13:52,488 DEBUG : process_Request line: kraken 1514.30 graph.html#tests=[[232,1,43]] 06:13:52 INFO - 2015-11-12 06:13:52,488 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:52 INFO - 2015-11-12 06:13:52,523 DEBUG : process_Request line: v8_7 21472.00 graph.html#tests=[[230,1,43]] 06:13:52 INFO - 2015-11-12 06:13:52,524 INFO : javascript benchmark 06:13:52 INFO - 2015-11-12 06:13:52,528 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [352.17942194686384, 356.7181926278237, 356.819805997971, 357.3567578358954, 360.71503512225337, 11323.490442930068, 11606.477708503116, 16605.916970415146, 17164.91417542912, 17928.19323130459, 13368.064235503518, 13391.330433478335, 13485.39315730792, 16679.83320166798, 16874.325026998904, 6130.172426722403, 6303.086052522382, 6329.430351268385, 6501.577397469149, 6502.837429064288, 6398.3684160539, 6449.290578036413, 6464.095026696266, 6654.700538475756, 7008.123984501937, 6249.531285153609, 6517.837054073662, 6518.771842985497, 6975.2675969023285, 7000.29997000301, 6267.185265915402, 6379.872402551946, 6390.169277993878, 6423.164988551505, 6489.935100649028, 6186.257649082139, 6222.533310001768, 6229.3459186785185, 6229.719662615148, 6443.613383197023, 22208.222712204995, 22636.207732729275, 22971.655425168636, 23021.884890575606, 24094.759052409427, 2139.9786002139936, 2198.626233540302, 2230.509287956647, 2236.3402796175005, 2508.4606809536035, 13708.588742337746, 13878.444862205499, 14664.0, 14702.338394772261, 15093.094414335175, 1942.630900128971, 1949.561348696546, 1963.990180049105, 1977.980220197794, 2018.2028098900998, 69224.0, 69228.0, 70435.0, 70923.29076709218, 72388.63805680991, 15918.442854500037, 16295.674086518204, 16305.0, 16319.91840040816, 16399.0, 24386.0, 24397.26808195757, 24432.877835610707, 24727.25818225456, 24748.257552273462, 8840.248578870867, 8934.642614295486, 8946.105389461001, 8973.551322433852, 8984.281257499384, 7379.926200738031, 7505.474616776883, 7522.3605993491165, 7553.848923021509, 7558.093028836574, 8023.7994050148045, 8073.717419890276, 8099.230573095547, 8120.959395203105, 8137.267645911778, 1154.543955137716, 1191.5591231244496, 3147.826869522198, 3219.6780321967617, 3224.3081671486016, 412.72966207134374, 415.96880233982574, 436.6637688979468, 505.24970418927865, 517.0, 10520.526576304084, 10728.570857165781, 10848.294860834021, 10998.890011099948, 11015.724606884733, 422.6111976981185, 481.03552377483624, 487.04296058245717, 487.2301763214113, 502.53515498164785, 6286.685665716695, 6499.642519661369, 6556.4427023702565, 6630.1380820494, 6645.767398141139, 543304.0, 552459.0, 555706.0, 572508.0, 578192.0, 73159.0, 74594.62702686452, 76529.0, 76961.61519192481, 76968.0, 544.0723566319416, 549.4148731600752, 551.0659432262357, 551.4485514485515, 552.0504731861192, 10586.570812940154, 10843.566257349934, 10906.691197056403, 11045.116390688565, 11069.114470842153, 32700.50949235716, 32805.17987050343, 33252.33495330031, 34958.82520587381, 35415.645843541235, 25104.246872593852, 25477.235682929542, 25812.483750325264, 40105.99735006648, 47997.5200248007, 14346.856531434552, 14692.559223223321, 14800.48198313054, 14868.702625947637, 15170.544883653509, 19395.030248487237, 19452.319168829024, 19629.50926226856, 20179.394618161477, 20281.898590506953, 9694.806103878023, 9759.414435133915, 10007.449590272605, 10054.396736195851, 10151.89848101539, 9930.106290433896, 10192.13366863825, 10219.802742410417, 10264.897351026395, 10526.578936842441, 10113.140383067228, 10400.167986560906, 10515.15878729715, 10592.629257975934, 10734.516946737573, 15041.247937602857, 15072.321745521258, 15163.924180379028, 15339.309731061905, 15429.0, 15542.84457155414, 15605.843941560439, 15834.445794397141, 15870.60323491922, 16205.75691364654], "dojo.html": [3195.6964088411605, 3231.14374690707, 3241.011491495093, 3274.81988490633, 3280.1963518937864, 5199.194124910636, 5431.91852122218, 5434.538064264532, 5445.700486473247, 5453.618246722731, 5300.310959575259, 5337.2527846101575, 5366.624336296461, 5453.345598528173, 5472.863178420542, 4963.578095861856, 4970.254461830718, 5041.72270525121, 5064.873378165557, 5103.566196873252, 4983.626228032894, 5048.974755126219, 5091.79632814687, 5106.157484015152, 5111.718855462948, 4819.132556139911, 4863.221884498499, 4926.926096108561, 4943.382077240345, 5024.572911302544, 4918.139325618003, 4948.158813001798, 4962.528559786814, 4987.925181122286, 4989.101961646902, 4685.2972054191805, 4930.457649658535, 4938.308636790852, 4949.455559888409, 4994.375703037121, 5186.507281808223, 5199.610029247784, 5206.583473322163, 5225.529702326771, 5259.684418934876, 5844.503217226541, 5852.736626851759, 5898.0, 5917.792877249276, 5923.7926672566255, 5697.77208911643, 5782.3350314713925, 5882.647041177543, 5891.882162356729, 5918.733656985403, 5413.02565538203, 5474.753636086386, 5476.91784623231, 5491.615586908918, 5555.944370569619, 5939.198208241918, 5962.4633782959745, 5969.611975221596, 5980.192673989043, 5989.861926234002, 5515.641483303572, 5600.467955544217, 5635.887282254332, 5772.365039845614, 5804.303483581997, 5628.493435590816, 5702.201691763156, 5711.628744131701, 5721.713914304268, 5761.020626493506, 5760.884782304331, 5803.738831752581, 5817.069268916953, 5822.039363505059, 5833.474987251083, 5633.549316054706, 5745.224394706661, 5796.101604251347, 5802.796902108406, 5832.883342333214, 4464.3973063635995, 4480.260756975063, 4492.663050271242, 4515.367848501212, 4517.209488339593, 4000.6799456043445, 4002.699797515198, 4019.678425725935, 4022.27599032177, 4030.5969403059457, 5322.627416080914, 5403.648762830482, 5441.564674826004, 5550.694711790809, 5568.0, 5814.127880817827, 5816.970915145397, 5829.8251052468495, 5838.649681019152, 5927.288725352985, 5536.75084621193, 5545.861353466115, 5546.195801608744, 5554.972225138848, 5557.499825015687, 4875.68308059975, 4955.2567114933045, 4969.0, 5021.874453138627, 5077.974610126926, 6102.481289090389, 6128.785492507741, 6140.631562106288, 6171.506279497629, 6172.0, 5557.0, 5910.438508341873, 5938.049912014057, 5949.851253718692, 5961.612495187799, 5851.502622277154, 5890.4698577128265, 5891.469767720926, 5896.439838215363, 5908.202392676933, 5644.717764111696, 5691.943080569307, 5824.388439213822, 5832.300123985149, 5876.764929402947, 5774.595778295647, 5824.708764561839, 5833.79581714638, 5835.503982161564, 5848.795292164754, 5527.115661494303, 5664.631798933056, 5695.544356451391, 5700.942990570041, 5709.800156994652, 5511.779528818803, 5554.444555544414, 5579.218909352775, 5592.077307244259, 5620.297462817148, 5500.064988951808, 5527.336719593674, 5530.5022547969265, 5539.750711218086, 5540.058190107611, 5533.916991245215, 5600.523955463831, 5619.747111380079, 5666.631668941505, 5704.458076482728, 5591.30108736408, 5685.459881311269, 5698.6580805151825, 5702.287214098238, 5747.08046712524], "mootools.html": [1422.374155371637, 1693.4327000454848, 1735.4186347573561, 1758.5515693498164, 1774.9882566936847, 7395.149557800854, 7750.069991601016, 7799.766007019784, 7836.17720139385, 7880.4089693272945, 7822.8044298892555, 7878.29095381417, 7885.304659498207, 7924.049114106316, 7933.404994625412, 2215.490437199441, 2224.3104637562406, 2239.9104035838627, 2243.921462748804, 2247.9438014049697, 2262.061244583496, 2263.7962583367494, 2299.1033496936125, 2302.458922153293, 2308.0652335803943, 2153.5154590217235, 2222.1777942161343, 2228.197848774448, 2229.565234779219, 2243.8990245438995, 2213.612617791896, 2236.552689462106, 2271.159670921761, 2273.602119629075, 2279.4985103277254, 2225.543763528473, 2253.4479052632046, 2254.0645632062674, 2261.547690461914, 2269.8184145268337, 7338.15611204713, 7441.962790186014, 7456.217097204824, 7470.47706660534, 7485.214052524516, 4345.065810850682, 4413.977930110329, 4419.359192917009, 4441.067375851075, 4455.04216593434, 2987.521996480553, 3001.294695746498, 3053.923651908698, 3074.9077527674203, 3087.9073627791204, 952.2239374909495, 957.8036502516967, 982.7690492734201, 992.533509250651, 993.3692105512979, 10393.22050846182, 10441.112505437048, 10452.529636166315, 10465.058144767008, 10500.317479363817, 3914.784686842251, 3920.725549211528, 3979.840806367713, 3997.600239975979, 4073.165001174752, 8456.957715211507, 8464.0, 8514.403991720521, 8520.233179013794, 8529.061803201643, 4516.909661806745, 4533.52397998212, 4541.2733962565835, 4548.363229147922, 4554.294084416921, 4102.384642303678, 4125.731827431207, 4130.0, 4139.958600413957, 4143.02638879863, 3464.5149679044953, 3478.617352091268, 3507.2459421224557, 3507.316073365669, 3521.2781379817075, 1081.4376524207369, 1081.534939975818, 1086.3590481615884, 1089.3518356577824, 1095.917806164541, 1018.0328687746522, 1020.1125021231576, 1064.3401091323274, 1135.239389608964, 1269.3082270162784, 7005.824854378681, 7133.785986420416, 7139.785806425815, 7140.892886606705, 7143.321384468467, 1029.5006921642996, 1039.5789705169418, 1049.3546468921559, 1051.8527406163143, 1051.9421431821324, 5506.531944784738, 5526.834194974157, 5534.225208470817, 5541.750621222055, 5559.527440167631, 8871.955640221757, 8981.832361792925, 8994.910050899407, 9156.633734650673, 9306.208972237435, 9059.048799876049, 9108.681196158102, 9197.586108625128, 9228.630854765868, 9306.441613503212, 7074.7170113195925, 7135.821604459827, 7181.0, 7231.421486281085, 7233.674484648203, 6798.592084474947, 6865.176178858569, 6893.965530172317, 6910.136232970879, 6938.548994315353, 7685.423593230418, 7977.80055498594, 8009.239122283374, 8035.196480351918, 8130.430869839054, 8169.428140030141, 8267.503949763033, 8291.792705182419, 8296.668133274601, 8456.450330728483, 6809.693563789542, 6827.0, 6851.486138539729, 6899.827504312231, 6973.651317434006, 7457.366123879531, 7502.174760776201, 7530.209328020479, 7532.284432978859, 7540.773776786705, 6925.342092501204, 7082.2917708230825, 7161.498695091502, 7240.420766338786, 7258.491905566771, 6303.401176888188, 6307.779227727007, 6907.171139463297, 6925.722971081101, 7026.262242464468, 7013.228544860163, 7043.859122817413, 7072.611006394698, 7094.858102838018, 7103.147622285359, 6318.684065796784, 6334.968325158345, 6353.396427339396, 6357.205349331333, 6362.172917520693, 6449.0, 6492.870142597216, 6500.382463665944, 6501.967490162708, 6511.186101737283], "ext.html": [544.8068729482436, 600.5525883217002, 600.8678090820018, 608.540551883328, 608.7869245763981, 40078.19843603126, 41008.38487422691, 41055.0, 41105.58894411055, 41213.587864121386, 43740.562594374045, 44010.33984490235, 44227.0, 44276.557234427644, 44384.77807610966, 8766.298696104312, 8793.780155496132, 8865.246454051414, 8875.911240887574, 8911.95544022279, 8649.351298652595, 8749.693760718375, 8750.649974001033, 8756.124387561256, 8759.693410730593, 8720.476771393736, 8783.95608021959, 8792.428492148021, 8851.822963540757, 8866.335024873128, 8729.563521823884, 8745.256653184455, 8758.211760941515, 8797.824043519126, 8825.382223244376, 8733.25767309773, 8789.0, 8865.601047952858, 8870.689525866628, 8872.73381798547, 40782.0, 41060.38409423861, 41095.7945210275, 41196.1760764786, 41437.585624143976, 3455.6371580983887, 3561.1631266652316, 3825.8087095645383, 3879.1465877506903, 3995.1011022519992, 29744.36405997669, 30116.0, 30374.696253037408, 30410.0, 30475.542866857017, 3232.3696879108584, 3272.787268827519, 3273.852676629557, 3361.697447229761, 3386.2211691311136, 266515.0, 266673.0, 266836.0, 266873.0, 267608.0, 57322.42677573171, 58414.41585584175, 59556.404435955956, 68662.31337686659, 69371.65314173397, 61484.0, 61943.0, 62084.65407421527, 62096.68951655303, 62267.0, 14452.855471445151, 14636.341364638616, 14677.192754398611, 14722.55832325032, 14734.263286835616, 10766.354018758899, 10817.296875703054, 10818.621348252773, 10931.344119352865, 10946.397948112772, 19876.304329348404, 20582.691259631116, 20614.175432982513, 20633.690494642593, 20798.168073277204, 7349.816254593571, 7582.658780354897, 7632.389408847279, 7689.231076892266, 7692.461527693008, 893.2496702769705, 915.3775432705824, 934.1685899549407, 1048.5596049659162, 1064.9627263045757, 29313.56029659557, 30553.23616909595, 30800.845995770327, 32316.515252271234, 32621.51067733986, 980.9362391444675, 1010.7422607235255, 1022.3967858963099, 1041.3075304922293, 1113.7939481196004, 14251.0, 14256.144631322153, 14299.0, 14534.127952322895, 14564.85435145635, 336994.0, 343242.0, 343919.0, 344316.0, 345025.0, 52638.21042684363, 52809.47190528122, 53022.0, 53110.73444632829, 53125.73437132867, 1293.4761421624257, 1326.4362645875658, 1326.6484381638872, 1353.8646135386382, 1358.551677946295, 26881.327966800985, 27543.449131016867, 27916.44167116687, 27984.0, 28072.578911316756, 46376.53623463722, 46459.767701161276, 46631.06737865156, 46930.0, 47186.52813471821, 316018.0, 318259.0, 318301.0, 318836.0, 320655.0, 31838.204044899063, 32487.350252995282, 32979.83510082434, 33008.1747956303, 33292.167695807795, 40402.59597403988, 42816.14367712691, 44598.10803783971, 44765.77617111894, 45211.54788452205, 33402.66597333996, 36048.8197559021, 36384.818075909454, 36543.81728091343, 36744.448833266986, 36708.26583468369, 36766.816165919, 36869.44695829511, 37078.629213707514, 37134.8143259282, 35118.0, 36117.27765444729, 36203.0, 36295.45556816597, 36349.636503634625, 31820.5226921601, 33284.0, 33407.665923341425, 33846.15384615404, 33939.66060339464, 25679.871600641876, 26584.468310633292, 26726.331841704112, 26805.597916031664, 26893.731062689905], "prototype.html": [311.20797570183885, 317.53164082977605, 327.5125422416744, 333.0757148911771, 334.83258370814576, 6071.180390647261, 6073.0, 6079.027355623101, 6091.6345019298815, 6150.323464418911, 5965.642061476304, 5966.67183304918, 5990.281166260044, 6040.30536488304, 6053.303870054945, 4538.364628951941, 4540.59134677879, 4543.4093567836135, 4548.272276435771, 4556.179887620227, 4549.181147393468, 4552.317152427129, 4552.9089418211615, 4565.269556870901, 4570.588647021767, 4443.577860103285, 4490.3040028795585, 4509.030558429937, 4553.908921821561, 4569.405977222957, 4551.089782043605, 4553.840615578439, 4558.225101732697, 4564.680472366936, 4573.474050484204, 3913.6086391360923, 3915.4126880967797, 3915.9216815663813, 3927.6661483773914, 3929.489166408377, 5776.508996735282, 5782.710864456761, 5784.623999440065, 5789.334226563957, 5793.594448388614, 5142.04872098663, 5224.529792318672, 5234.0, 5264.210368444726, 5277.102892508283, 6228.065790131472, 6312.558120931537, 6320.178376810985, 6324.7470101195895, 6331.303556608769, 4297.978510107429, 4305.074409002048, 4313.115811258715, 4326.134773045404, 4326.545712700153, 6431.389018043325, 6507.0, 6561.3438656134485, 6563.770268040644, 6576.04647326135, 4420.336949457543, 4471.32930060487, 4473.955260447354, 4480.439945006874, 4482.9775851121185, 4515.367848501212, 4520.796564154621, 4533.455985281787, 4539.6368290536675, 4540.318952157203, 5258.158694608845, 5260.92108618371, 5261.210818377274, 5267.868303292448, 5278.81524146653, 6293.96853015732, 6417.647029413333, 6428.100065990765, 6429.260635026938, 6443.130177425987, 1608.4692051622937, 1611.9032858028556, 1635.255958538862, 1650.3893559383105, 1650.5543503254055, 1109.755853712182, 1121.3272036777869, 1121.545773961547, 1129.8079326514512, 1137.5449820072038, 6044.0, 6048.274207095177, 6091.604045737013, 6096.237970253718, 6112.0, 6423.743050277936, 6444.516661250425, 6446.226452825597, 6452.322506136882, 6469.514786390945, 6049.274087109487, 6154.78458253959, 6155.353687862799, 6158.938410615837, 6160.8767824643255, 3659.0852286928266, 3680.0431887709387, 3682.5580930288, 3684.521012268388, 3688.5942546319884, 6790.626515541594, 6795.626240556817, 6805.591664500146, 6827.078344423439, 6830.043793868862, 6617.569857959217, 6624.470042396597, 6629.966850165815, 6662.367075127855, 6695.230048544382, 6713.12729345182, 6758.526903116833, 6815.965920170466, 6830.93169068303, 6844.5208835382045, 6583.8478266302245, 6591.373819487141, 6596.90104648421, 6598.3401659833635, 6617.371349721769, 6424.51816113784, 6513.348665133449, 6518.902216466851, 6532.640704761284, 6551.541392102507, 6827.52207345481, 6829.0, 6839.589624622538, 6849.965750171217, 6853.0405743195, 4388.495323037764, 4439.045605194899, 4442.977785111054, 4448.955510444855, 4471.0610771737, 6489.091527186103, 6606.8017959461295, 6662.600243985376, 6663.200415950117, 6691.76578819739, 6379.840503987438, 6397.424231819158, 6400.359964003563, 6402.03969404593, 6403.871922561616, 6331.113644089924, 6356.269029061532, 6395.072714456284, 6395.360463953567, 6418.871622567616, 6172.598781079216, 6290.779822706183, 6296.118543403835, 6311.873762524816, 6312.4634406074165, 6377.681115944277, 6429.7106630200815, 6457.225132983884, 6547.1161393211305, 6551.148350714377, 6365.745370185326, 6390.233172019387, 6391.296957334596, 6397.712102955471, 6404.135441715309], "yui.html": [859.965601375945, 861.7242482405633, 862.2153840005594, 877.0527829943661, 880.9339299552535, 13768.0, 13999.580012599612, 14143.929280353597, 14179.149251044944, 14207.92896035521, 13037.73924521509, 13129.934350328258, 13158.671033224175, 13214.669633259173, 13904.93047534761, 803.6704950970103, 821.0434843407453, 822.5106061893164, 822.8436597046542, 825.5995842016617, 814.9714759983402, 820.2207902492626, 821.8602837517607, 822.1737154160061, 822.4941660878546, 856.1353033436212, 863.4991704811194, 868.3227082875336, 870.2820173356974, 871.6208449324564, 861.0313397427893, 866.9653213871501, 867.5228624256665, 867.5792240763225, 869.1959937058227, 623.7847942459844, 627.1940556385069, 627.7771391156165, 627.8116565030518, 629.9968500157515, 11880.465379057876, 11927.224730392496, 11967.64097077089, 11968.162228643998, 12012.69968250792, 10913.39976301303, 11106.722331941766, 11223.607173748962, 11248.887511124947, 11250.943745281304, 8812.16284452976, 8950.68672596456, 8978.0, 9017.684381046698, 9048.230900373475, 3300.9834950825093, 3378.45944648855, 3386.204242003127, 3400.064982129934, 3470.819921226795, 44018.779906100266, 45178.09643807106, 46439.76780116111, 46658.30012549781, 47725.284120738215, 6883.724651013903, 6959.582425054513, 6998.265182155902, 7024.964875175591, 7170.175429825533, 11632.709182270512, 11634.6509604712, 11639.06887449002, 11660.533578656929, 11704.70738231551, 6632.8673426531195, 6761.695723692445, 6766.221884483249, 6786.355296246848, 6951.582905025714, 4110.34234522475, 4118.608732170439, 4188.937165942452, 4193.30810416284, 4239.40648309237, 2859.828410295389, 2874.8993785217417, 2877.784166187544, 2883.308006078568, 2904.288449329885, 439.16558538775945, 443.0629219201366, 455.28292938621803, 455.38522993958554, 455.7561704488083, 662.5825729790298, 668.8296477929151, 677.9796606101726, 681.2266045266329, 705.8164877131983, 8839.204471597586, 9157.084291570789, 9223.53882305882, 9245.72262832116, 9324.347295689373, 557.768526061688, 590.8345663214307, 644.8097811145723, 678.5657179405086, 681.6966449929832, 4072.6741860651077, 4140.710150289511, 4158.147579746144, 4190.287651099259, 4208.726432781859, 54094.0, 63198.684006580595, 63482.0, 63543.0, 63576.68211658912, 51858.22212666813, 52604.736976314874, 53573.196402054, 53642.19536706952, 54400.45599544033, 45536.544634553895, 46001.53998460039, 47460.288095678596, 47838.76080619644, 48340.758296208296, 8519.23326900582, 8807.823843523222, 8956.328275379503, 9151.61860270109, 9409.482478463477, 36413.63586364102, 36506.26987460289, 36733.81633091818, 38650.42024369693, 38748.80625596967, 47393.52606474029, 47624.28563571619, 48436.273455898896, 48511.51488485211, 48714.26928596145, 7509.812254693677, 7860.449768516149, 7902.841943161219, 8068.47554908929, 8123.959380203298, 11805.704857378634, 11848.466818992994, 11891.227070240408, 11910.464029118537, 11991.280523168289, 10751.677449676523, 10978.286411383235, 11033.83449248278, 11161.553537858395, 11439.656810295704, 11047.944760276147, 11465.31208127515, 11910.940445297718, 11915.165938384576, 11990.940045299718, 10948.616798412337, 11297.209195356247, 11452.255603385753, 11725.530978760755, 11890.46492907804, 9776.462294573867, 9885.604575816888, 10020.34867733595, 10043.89956100459, 10212.540435680263, 8872.600732967161, 8935.553222338987, 8970.41692289999, 9204.631814727603, 9494.667686630935]}, "summary": {"lowerIsBetter": false, "suite": 6960.527676839184, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8905.886578774542, "unit": "ms", "value": 8905.886578774542}, "dojo.html": {"lowerIsBetter": false, "filtered": 5359.412263464739, "unit": "ms", "value": 5359.412263464739}, "mootools.html": {"lowerIsBetter": false, "filtered": 4383.406290951094, "unit": "ms", "value": 4383.406290951094}, "ext.html": {"lowerIsBetter": false, "filtered": 18687.774526185625, "unit": "ms", "value": 18687.774526185625}, "prototype.html": {"lowerIsBetter": false, "filtered": 4799.169191973745, "unit": "ms", "value": 4799.169191973745}, "yui.html": {"lowerIsBetter": false, "filtered": 6060.1502315659145, "unit": "ms", "value": 6060.1502315659145}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-020.e"}, "testrun": {"date": 1447336412, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112043002", "branch": "Firefox", "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 165.0, 162.0, 165.0, 162.0, 163.0, 162.0, 165.0, 175.0, 163.0], "ai-astar": [112.0, 103.0, 113.0, 110.0, 111.0, 123.0, 110.0, 110.0, 109.0, 110.0], "imaging-gaussian-blur": [111.0, 111.0, 111.0, 111.0, 111.0, 110.0, 111.0, 111.0, 110.0, 110.0], "audio-beat-detection": [150.0, 126.0, 149.0, 163.0, 125.0, 159.0, 155.0, 125.0, 162.0, 139.0], "json-stringify-tinderbox": [67.0, 68.0, 67.0, 68.0, 66.0, 67.0, 67.0, 66.0, 68.0, 67.0], "stanford-crypto-pbkdf2": [139.0, 153.0, 149.0, 149.0, 152.0, 141.0, 152.0, 157.0, 149.0, 145.0], "json-parse-financial": [62.0, 62.0, 62.0, 64.0, 62.0, 63.0, 62.0, 62.0, 60.0, 61.0], "stanford-crypto-sha256-iterative": [68.0, 67.0, 72.0, 71.0, 73.0, 65.0, 66.0, 66.0, 66.0, 67.0], "audio-fft": [71.0, 74.0, 72.0, 73.0, 72.0, 71.0, 147.0, 72.0, 72.0, 72.0], "imaging-darkroom": [151.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "stanford-crypto-ccm": [126.0, 124.0, 122.0, 125.0, 124.0, 119.0, 118.0, 125.0, 125.0, 124.0], "audio-oscillator": [91.0, 89.0, 131.0, 91.0, 89.0, 91.0, 129.0, 91.0, 91.0, 131.0], "stanford-crypto-aes": [84.0, 86.0, 86.0, 93.0, 86.0, 94.0, 86.0, 86.0, 94.0, 86.0], "imaging-desaturate": [97.0, 97.0, 96.0, 97.0, 97.0, 98.0, 97.0, 97.0, 97.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1514.2999999999997, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.6, "unit": "ms", "value": 79.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 148.6, "unit": "ms", "value": 148.6}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.3, "unit": "ms", "value": 145.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 123.2, "unit": "ms", "value": 123.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.9, "unit": "ms", "value": 146.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 62.0, "unit": "ms", "value": 62.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.4, "unit": "ms", "value": 102.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.1, "unit": "ms", "value": 111.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 164.3, "unit": "ms", "value": 164.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.1, "unit": "ms", "value": 68.1}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.1, "unit": "ms", "value": 67.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.7, "unit": "ms", "value": 110.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 88.1, "unit": "ms", "value": 88.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.9, "unit": "ms", "value": 96.9}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-020.e"}, "testrun": {"date": 1447336412, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112043002", "branch": "Firefox", "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.8281220026856], "Encrypt": [281.5315315315315], "NavierStokes": [4854.368932038835], "Decrypt": [5040.201005025126], "Splay": [637.7551020408164], "Richards": [163.21201240411295], "RegExp": [24926.829268292684], "Earley": [708.4217975937721], "Boyer": [11651.162790697674], "RayTrace": [1055.9662090813094]}, "summary": {"lowerIsBetter": false, "suite": 21471.995414887373, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.6731340000001, "unit": "score", "value": 344.6731340000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 945.4749119999998, "unit": "score", "value": 945.4749119999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 305.7040000000001, "unit": "score", "value": 305.7040000000001}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.81158424725827, "unit": "score", "value": 52.81158424725827}, "Splay": {"lowerIsBetter": false, "filtered": 127.77788800000003, "unit": "score", "value": 127.77788800000003}, "RegExp": {"lowerIsBetter": false, "filtered": 36.54636497064577, "unit": "score", "value": 36.54636497064577}, "Richards": {"lowerIsBetter": false, "filtered": 216.29535399999995, "unit": "score", "value": 216.29535399999995}, "Earley": {"lowerIsBetter": false, "filtered": 940.7714475524477, "unit": "score", "value": 940.7714475524477}, "Boyer": {"lowerIsBetter": false, "filtered": 57.20141516966067, "unit": "score", "value": 57.20141516966067}, "RayTrace": {"lowerIsBetter": false, "filtered": 700.7695829999997, "unit": "score", "value": 700.7695829999997}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-020.e"}, "testrun": {"date": 1447336412, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112043002", "branch": "Firefox", "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2"}}] 06:13:52 INFO - RETURN: dromaeo_css: 6960.53 06:13:52 INFO - RETURN: kraken: 1514.30 06:13:52 INFO - RETURN: v8_7: 21472.00 06:13:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21472.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1514.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6960.53"}}} 06:13:52 INFO - Return code: 0 06:13:52 INFO - # TBPL SUCCESS # 06:13:52 INFO - Running post-action listener: _resource_record_post_action 06:13:52 INFO - Running post-run listener: _resource_record_post_run 06:13:53 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 12288; Write bytes: 514670592; Read time: 1460; Write time: 1713480 06:13:53 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 112078848; Read time: 0; Write time: 178804 06:13:53 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 12288; Write bytes: 373399552; Read time: 1460; Write time: 1409944 06:13:53 INFO - Running post-run listener: _upload_blobber_files 06:13:53 INFO - Blob upload gear active. 06:13:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:13:53 INFO - Copying logs to upload dir... 06:13:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.178648 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-12 06:13:52.830460) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 06:13:52.833621) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009935 build_url: 'https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/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-12 06:13:52.884668) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 06:13:52.885082) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447333572.675245-1924455298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004689 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 06:13:52.935474) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 06:13:52.935800) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 06:13:52.936104) ========= ========= Total master_lag: 0.23 =========