builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1447620516.2 results: success (0) buildid: 20151115103014 builduid: adfaff2384664086b6fc53f066b58774 revision: 7cd2d806bd069c0260ff73f023ac85f892b863bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.198243) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.198745) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.199071) ========= 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=7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006435 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.231064) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.231377) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.301377) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.301721) ========= 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=7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004754 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.350474) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.350766) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.351210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.351486) ========= 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=7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-15 12:48:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-11-15 12:48:36 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122389 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.486592) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.486933) ========= 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=7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022340 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.545653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:36.546018) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7cd2d806bd069c0260ff73f023ac85f892b863bf --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 7cd2d806bd069c0260ff73f023ac85f892b863bf --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=7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-15 12:48:36,856 truncating revision to first 12 chars 2015-11-15 12:48:36,856 Setting DEBUG logging. 2015-11-15 12:48:36,856 attempt 1/10 2015-11-15 12:48:36,856 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7cd2d806bd06?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 12:48:37,103 unpacking tar archive at: mozilla-central-7cd2d806bd06/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549103 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:37.115153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:37.115472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:37.133521) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:37.133872) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 12:48:37.134374) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-15 12:48:37.134672) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:48:37 INFO - MultiFileLogger online at 20151115 12:48:37 in /builds/slave/test-pgo 12:48:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:48:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:48:37 INFO - {'append_to_log': False, 12:48:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:48:37 INFO - 'blob_upload_branch': 'Firefox', 12:48:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:48:37 INFO - 'branch': 'Firefox', 12:48:37 INFO - 'buildbot_json_path': 'buildprops.json', 12:48:37 INFO - 'config_files': ('talos/linux_config.py',), 12:48:37 INFO - 'default_actions': ('clobber', 12:48:37 INFO - 'read-buildbot-config', 12:48:37 INFO - 'download-and-extract', 12:48:37 INFO - 'populate-webroot', 12:48:37 INFO - 'create-virtualenv', 12:48:37 INFO - 'install', 12:48:37 INFO - 'run-tests'), 12:48:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:48:37 INFO - 'download_minidump_stackwalk': True, 12:48:37 INFO - 'download_symbols': 'ondemand', 12:48:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:48:37 INFO - 'tooltool.py': '/tools/tooltool.py', 12:48:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:48:37 INFO - '/tools/misc-python/virtualenv.py')}, 12:48:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:48:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:48:37 INFO - 'installer_path': 'installer.exe', 12:48:37 INFO - 'log_level': 'info', 12:48:37 INFO - 'log_name': 'talos', 12:48:37 INFO - 'log_to_console': True, 12:48:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:48:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:48:37 INFO - 'opt_config_files': (), 12:48:37 INFO - 'pip_index': False, 12:48:37 INFO - 'sps_profile': False, 12:48:37 INFO - 'sps_profile_interval': 0, 12:48:37 INFO - 'suite': 'dromaeojs', 12:48:37 INFO - 'system_bits': '64', 12:48:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:48:37 INFO - 'title': 'talos-linux64-ix-008', 12:48:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:48:37 INFO - 'use_talos_json': True, 12:48:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:48:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:48:37 INFO - 'work_dir': 'build'} 12:48:37 INFO - ##### 12:48:37 INFO - ##### Running clobber step. 12:48:37 INFO - ##### 12:48:37 INFO - Running pre-action listener: _resource_record_pre_action 12:48:37 INFO - Running main action method: clobber 12:48:37 INFO - rmtree: /builds/slave/test-pgo/build 12:48:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:48:37 INFO - Running post-action listener: _resource_record_post_action 12:48:37 INFO - ##### 12:48:37 INFO - ##### Running read-buildbot-config step. 12:48:37 INFO - ##### 12:48:37 INFO - Running pre-action listener: _resource_record_pre_action 12:48:37 INFO - Running main action method: read_buildbot_config 12:48:37 INFO - Using buildbot properties: 12:48:37 INFO - { 12:48:37 INFO - "properties": { 12:48:37 INFO - "buildnumber": 554, 12:48:37 INFO - "product": "firefox", 12:48:37 INFO - "script_repo_revision": "production", 12:48:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:48:37 INFO - "repository": "", 12:48:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 12:48:37 INFO - "buildid": "20151115103014", 12:48:37 INFO - "slavename": "talos-linux64-ix-008", 12:48:37 INFO - "pgo_build": "True", 12:48:37 INFO - "basedir": "/builds/slave/test-pgo", 12:48:37 INFO - "project": "", 12:48:37 INFO - "platform": "ubuntu64_hw", 12:48:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:48:37 INFO - "slavebuilddir": "test", 12:48:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 12:48:37 INFO - "branch": "mozilla-central", 12:48:37 INFO - "repo_path": "mozilla-central", 12:48:37 INFO - "stage_platform": "linux64-pgo", 12:48:37 INFO - "builduid": "adfaff2384664086b6fc53f066b58774", 12:48:37 INFO - "revision": "7cd2d806bd069c0260ff73f023ac85f892b863bf" 12:48:37 INFO - }, 12:48:37 INFO - "sourcestamp": { 12:48:37 INFO - "repository": "", 12:48:37 INFO - "hasPatch": false, 12:48:37 INFO - "project": "", 12:48:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 12:48:37 INFO - "changes": [ 12:48:37 INFO - { 12:48:37 INFO - "category": null, 12:48:37 INFO - "files": [ 12:48:37 INFO - { 12:48:37 INFO - "url": null, 12:48:37 INFO - "name": "https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:48:37 INFO - } 12:48:37 INFO - ], 12:48:37 INFO - "repository": "", 12:48:37 INFO - "rev": "7cd2d806bd069c0260ff73f023ac85f892b863bf", 12:48:37 INFO - "who": "sendchange", 12:48:37 INFO - "when": 1447620446, 12:48:37 INFO - "number": 6663957, 12:48:37 INFO - "comments": "", 12:48:37 INFO - "project": "", 12:48:37 INFO - "at": "Sun 15 Nov 2015 12:47:26", 12:48:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 12:48:37 INFO - "revlink": "", 12:48:37 INFO - "properties": [ 12:48:37 INFO - [ 12:48:37 INFO - "buildid", 12:48:37 INFO - "20151115103014", 12:48:37 INFO - "Change" 12:48:37 INFO - ], 12:48:37 INFO - [ 12:48:37 INFO - "builduid", 12:48:37 INFO - "adfaff2384664086b6fc53f066b58774", 12:48:37 INFO - "Change" 12:48:37 INFO - ], 12:48:37 INFO - [ 12:48:37 INFO - "pgo_build", 12:48:37 INFO - "True", 12:48:37 INFO - "Change" 12:48:37 INFO - ] 12:48:37 INFO - ], 12:48:37 INFO - "revision": "7cd2d806bd069c0260ff73f023ac85f892b863bf" 12:48:37 INFO - } 12:48:37 INFO - ], 12:48:37 INFO - "revision": "7cd2d806bd069c0260ff73f023ac85f892b863bf" 12:48:37 INFO - } 12:48:37 INFO - } 12:48:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:48:37 INFO - Running post-action listener: _resource_record_post_action 12:48:37 INFO - ##### 12:48:37 INFO - ##### Running download-and-extract step. 12:48:37 INFO - ##### 12:48:37 INFO - Running pre-action listener: _resource_record_pre_action 12:48:37 INFO - Running main action method: download_and_extract 12:48:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:37 INFO - https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:48:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/test_packages.json 12:48:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/test_packages.json 12:48:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:48:44 INFO - Downloaded 1302 bytes. 12:48:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:48:44 INFO - Using the following test package requirements: 12:48:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:48:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'jsshell-linux-x86_64.zip'], 12:48:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:48:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:48:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:48:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:48:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:48:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:44 INFO - https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:48:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/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 12:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/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 12:48:46 INFO - Downloaded 22462849 bytes. 12:48:46 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 12:48:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:46 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 12:48:47 INFO - Return code: 0 12:48:47 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 12:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:47 INFO - https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:48:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/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 12:48:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/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 12:48:48 INFO - Downloaded 22462849 bytes. 12:48:48 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 12:48:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:48 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 12:48:50 INFO - Return code: 0 12:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:50 INFO - https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:48:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/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 12:48:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/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 12:48:51 INFO - Downloaded 11131693 bytes. 12:48:51 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 12:48:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:51 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 12:48:51 INFO - Return code: 0 12:48: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')]} 12:48:51 INFO - https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:48:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/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 12:48:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBQw9lwYT_2MEcVln3kEcg/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 12:48:54 INFO - Downloaded 57137042 bytes. 12:48:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:54 INFO - mkdir: /builds/slave/test-pgo/properties 12:48:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:48:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:48:54 INFO - Contents: 12:48:54 INFO - build_url:https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:54 INFO - Running post-action listener: _resource_record_post_action 12:48:54 INFO - Running post-action listener: set_extra_try_arguments 12:48:54 INFO - ##### 12:48:54 INFO - ##### Running populate-webroot step. 12:48:54 INFO - ##### 12:48:54 INFO - Running pre-action listener: _resource_record_pre_action 12:48:54 INFO - Running main action method: populate_webroot 12:48:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:48:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:48:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:48:54 INFO - '../fennec_ids.txt'], 12:48:54 INFO - 'tests': ['tcheck2']}, 12:48:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:48:54 INFO - '--tppagecycles', 12:48:54 INFO - '7'], 12:48:54 INFO - 'tests': ['tsvgm']}}, 12:48:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:48:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:48:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:48:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:48:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:48:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:48:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:54 INFO - 'talos_options': ['--e10s'], 12:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:54 INFO - 'tests': ['damp', 'tps']}, 12:48:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:54 INFO - 'talos_options': ['--e10s'], 12:48:54 INFO - 'tests': ['damp', 'tps']}, 12:48:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:48:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:48:54 INFO - 'other': {'tests': ['a11yr', 12:48:54 INFO - 'ts_paint', 12:48:54 INFO - 'tpaint', 12:48:54 INFO - 'sessionrestore', 12:48:54 INFO - 'sessionrestore_no_auto_restore']}, 12:48:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:48:54 INFO - 'tests': ['a11yr', 12:48:54 INFO - 'ts_paint', 12:48:54 INFO - 'tpaint', 12:48:54 INFO - 'sessionrestore', 12:48:54 INFO - 'sessionrestore_no_auto_restore']}, 12:48:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:48:54 INFO - 'tests': ['a11yr', 12:48:54 INFO - 'ts_paint', 12:48:54 INFO - 'tpaint', 12:48:54 INFO - 'sessionrestore', 12:48:54 INFO - 'sessionrestore_no_auto_restore']}, 12:48:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:48:54 INFO - 'tests': ['a11yr', 12:48:54 INFO - 'ts_paint', 12:48:54 INFO - 'tpaint', 12:48:54 INFO - 'sessionrestore', 12:48:54 INFO - 'sessionrestore_no_auto_restore']}, 12:48:54 INFO - 'other_l64': {'tests': ['a11yr', 12:48:54 INFO - 'ts_paint', 12:48:54 INFO - 'tpaint', 12:48:54 INFO - 'sessionrestore', 12:48:54 INFO - 'sessionrestore_no_auto_restore']}, 12:48:54 INFO - 'other_nol64': {'tests': ['a11yr', 12:48:54 INFO - 'ts_paint', 12:48:54 INFO - 'tpaint', 12:48:54 INFO - 'sessionrestore', 12:48:54 INFO - 'sessionrestore_no_auto_restore']}, 12:48:54 INFO - 'svgr': {'tests': ['tsvgx', 12:48:54 INFO - 'tsvgr_opacity', 12:48:54 INFO - 'tart', 12:48:54 INFO - 'tscrollx', 12:48:54 INFO - 'cart']}, 12:48:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:48:54 INFO - 'tests': ['tsvgx', 12:48:54 INFO - 'tsvgr_opacity', 12:48:54 INFO - 'tart', 12:48:54 INFO - 'tscrollx', 12:48:54 INFO - 'cart']}, 12:48:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:54 INFO - 'tests': ['tp5o']}, 12:48:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:54 INFO - 'talos_options': ['--e10s'], 12:48:54 INFO - 'tests': ['tp5o']}, 12:48:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:54 INFO - 'talos_options': ['--xperf_path', 12:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:54 INFO - 'tests': ['tp5n']}, 12:48:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:54 INFO - 'talos_options': ['--e10s', 12:48:54 INFO - '--xperf_path', 12:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:54 INFO - 'tests': ['tp5n']}}, 12:48:54 INFO - 'talos.zip': {'path': '', 12:48:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:48:54 INFO - Running post-action listener: _resource_record_post_action 12:48:54 INFO - ##### 12:48:54 INFO - ##### Running create-virtualenv step. 12:48:54 INFO - ##### 12:48:54 INFO - Running pre-action listener: _resource_record_pre_action 12:48:54 INFO - Running main action method: create_virtualenv 12:48:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:48:54 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 12:48:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:48:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:48:54 INFO - Using real prefix '/usr' 12:48:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:48:54 INFO - Installing distribute.............................................................................................................................................................................................done. 12:48:56 INFO - Installing pip.................done. 12:48:56 INFO - Return code: 0 12:48:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:48: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')]} 12:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:56 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 0x7ff3fa385c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12978c0>, '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 0x1244420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12448b0>, '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': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', '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 12:48:56 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 12:48:56 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 12:48:56 INFO - Using env: {'DISPLAY': ':0', 12:48:56 INFO - 'HOME': '/home/cltbld', 12:48:56 INFO - 'LANG': 'en_US.UTF-8', 12:48:56 INFO - 'LANGUAGE': 'en_US:en', 12:48:56 INFO - 'LOGNAME': 'cltbld', 12:48:56 INFO - 'MAIL': '/var/mail/cltbld', 12:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:56 INFO - 'MOZ_NO_REMOTE': '1', 12:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:56 INFO - 'NO_EM_RESTART': '1', 12:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:56 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:56 INFO - 'SHELL': '/bin/bash', 12:48:56 INFO - 'SHLVL': '1', 12:48:56 INFO - 'TERM': 'linux', 12:48:56 INFO - 'TMOUT': '86400', 12:48:56 INFO - 'USER': 'cltbld', 12:48:56 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', 12:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:56 INFO - '_': '/tools/buildbot/bin/python'} 12:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:56 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 12:48:56 INFO - Cleaning up... 12:48:56 INFO - Return code: 0 12:48:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:48: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')]} 12:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:56 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 0x7ff3fa385c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12978c0>, '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 0x1244420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12448b0>, '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': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', '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 12:48:56 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 12:48:56 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 12:48:56 INFO - Using env: {'DISPLAY': ':0', 12:48:56 INFO - 'HOME': '/home/cltbld', 12:48:56 INFO - 'LANG': 'en_US.UTF-8', 12:48:56 INFO - 'LANGUAGE': 'en_US:en', 12:48:56 INFO - 'LOGNAME': 'cltbld', 12:48:56 INFO - 'MAIL': '/var/mail/cltbld', 12:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:56 INFO - 'MOZ_NO_REMOTE': '1', 12:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:56 INFO - 'NO_EM_RESTART': '1', 12:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:56 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:56 INFO - 'SHELL': '/bin/bash', 12:48:56 INFO - 'SHLVL': '1', 12:48:56 INFO - 'TERM': 'linux', 12:48:56 INFO - 'TMOUT': '86400', 12:48:56 INFO - 'USER': 'cltbld', 12:48:56 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', 12:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:56 INFO - '_': '/tools/buildbot/bin/python'} 12:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:57 INFO - Downloading/unpacking psutil>=0.7.1 12:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:48:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:48:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:48:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:58 INFO - Installing collected packages: psutil 12:48:58 INFO - Running setup.py install for psutil 12:48:58 INFO - building 'psutil._psutil_linux' extension 12:48:58 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 12:48:59 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 12:48:59 INFO - building 'psutil._psutil_posix' extension 12:48:59 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 12:48:59 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 12:48:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:59 INFO - Successfully installed psutil 12:48:59 INFO - Cleaning up... 12:48:59 INFO - Return code: 0 12:48:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:48:59 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')]} 12:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:59 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')]} 12:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:59 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 0x7ff3fa385c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12978c0>, '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 0x1244420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12448b0>, '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': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', '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 12:48:59 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 12:48:59 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 12:48:59 INFO - Using env: {'DISPLAY': ':0', 12:48:59 INFO - 'HOME': '/home/cltbld', 12:48:59 INFO - 'LANG': 'en_US.UTF-8', 12:48:59 INFO - 'LANGUAGE': 'en_US:en', 12:48:59 INFO - 'LOGNAME': 'cltbld', 12:48:59 INFO - 'MAIL': '/var/mail/cltbld', 12:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:59 INFO - 'MOZ_NO_REMOTE': '1', 12:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:59 INFO - 'NO_EM_RESTART': '1', 12:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:59 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:59 INFO - 'SHELL': '/bin/bash', 12:48:59 INFO - 'SHLVL': '1', 12:48:59 INFO - 'TERM': 'linux', 12:48:59 INFO - 'TMOUT': '86400', 12:48:59 INFO - 'USER': 'cltbld', 12:48:59 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', 12:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:59 INFO - '_': '/tools/buildbot/bin/python'} 12:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:49:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:49:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:49:01 INFO - Installing collected packages: mozsystemmonitor 12:49:01 INFO - Running setup.py install for mozsystemmonitor 12:49:01 INFO - Successfully installed mozsystemmonitor 12:49:01 INFO - Cleaning up... 12:49:01 INFO - Return code: 0 12:49:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7ff3fa385c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12978c0>, '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 0x1244420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12448b0>, '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': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', '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 12:49:01 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 12:49:01 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 12:49:01 INFO - Using env: {'DISPLAY': ':0', 12:49:01 INFO - 'HOME': '/home/cltbld', 12:49:01 INFO - 'LANG': 'en_US.UTF-8', 12:49:01 INFO - 'LANGUAGE': 'en_US:en', 12:49:01 INFO - 'LOGNAME': 'cltbld', 12:49:01 INFO - 'MAIL': '/var/mail/cltbld', 12:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:01 INFO - 'MOZ_NO_REMOTE': '1', 12:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:01 INFO - 'NO_EM_RESTART': '1', 12:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:01 INFO - 'SHELL': '/bin/bash', 12:49:01 INFO - 'SHLVL': '1', 12:49:01 INFO - 'TERM': 'linux', 12:49:01 INFO - 'TMOUT': '86400', 12:49:01 INFO - 'USER': 'cltbld', 12:49:01 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', 12:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:01 INFO - '_': '/tools/buildbot/bin/python'} 12:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:01 INFO - Downloading/unpacking blobuploader==1.2.4 12:49:01 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 12:49:01 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 12:49:01 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 12:49:01 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 12:49:01 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 12:49:01 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 12:49:03 INFO - Downloading blobuploader-1.2.4.tar.gz 12:49:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:49:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:49:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49:03 INFO - Downloading docopt-0.6.1.tar.gz 12:49:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:49:04 INFO - Installing collected packages: blobuploader, requests, docopt 12:49:04 INFO - Running setup.py install for blobuploader 12:49:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:49:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:49:04 INFO - Running setup.py install for requests 12:49:04 INFO - Running setup.py install for docopt 12:49:04 INFO - Successfully installed blobuploader requests docopt 12:49:04 INFO - Cleaning up... 12:49:04 INFO - Return code: 0 12:49:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:49:04 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')]} 12:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:04 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')]} 12:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:04 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 0x7ff3fa385c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12978c0>, '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 0x1244420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12448b0>, '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': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', '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 12:49:04 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 12:49:04 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 12:49:04 INFO - Using env: {'DISPLAY': ':0', 12:49:04 INFO - 'HOME': '/home/cltbld', 12:49:04 INFO - 'LANG': 'en_US.UTF-8', 12:49:04 INFO - 'LANGUAGE': 'en_US:en', 12:49:04 INFO - 'LOGNAME': 'cltbld', 12:49:04 INFO - 'MAIL': '/var/mail/cltbld', 12:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:04 INFO - 'MOZ_NO_REMOTE': '1', 12:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:04 INFO - 'NO_EM_RESTART': '1', 12:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:04 INFO - 'SHELL': '/bin/bash', 12:49:04 INFO - 'SHLVL': '1', 12:49:04 INFO - 'TERM': 'linux', 12:49:04 INFO - 'TMOUT': '86400', 12:49:04 INFO - 'USER': 'cltbld', 12:49:04 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', 12:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:04 INFO - '_': '/tools/buildbot/bin/python'} 12:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:04 INFO - Running setup.py (path:/tmp/pip-Iefknb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:04 INFO - Running setup.py (path:/tmp/pip-T52yPU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:04 INFO - Running setup.py (path:/tmp/pip-Dy_t88-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:05 INFO - Running setup.py (path:/tmp/pip-jTSjJB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:05 INFO - Running setup.py (path:/tmp/pip-UBbdyn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:05 INFO - Running setup.py (path:/tmp/pip-dxpZVp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:05 INFO - Running setup.py (path:/tmp/pip-7iK2pn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:05 INFO - Running setup.py (path:/tmp/pip-8E1mAR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:05 INFO - Running setup.py (path:/tmp/pip-kuffDi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:05 INFO - Running setup.py (path:/tmp/pip-yyYhrr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:05 INFO - Running setup.py (path:/tmp/pip-OEOcqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:05 INFO - Running setup.py (path:/tmp/pip-mSLeQw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:05 INFO - Running setup.py (path:/tmp/pip-pUfqVw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:05 INFO - Running setup.py (path:/tmp/pip-s2BFaz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:05 INFO - Running setup.py (path:/tmp/pip-ZPSf9b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:05 INFO - Running setup.py (path:/tmp/pip-bcwsvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:05 INFO - Running setup.py (path:/tmp/pip-FHP3Wk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:49:06 INFO - Running setup.py install for manifestparser 12:49:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:49:06 INFO - Running setup.py install for mozcrash 12:49:06 INFO - Running setup.py install for mozdebug 12:49:06 INFO - Running setup.py install for mozdevice 12:49:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:49:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:49:06 INFO - Running setup.py install for mozfile 12:49:06 INFO - Running setup.py install for mozhttpd 12:49:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:49:06 INFO - Running setup.py install for mozinfo 12:49:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:49:06 INFO - Running setup.py install for mozInstall 12:49:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:49:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:49:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:49:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:49:06 INFO - Running setup.py install for mozleak 12:49:06 INFO - Running setup.py install for mozlog 12:49:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:49:07 INFO - Running setup.py install for moznetwork 12:49:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:49:07 INFO - Running setup.py install for mozprocess 12:49:07 INFO - Running setup.py install for mozprofile 12:49:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:49:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:49:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:49:07 INFO - Running setup.py install for mozrunner 12:49:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:49:07 INFO - Running setup.py install for mozscreenshot 12:49:07 INFO - Running setup.py install for moztest 12:49:07 INFO - Running setup.py install for mozversion 12:49:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:49:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:49:07 INFO - Cleaning up... 12:49:07 INFO - Return code: 0 12:49:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:49: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')]} 12:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49: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')]} 12:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49: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', '-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 0x7ff3fa385c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12978c0>, '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 0x1244420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12448b0>, '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': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', '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 12:49:07 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 12:49:07 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 12:49:07 INFO - Using env: {'DISPLAY': ':0', 12:49:07 INFO - 'HOME': '/home/cltbld', 12:49:07 INFO - 'LANG': 'en_US.UTF-8', 12:49:07 INFO - 'LANGUAGE': 'en_US:en', 12:49:07 INFO - 'LOGNAME': 'cltbld', 12:49:07 INFO - 'MAIL': '/var/mail/cltbld', 12:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:07 INFO - 'MOZ_NO_REMOTE': '1', 12:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:07 INFO - 'NO_EM_RESTART': '1', 12:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:07 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:07 INFO - 'SHELL': '/bin/bash', 12:49:07 INFO - 'SHLVL': '1', 12:49:07 INFO - 'TERM': 'linux', 12:49:07 INFO - 'TMOUT': '86400', 12:49:07 INFO - 'USER': 'cltbld', 12:49:07 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', 12:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:07 INFO - '_': '/tools/buildbot/bin/python'} 12:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:08 INFO - Running setup.py (path:/tmp/pip-yGWjse-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:08 INFO - Running setup.py (path:/tmp/pip-p3K7vK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:08 INFO - Running setup.py (path:/tmp/pip-zJfdY6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:08 INFO - Running setup.py (path:/tmp/pip-COn3GC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:08 INFO - Running setup.py (path:/tmp/pip-Q4tDnv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:08 INFO - Running setup.py (path:/tmp/pip-hIIlWs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:08 INFO - Running setup.py (path:/tmp/pip-6c7x67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:08 INFO - Running setup.py (path:/tmp/pip-iKySHd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:08 INFO - Running setup.py (path:/tmp/pip-NPgBQM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:08 INFO - Running setup.py (path:/tmp/pip-vsMRIV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:08 INFO - Running setup.py (path:/tmp/pip-CaRNgU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:08 INFO - Running setup.py (path:/tmp/pip-yhNBmc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:08 INFO - Running setup.py (path:/tmp/pip-5P9n9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:08 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)) 12:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:08 INFO - Running setup.py (path:/tmp/pip-6t_vYV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:09 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)) 12:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:09 INFO - Running setup.py (path:/tmp/pip-1toV4b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:09 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)) 12:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:09 INFO - Running setup.py (path:/tmp/pip-Iatbmq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:09 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)) 12:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:09 INFO - Running setup.py (path:/tmp/pip-80Krzk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:09 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)) 12:49:09 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)) 12:49:09 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)) 12:49:09 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)) 12:49:09 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)) 12:49:09 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)) 12:49:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49:10 INFO - Downloading blessings-1.5.1.tar.gz 12:49:10 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 12:49:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:49:10 INFO - Installing collected packages: blessings 12:49:10 INFO - Running setup.py install for blessings 12:49:11 INFO - Successfully installed blessings 12:49:11 INFO - Cleaning up... 12:49:11 INFO - Return code: 0 12:49:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:49:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:49:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:49:11 INFO - Reading from file tmpfile_stdout 12:49:11 INFO - Current package versions: 12:49:11 INFO - argparse == 1.2.1 12:49:11 INFO - blessings == 1.5.1 12:49:11 INFO - blobuploader == 1.2.4 12:49:11 INFO - docopt == 0.6.1 12:49:11 INFO - manifestparser == 1.1 12:49:11 INFO - mozInstall == 1.12 12:49:11 INFO - mozcrash == 0.16 12:49:11 INFO - mozdebug == 0.1 12:49:11 INFO - mozdevice == 0.47 12:49:11 INFO - mozfile == 1.2 12:49:11 INFO - mozhttpd == 0.7 12:49:11 INFO - mozinfo == 0.9 12:49:11 INFO - mozleak == 0.1 12:49:11 INFO - mozlog == 3.0 12:49:11 INFO - moznetwork == 0.27 12:49:11 INFO - mozprocess == 0.22 12:49:11 INFO - mozprofile == 0.27 12:49:11 INFO - mozrunner == 6.11 12:49:11 INFO - mozscreenshot == 0.1 12:49:11 INFO - mozsystemmonitor == 0.0 12:49:11 INFO - moztest == 0.7 12:49:11 INFO - mozversion == 1.4 12:49:11 INFO - psutil == 3.1.1 12:49:11 INFO - requests == 1.2.3 12:49:11 INFO - wsgiref == 0.1.2 12:49:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7ff3fa385c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12978c0>, '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 0x1244420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12448b0>, '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': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', '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 12:49:11 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 12:49:11 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 12:49:11 INFO - Using env: {'DISPLAY': ':0', 12:49:11 INFO - 'HOME': '/home/cltbld', 12:49:11 INFO - 'LANG': 'en_US.UTF-8', 12:49:11 INFO - 'LANGUAGE': 'en_US:en', 12:49:11 INFO - 'LOGNAME': 'cltbld', 12:49:11 INFO - 'MAIL': '/var/mail/cltbld', 12:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:11 INFO - 'MOZ_NO_REMOTE': '1', 12:49:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:11 INFO - 'NO_EM_RESTART': '1', 12:49:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:11 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:11 INFO - 'SHELL': '/bin/bash', 12:49:11 INFO - 'SHLVL': '1', 12:49:11 INFO - 'TERM': 'linux', 12:49:11 INFO - 'TMOUT': '86400', 12:49:11 INFO - 'USER': 'cltbld', 12:49:11 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', 12:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:11 INFO - '_': '/tools/buildbot/bin/python'} 12:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:11 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)) 12:49:11 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)) 12:49:11 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)) 12:49:11 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)) 12:49:11 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)) 12:49:11 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)) 12:49:11 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)) 12:49:11 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)) 12:49:11 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)) 12:49:11 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)) 12:49:11 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)) 12:49:11 INFO - Cleaning up... 12:49:11 INFO - Return code: 0 12:49:11 INFO - Running post-action listener: _resource_record_post_action 12:49:11 INFO - Running post-action listener: _start_resource_monitoring 12:49:11 INFO - Starting resource monitoring. 12:49:11 INFO - ##### 12:49:11 INFO - ##### Running install step. 12:49:11 INFO - ##### 12:49:11 INFO - Running pre-action listener: _resource_record_pre_action 12:49:11 INFO - Running main action method: install 12:49:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:49:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:49:11 INFO - Reading from file tmpfile_stdout 12:49:11 INFO - Detecting whether we're running mozinstall >=1.0... 12:49:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:49:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:49:11 INFO - Reading from file tmpfile_stdout 12:49:11 INFO - Output received: 12:49:11 INFO - Usage: mozinstall [options] installer 12:49:11 INFO - Options: 12:49:11 INFO - -h, --help show this help message and exit 12:49:11 INFO - -d DEST, --destination=DEST 12:49:11 INFO - Directory to install application into. [default: 12:49:11 INFO - "/builds/slave/test-pgo"] 12:49:11 INFO - --app=APP Application being installed. [default: firefox] 12:49:11 INFO - mkdir: /builds/slave/test-pgo/build/application 12:49:11 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'] 12:49:11 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 12:49:26 INFO - Reading from file tmpfile_stdout 12:49:26 INFO - Output received: 12:49:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:49:26 INFO - Running post-action listener: _resource_record_post_action 12:49:26 INFO - ##### 12:49:26 INFO - ##### Running run-tests step. 12:49:26 INFO - ##### 12:49:26 INFO - Running pre-action listener: _resource_record_pre_action 12:49:26 INFO - Running main action method: run_tests 12:49:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:49:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:49:26 INFO - Python 2.7.3 12:49:26 INFO - Return code: 0 12:49:26 INFO - grabbing minidump binary from tooltool 12:49:26 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')]} 12:49:26 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 0x12978c0>, '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 0x1244420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12448b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:49:26 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 12:49:26 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 12:49:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:49:26 INFO - Return code: 0 12:49:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:49:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:49:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:49:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:49:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:49:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:49:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 12:49:26 INFO - Using env: {'DISPLAY': ':0', 12:49:26 INFO - 'HOME': '/home/cltbld', 12:49:26 INFO - 'LANG': 'en_US.UTF-8', 12:49:26 INFO - 'LANGUAGE': 'en_US:en', 12:49:26 INFO - 'LOGNAME': 'cltbld', 12:49:26 INFO - 'MAIL': '/var/mail/cltbld', 12:49:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:49:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:26 INFO - 'MOZ_NO_REMOTE': '1', 12:49:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:26 INFO - 'NO_EM_RESTART': '1', 12:49:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:26 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:49:26 INFO - 'SHELL': '/bin/bash', 12:49:26 INFO - 'SHLVL': '1', 12:49:26 INFO - 'TERM': 'linux', 12:49:26 INFO - 'TMOUT': '86400', 12:49:26 INFO - 'USER': 'cltbld', 12:49:26 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780', 12:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:26 INFO - '_': '/tools/buildbot/bin/python'} 12:49:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 12:49:26 INFO - mozversion INFO | application_buildid: 20151115103014 12:49:26 INFO - mozversion INFO | application_changeset: 7cd2d806bd069c0260ff73f023ac85f892b863bf 12:49:26 INFO - mozversion INFO | application_display_name: Nightly 12:49:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:49:26 INFO - mozversion INFO | application_name: Firefox 12:49:26 INFO - mozversion INFO | application_remotingname: firefox 12:49:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 12:49:26 INFO - mozversion INFO | application_vendor: Mozilla 12:49:26 INFO - mozversion INFO | application_version: 45.0a1 12:49:26 INFO - mozversion INFO | platform_buildid: 20151115103014 12:49:26 INFO - mozversion INFO | platform_changeset: 7cd2d806bd069c0260ff73f023ac85f892b863bf 12:49:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 12:49:26 INFO - mozversion INFO | platform_version: 45.0a1 12:49:26 INFO - 2015-11-15 12:49:26,505 DEBUG : using testdate: 1447620566 12:49:26 INFO - 2015-11-15 12:49:26,505 DEBUG : actual date: 1447620566 12:49:26 INFO - 2015-11-15 12:49:26,581 INFO : starting webserver on 'localhost:60129' 12:49:26 INFO - 2015-11-15 12:49:26,582 INFO : Starting test suite talos-linux64-ix-008 12:49:26 INFO - 2015-11-15 12:49:26,582 INFO : Starting test dromaeo_css 12:49:26 INFO - 2015-11-15 12:49:26,582 DEBUG : operating with platform_type : linux_ 12:49:26 INFO - 2015-11-15 12:49:26,583 INFO : Initialising browser for dromaeo_css test... 12:49:26 INFO - 2015-11-15 12:49:26,599 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgxybxc/profile http://localhost:60129/getInfo.html 12:49:31 INFO - 2015-11-15 12:49:31,307 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:49:31 INFO - 2015-11-15 12:49:31,307 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:49:31 INFO - 2015-11-15 12:49:31,307 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:49:31 INFO - 2015-11-15 12:49:31,307 DEBUG : BROWSER_OUTPUT: __metrics 12:49:31 INFO - 2015-11-15 12:49:31,429 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:49:32 INFO - 2015-11-15 12:49:32,570 INFO : Browser initialized. 12:49:32 INFO - 2015-11-15 12:49:32,571 INFO : Running cycle 1/1 for dromaeo_css test... 12:49:32 INFO - 2015-11-15 12:49:32,571 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgxybxc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:49:44 INFO - 2015-11-15 12:49:44,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 141471744 12:49:44 INFO - 2015-11-15 12:49:44,331 DEBUG : BROWSER_OUTPUT: 12:50:35 INFO - 2015-11-15 12:50:35,884 DEBUG : BROWSER_OUTPUT: 1447620635882 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] 12:52:44 INFO - 2015-11-15 12:52:44,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60129/tests/dromaeo/cssquery-ext.html) 12:52:45 INFO - 2015-11-15 12:52:45,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 241291264 12:52:45 INFO - 2015-11-15 12:52:45,421 DEBUG : BROWSER_OUTPUT: 12:55:47 INFO - 2015-11-15 12:55:47,709 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/dromaeo/cssquery-ext.html (next: http://localhost:60129/tests/dromaeo/cssquery-jquery.html) 12:55:48 INFO - 2015-11-15 12:55:48,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 220192768 12:55:48 INFO - 2015-11-15 12:55:48,281 DEBUG : BROWSER_OUTPUT: 12:58:50 INFO - 2015-11-15 12:58:50,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60129/tests/dromaeo/cssquery-mootools.html) 12:58:50 INFO - 2015-11-15 12:58:50,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 213491712 12:58:50 INFO - 2015-11-15 12:58:50,788 DEBUG : BROWSER_OUTPUT: 13:01:52 INFO - 2015-11-15 13:01:52,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60129/tests/dromaeo/cssquery-prototype.html) 13:01:53 INFO - 2015-11-15 13:01:53,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 206880768 13:01:53 INFO - 2015-11-15 13:01:53,143 DEBUG : BROWSER_OUTPUT: 13:04:55 INFO - 2015-11-15 13:04:55,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60129/tests/dromaeo/cssquery-yui.html) 13:04:56 INFO - 2015-11-15 13:04:56,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 205217792 13:04:56 INFO - 2015-11-15 13:04:56,002 DEBUG : BROWSER_OUTPUT: 13:07:58 INFO - 2015-11-15 13:07:58,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/dromaeo/cssquery-yui.html (next: http://localhost:60129/tests/dromaeo/cssquery-dojo.html) 13:07:58 INFO - 2015-11-15 13:07:58,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 271691776 13:07:58 INFO - 2015-11-15 13:07:58,773 DEBUG : BROWSER_OUTPUT: 13:07:58 INFO - 2015-11-15 13:07:58,773 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:07:58 INFO - 2015-11-15 13:07:58,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:07:58 INFO - 2015-11-15 13:07:58,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:07:58 INFO - 2015-11-15 13:07:58,773 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:07:58 INFO - 2015-11-15 13:07:58,774 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3208.4866421372585;3252.36578867121;3290.506424036394;3298.9340213195737;3310.05663385935;5408.594355423349;5497.422770609089;5500.339959204896;5512.062949298619;5559.722013899304;5513.558915286778;5518.668879867211;5572.749226284816;5576.442355764431;5648.011597970349;4768.028395583131;5035.597152227831;5040.899182016357;5058.494150584949;5062.9240561391425;4967.00659868026;5087.236914462842;5094.51602097802;5169.586433085344;5173.818916337929;4872.171730805771;5027.874303142414;5033.395992480926;5050.924236136424;5094.592432605401;5063.139266324733;5071.7210553419545;5077.974610126963;5086.160783470723;5109.489051094898;4831.227003679394;4946.08497427977;5027.622928280393;5051.065552872694;5067.189249720064;5317.12267475866;5403.189521571757;5425.647332923348;5428.511433970962;5433.592480563934;6118.051701986199;6140;6140.263168419773;6140.50875929929;6143.938560614426;5803.129530570406;5923.407659234085;5930.466258036754;6141.969290153521;6185.288691800455;5648.943510564883;5705.6006079574445;5709.62887412321;5711.114777209539;5714.342850572154;6163.044728067067;6164.4143806338325;6184.690765461709;6188.659623720649;6190.195274614362;5758.942410575924;5833.300003999547;5909.8227053188475;5952.226210592596;5980.820575382745;6069.2110025696375;6083.422074902877;6090.634561926298;6094.146819445281;6096.69516524172;6043.153958445821;6048.637081775108;6050.515958723292;6057.8485537861025;6058.575899687068;5731.512821410143;5885.440883116097;5924.200232968494;5992.131140984533;6029.397060293935;4513.842015529506;4548.385967894292;4566.178087944136;4581.931271030937;4596.655250856199;3985.880423587297;4060.573639767782;4080.204360149742;4092.4066010428323;4114.855980040684;5590.552755779528;5606.103023516218;5644.774209031592;5666.631668941505;5704.030314846486;6045.032794752907;6061.727222275008;6071.6660583667435;6072.574919755575;6073.817785466443;5600.187972743929;5723.112917497794;5736.139579063174;5737.971310143423;5751.367349591542;5122.1804511278015;5189.688618682816;5201.063808514428;5205.193195054772;5232.136697444955;6223.688815559294;6227.564070515021;6228.34602366745;6230.844228894314;6231.563790534619;5809.477147056617;5922.111683247547;6003;6010.33886272501;6026.276846778414;6067.24159480065;6072.757089716361;6081.908771368345;6086.543509236736;6102.694865256808;5780.537556995514;5789.768409263751;5793.768249269982;5801.6519008859605;5818.592698511064;5878.735456904364;5887.852803679943;5905.498032667271;5984.640921544721;6004.249468816398;5854.531637468907;5855.23881895368;5861.706914654165;5876;5877.706114694333;5841.678707671119;5842.152887831156;5843.29880414353;5844.211031510862;5849.444302791228;5673.404292549388;5674.120511320752;5756.769729210785;5789.2763404574425;5798.391168927202;5718.971405142947;5739.110437882135;5746.281714785652;5749;5795.391483894299;5607.243022191952;5623.943760562342;5631.239782629293;5632.85917852057;5646.35066967304 13:07:58 INFO - 2015-11-15 13:07:58,774 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.7467639562195;594.2868557730723;597.575721237921;599.5862854630304;612.3386742318297;31344.529832052536;40175.39736903945;41133.38299925504;41148.794256028756;41204;44028.77985610067;44677.106457870825;44749.32876006854;44763.552364476345;44823.1035379293;7678.692852285902;7817.76546703597;8616.526091064989;8743.344249181306;8749.95625021874;10506.369617822917;10735.892641073606;10741.462926853665;10745.032947034766;10747.516361763739;10414.687559373193;10477.476126193698;10499.632512862052;10502.527386267637;10515.52680129396;7779.76660700177;7895.368370530344;10387.22095842811;10561.155107591374;10852.403117828517;10295.742606434898;10404.271700980935;10421.635242766542;10436.060754532129;10443.477826108665;33448.16379590506;40967;41458.79270603628;41505.377419338736;41507.377389339184;2808.3330036006855;2879.6544414670166;3368.96631033689;3542.734294927865;4065.024394145413;30423.087307380814;30575.694243057507;30983;31159.376812463623;31859;3365.5456513370627;3455.8617655293756;3493.336266109431;3502.702270307027;3571.178628915338;286432;287394;287686;288152.55923720455;288576;60492;60782.39217607856;60840.39159608436;60885;60901.39098609046;66280.66859665768;66806.66596667083;66808.33191668021;66960.66519667371;67004.3299566998;15027.474038408604;15368.385264589291;15432.768508472382;15441.845581544041;15540.30068646891;12299.69250768738;12493.500259989498;12493.750124997448;12502.562410315595;12528.874711252953;19807.20771169137;20558.486037849172;20654.48363790887;20657.793422065588;20666.17335306601;7532.661030253542;7589;7646.617669116522;7702.653380597886;7801.648925798353;924.7549399409162;979.4270351844251;993.4982833668951;1006.3609607898891;1115.2806439846415;28165.43669126647;28486;28555.857220713762;29066.27334316659;29546.40907181844;930.9674161404319;1026.08165691707;1039.6309310194772;1056.6513050693407;1118.8713297970676;12826.486940522274;14400.20798856052;14734.263286835616;14895.404183832525;15251;349498;353983;355033;355331;355632;44305.55694443079;44810.55189448064;50812;53200;53528.46471535235;1321.3261236769124;1327.9668008299677;1342.7113170668158;1356.2269506381267;1368.2269517722455;27758.306042349104;28255.858720706266;28582.285442864093;28939.227124858677;29188.124356269345;43836;44524.332135018645;49713.502864970884;50272.748636258046;50456.74771626118;268657;271419;271437;274290;274425;30987.69012309848;31215.531767023967;31347.529787052757;31377.21556961003;31399.372012560078;43570;44146.33780493231;44199;44584;44974.325385118595;36662.450063248536;36827.447588286734;37204;37507;38232.61767382402;37304.44043339406;37325.62674373222;37518;37774.81112594529;38151;36476.63523364732;36501.26997460089;36782;36810.8159459201;36866;29640.258993525335;30250.394992100475;31062.844685776425;31208.843955780078;31232.68767312298;23547;23892.52214955726;24668.38329041788;24742.38144046413;25019 13:07:58 INFO - 2015-11-15 13:07:58,774 DEBUG : BROWSER_OUTPUT: |2;jquery.html;342.7001373797926;343.6426116838488;344.2048867116959;345.33178299989504;352.22510476950714;13899.722005559908;14198.645033874158;16339.183040847955;16973.57566060849;17075.402360917356;15211.23943802811;16996.235169417374;17145;17183.74224386632;17769.20038598263;5314.07003774339;5429.077056900317;5434.3207099112615;5435.266239057736;5438.3473983121885;4072.9592704073025;4187.392828039948;5372.865678358034;5394.91907621386;5875;5975.492083172936;6002.579819412643;6017.48851347636;6029.547783916202;6033.728482218289;4934.309196712463;5023.799048038074;5034.119029169899;5040.243963405482;6090.695465226743;4339.826406943718;4342.305231162999;4346.304591265382;4346.695731298811;4348.434703488558;13968.231747253896;14083.155010699391;14417.639559011004;14441;14462.855371446361;1944.912478938437;1946.0950657944124;1968.045497933501;2003.4190084875368;2148.4843637527038;9966;10190.133838623726;10287.331323463952;10350.689479315633;10427.374357538572;1773.1134432783608;1807.7469154318405;1808.9005104719236;1822.3844764984879;1874.578219900525;59425.10862337025;59920.40079599192;60832.69583652098;61073.38926610722;62106;6891.241963384024;7040.5071644984355;7076.893846592306;7079.716811327592;7121.608311542915;8340.582970851434;8342.16578342161;8352.248297653241;8362.874556881652;8371.95814020926;5557.249771280906;5599.468050535193;5612.130119831432;5636.802711905064;5647.887042259132;5944.554158438134;5966.463018328284;5969.880602387928;5975.850603734854;5998.980173370537;3266.5426840242385;3272.4600440927456;3279.508073788903;3281.6062072551445;3299;1142.3774043146338;1171;1191.9284842909453;1200.4837919694614;1237;435.7124297963329;443.8158164361818;450.36498537062585;452.5203284518421;456.6460992730594;10410.375377477376;11444.771104577861;11709.473073711704;12150.817737733942;12314.815277770662;460.75810199645457;466.5707549054878;466.6266986410858;475.5030992612728;477.4557005014286;6397.136386587844;6610.8347291318105;6632.469402447792;6706.5640733352175;6743.52795304324;504828;505863;506192;528385;533148;75084.62457687677;77928.61035694786;78628;81029.59485202536;81610.59194703988;529.4467281690643;532.3585079978617;535.686623325359;536.8469986054034;537.1754357061891;10871.130309575057;11161.386123762946;11205.719857003314;11541.596044138414;11874.584389546324;35862.103447414025;37154;37288;37629.623703763704;38160.618393815705;47516.52483475121;48938.51061489482;49023.26465102955;49135.26297105475;49267.26099108445;6506.967465162644;6648.9002664961035;6649.933500664932;6659.500537459613;6838.418734407631;11197.66407007791;11432.714182145513;11561.7109572258;11564.537418503165;11625.88374116248;9988.400695958266;10024.899751002687;10174.593016279267;10222.6422075227;10259.281850270409;10116.797664046531;10732.892671073188;10744.570217191538;10789.190810689386;10909.18181136402;9150.40522366044;10967.396793176453;11256.21206515536;11292.209545331747;11314.15143864197;6815.488838337045;6824.112865327675;6843.692033858389;6881.10545629085;6885.1049363582415;10882.510287036945;10923.180761442765;10992.28550144238;11101.333919964827;11121.88878111241 13:07:58 INFO - 2015-11-15 13:07:58,774 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1332.6335257804108;1657.511034244898;1708.7949446066473;1756.2009285774973;1765.8145894681059;6658.067870498128;7367.373773229276;7460.253974602537;7499.887501687465;7527.360174385184;7374.705011799535;7476.514026588268;7514.0607424071995;7525.623718814065;7534.886976695354;1848.2976468941783;1873.38178401128;2246.056656204398;2247.5954328220914;2282.995481987928;2288.2563166970717;2296.678465014891;2299.2412503873766;2299.6435552489306;2301.9309420717404;2158.460384903774;2162.048698572623;2162.4485756132162;2163.459135216196;2165.4261620670536;1937.6415363157862;1973.6644770389069;2185.6284431646577;2209.4697272654607;2225.365770755343;2202.0971401725214;2207.2385027165765;2237.765034671352;2248.898799554024;2250.437390652337;7547.962260188719;7648.541087534766;7657.923420765776;7660.770176894702;7664.961675191644;4584.358189853423;4657.4411070671395;4677.64917631179;4680.063987202573;4683.929741053887;2907.185987923385;2940.911772646824;2943.1906225787866;2978.1512269003447;3042.7870049096573;956.4070276428658;956.5695437053354;968.7868668892833;969.5103972493916;996.4519514267124;10462.895371046345;10465.110465610433;10469.319494232926;10478.685639430829;10491.318064325871;4213.452251207324;4317.762523061199;4354.912901741947;4357.54245804186;4396.406485124531;9053.77365565866;9104;9108.134727200906;9114.772130696785;9115.407498512708;4700.341952126705;4718.41019872516;4721.457032441244;4726.480087190406;4738.549837765407;4282.421873047098;4305.31115021595;4312.029793296483;4315.136972605429;4315.633171180422;3574.9285014299567;3582.946255806165;3593.1915319053005;3612.169201083713;3651.379265524867;1174.8707642159357;1177.0289511153333;1181.6809461445362;1193.2721040165493;1201.7296108375544;1019.1795604538418;1041.4480325427535;1043.4521876015;1144.187626784992;1280.3726174174587;7159.212486626467;7198.568085914757;7249.347558719741;7252.419806415474;7254.056972593529;479.1566842357476;481.73263838569227;482.7658585585988;486.2293265174738;497.04815278740807;5221.347331583552;5234.581233501311;5284.550813180923;5289.709066001406;5296.523312901857;8831.867521987175;8909.1536304051;9210.585523651453;9231.261499080058;9284.675036373694;9111.407758495809;9203.309751768644;9216.078392160864;9225.169734723908;9226.723198304062;6982.197047339621;7071.116110486189;7195.352418282275;7203.027591275216;7204.819879503054;6645.667716614246;6667;6678.432333251728;6679.0649309097735;6701.1623547056615;7885.408594355332;8011.319037881845;8175.059868115005;8254.092049874389;8259.21537453941;8100.473469224482;8297.08732039463;8303.04514980785;8437.915620843713;8442.240198382175;6753.729850805913;6762;6794.898076528757;6841.110655614738;6853.4859885507785;7245.058142441449;7411.110666720028;7411.295926886937;7417.740379086706;7424.443166762622;6812.727490900308;6959.443244540324;7019.859602808017;7085.14978202619;7101.041359416413;5956.642601443928;6258.468030217483;6809.182898052265;6903.275156108536;6971.372576468142;6919.723211071702;6960.443164546926;6966.12923384577;6967;6974.58152510851;6317.431431171217;6393.976963685788;6394.200724909387;6398.328175541501;6439.098526206429;6355.872882542416;6384.457321127757;6393.424591786761;6396.296407395276;6403.391677790602 13:07:58 INFO - 2015-11-15 13:07:58,775 DEBUG : BROWSER_OUTPUT: |4;prototype.html;314.8964914371994;317.33201610609666;323.4888875576589;325.4126302024844;328.1042753283536;6045.214122164118;6118.724657390417;6129.295131059929;6145.047517634763;6219.129321894939;6067.544934129935;6074.240719910012;6080.908786368197;6081.695915204233;6084;4443.089166720831;4521.367008618796;4532.274836026237;4648.837290694826;4662.13750456165;4638.4433867935895;4647.814087436498;4665.136949664306;4674.228752255874;4679.134360143385;4609.285560738091;4610.05493873755;4612;4612.515685852987;4617.676762626617;4390.934135987946;4511.413516242867;4515.435570553665;4580.7022543534895;4627.467841198271;3997.5802540733093;4013.8996525086814;4014.6186112319283;4015.9196816063513;4033.3949907513816;5705.372409035044;5719.971400142973;5720.056190728525;5727.914081288784;5731.742071606787;5229.555487783543;5335.146376579729;5339.9733001335135;5351.411344752074;5365.678059316453;6387.457066149383;6394.520410969196;6404.199475065617;6406.327335629739;6408.711607977652;4445.222086134913;4450.577195166454;4451.621612162938;4452.443444569429;4452.9554704453185;6640.867182656368;6643.734250629921;6645.06969024337;6651.201855777289;6655.234648015444;4469.351943968171;4528.954710452919;4551.817927282872;4559.99680070384;4564.6348292136545;4613.769311534477;4614.538546145359;4618.861434156981;4623.398958135421;4632.374629425052;5348.224507446476;5354.678719276856;5357.062514060024;5358.035553600389;5359.3032905722785;6502.089707440962;6502.122213501211;6502.577332473374;6508.642024688593;6511.511636627272;1553.068159104551;1597.8162511311116;1598.936042558308;1599.224376177553;1600.8399160083898;1028.9382637041651;1054.8417737339307;1056.2553399853084;1072.5656109275756;1075.5590208014676;6185.195924529782;6188.783392581238;6192.071189321638;6198.675496688742;6202.007678771375;6528.967355163289;6540.640264785387;6546.607203567706;6550.705218265094;6553.4101930826455;6066.4217707474145;6153.230846144232;6192.907106393408;6199.783007594712;6200.627962322275;3567.3578755823683;3594.0475773919934;3601.2077342984503;3603.1892824114366;3609.5848977367414;6913.965430172918;6916.412104971134;6916.515843890879;6918;6919.481038922101;6693.765718199839;6795.626240556718;6805.625690587065;6807.353301436356;6824.829379265558;6842.04211410403;6854.965725171442;6887.862242755217;6890.345417185359;6891.448684105259;6594.70323835419;6601.042848786995;6604.3725846044545;6616.66916654175;6616.801495955129;6422.293547709654;6555.3772391622715;6556.3443655634055;6567.474602031731;6580.605163690194;6862.725490980305;6878.037074809431;6879.140107486564;6896.827579310558;6897.931020689729;4467.5755803198645;4470.888227794201;4470.888227794331;4475.172093162775;4476.328550717289;6546.639934803441;6596.208454985433;6606.504512161511;6609.20689517261;6612.867742645024;6230.532710046855;6406.519511036784;6408.359164083555;6408.58344207625;6410.775622853178;6374.872502550016;6375.585586936834;6376.298607153117;6384;6389.7124629390855;6178.474829639351;6283.622982621057;6287;6301.338359472373;6301.747930082929;6404.231492220963;6406.455451286693;6416.903746443713;6422.454091402096;6423.357664233539;6213.9067913982235;6231.470325022424;6259.593126446766;6261.405166509357;6263.937360626518 13:07:58 INFO - 2015-11-15 13:07:58,776 DEBUG : BROWSER_OUTPUT: |5;yui.html;757.7726681995401;762.2073044034202;768.596486844407;782.2568559868123;810.7648781853261;13215.141015833977;13423;16078.7588186177;16080.276387562559;16373.345066197367;14967.625809354771;15024.624384390396;15060.924695376536;15061.472848450307;15065.92467037666;683.0505597219868;839.9202075802789;847.8812966184709;849.8045449546609;850.2772643253217;678.3284548297199;824.9876251856197;827.383599218583;830.9750707478785;832.2177153475714;873.8776571280026;880.137465284022;880.1462581296164;880.7137680253911;881.576843115305;692.9965350173242;693.445243804954;859.909709480508;878.3280790195505;883.6421249394006;632.9588576742497;634.6223996721943;635.3963734452243;637.6939069246788;642.2004604267717;14284.357203925849;14382.92808535961;14413.711725765426;14476.059056161315;14479.493217737434;12506.374681265901;12819.807702884464;13268.668283292995;13287.73424531504;13506.054576179671;10093.394396336244;10143.644972426004;10206.897931020669;11815.645530634094;11903.107266955012;3619.348517266891;3692.9261414771554;3712.1556368938523;3779.527559055118;3879.3792993121247;45265.547344526465;46314.53685463136;51741;52113.47886521124;52141;9991.950040249752;10252.794944101226;10411.323263987968;10490.685279441628;10902.836457453144;18775.530611734815;18824;18824.623507529774;18831.340903068325;18839.05804709759;7605.23947605235;7677.769666910001;7881.527108373516;8130.552819594861;8346.290565301895;4389.473263208435;4454.276700859092;4509.729416235036;4524.954750452519;4585.95414045862;3178.904632861018;3202.151429871086;3204.903852884417;3211.4861622140347;3213.0682102190103;462.9722216667011;470.0903751241359;470.651717728885;473.07985967293286;475.852485729425;668.5787953589305;685.6092027544252;697.745322957117;699.6536714326339;715.8138883890122;8592.183742544448;8631.78420539479;8654.177853103945;8730;9223.907760922439;568.610501806264;679.480197648799;696.6307856835886;696.738722978883;706.2337363960161;3949.150932549458;4099.877003689894;4164.41752134187;4353.06409122034;4497.977510112429;58694;58949.70525147347;59113.70443147843;59410.70294648586;59584.10623840646;50149.24776128361;50357.244641330406;50425.74787126114;51849.48150518446;53684.73157634265;44001;44431.33352999708;44526.10947781091;44962.32556511655;46364.768176158905;8193.71322003727;8406.28546573548;8885.555722213734;8942.955285223532;9170.908290917005;35847.46228806518;36596.63403365932;36932.261354772214;37487.06282342963;37530.812345938095;44422.555774443135;47305.52694473011;47722;47891.675483431434;48018.5198148014;8224.424290299621;8284;8290.419670622998;8291.33669306466;8528.829423411622;12566.874331256571;12814.935925320313;12818.230906145662;12876.484940602646;13011.934940325238;11021;11579.710507237387;11603.651890442963;11672.47473863695;11973.281603103842;11687.415629218674;12124.393780311126;12299.262044277371;12694.174878632859;12696.238225706487;10263;10482.109020733018;10502.474876256309;10641.414722190353;10863.135251411933;9484.430934143973;9598.808023839345;9944.850827237453;10077.949610251902;10296.536655850356;8656.350773692124;8843.204111629726;9336.579853906454;9505.66730164441;9579.712608621752 13:07:58 INFO - 2015-11-15 13:07:58,777 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:07:58 INFO - 2015-11-15 13:07:58,777 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:07:58 INFO - 2015-11-15 13:07:58,777 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,887 13:07:58 INFO - 2015-11-15 13:07:58,778 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:07:58 INFO - 2015-11-15 13:07:58,778 DEBUG : BROWSER_OUTPUT: __startTimestamp1447621678766__endTimestamp 13:07:58 INFO - 2015-11-15 13:07:58,778 DEBUG : BROWSER_OUTPUT: 13:07:58 INFO - 2015-11-15 13:07:58,778 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:07:58 INFO - 2015-11-15 13:07:58,779 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:07:58 INFO - 2015-11-15 13:07:58,779 DEBUG : BROWSER_OUTPUT: 13:07:58 INFO - 2015-11-15 13:07:58,779 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5542.77 Median:5737.97 stddev:638.80 (11.1%) stddev-sans-first:613.96 13:07:58 INFO - 2015-11-15 13:07:58,779 DEBUG : BROWSER_OUTPUT: Values: 3208.5 3252.4 3290.5 3298.9 3310.1 5408.6 5497.4 5500.3 5512.1 5559.7 5513.6 5518.7 5572.7 5576.4 5648.0 4768.0 5035.6 5040.9 5058.5 5062.9 4967.0 5087.2 5094.5 5169.6 5173.8 4872.2 5027.9 5033.4 5050.9 5094.6 5063.1 5071.7 5078.0 5086.2 5109.5 4831.2 4946.1 5027.6 5051.1 5067.2 5317.1 5403.2 5425.6 5428.5 5433.6 6118.1 6140.0 6140.3 6140.5 6143.9 5803.1 5923.4 5930.5 6142.0 6185.3 5648.9 5705.6 5709.6 5711.1 5714.3 6163.0 6164.4 6184.7 6188.7 6190.2 5758.9 5833.3 5909.8 5952.2 5980.8 6069.2 6083.4 6090.6 6094.1 6096.7 6043.2 6048.6 6050.5 6057.8 6058.6 5731.5 5885.4 5924.2 5992.1 6029.4 4513.8 4548.4 4566.2 4581.9 4596.7 3985.9 4060.6 4080.2 4092.4 4114.9 5590.6 5606.1 5644.8 5666.6 5704.0 6045.0 6061.7 6071.7 6072.6 6073.8 5600.2 5723.1 5736.1 5738.0 5751.4 5122.2 5189.7 5201.1 5205.2 5232.1 6223.7 6227.6 6228.3 6230.8 6231.6 5809.5 5922.1 6003.0 6010.3 6026.3 6067.2 6072.8 6081.9 6086.5 6102.7 5780.5 5789.8 5793.8 5801.7 5818.6 5878.7 5887.9 5905.5 5984.6 6004.2 5854.5 5855.2 5861.7 5876.0 5877.7 5841.7 5842.2 5843.3 5844.2 5849.4 5673.4 5674.1 5756.8 5789.3 5798.4 5719.0 5739.1 5746.3 5749.0 5795.4 5607.2 5623.9 5631.2 5632.9 5646.4 13:07:58 INFO - 2015-11-15 13:07:58,780 DEBUG : BROWSER_OUTPUT: 13:07:58 INFO - 2015-11-15 13:07:58,780 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47852.26 Median:31629.19 stddev:80224.78 (253.6%) stddev-sans-first:80371.25 13:07:58 INFO - 2015-11-15 13:07:58,781 DEBUG : BROWSER_OUTPUT: Values: 562.7 594.3 597.6 599.6 612.3 31344.5 40175.4 41133.4 41148.8 41204.0 44028.8 44677.1 44749.3 44763.6 44823.1 7678.7 7817.8 8616.5 8743.3 8750.0 10506.4 10735.9 10741.5 10745.0 10747.5 10414.7 10477.5 10499.6 10502.5 10515.5 7779.8 7895.4 10387.2 10561.2 10852.4 10295.7 10404.3 10421.6 10436.1 10443.5 33448.2 40967.0 41458.8 41505.4 41507.4 2808.3 2879.7 3369.0 3542.7 4065.0 30423.1 30575.7 30983.0 31159.4 31859.0 3365.5 3455.9 3493.3 3502.7 3571.2 286432.0 287394.0 287686.0 288152.6 288576.0 60492.0 60782.4 60840.4 60885.0 60901.4 66280.7 66806.7 66808.3 66960.7 67004.3 15027.5 15368.4 15432.8 15441.8 15540.3 12299.7 12493.5 12493.8 12502.6 12528.9 19807.2 20558.5 20654.5 20657.8 20666.2 7532.7 7589.0 7646.6 7702.7 7801.6 924.8 979.4 993.5 1006.4 1115.3 28165.4 28486.0 28555.9 29066.3 29546.4 931.0 1026.1 1039.6 1056.7 1118.9 12826.5 14400.2 14734.3 14895.4 15251.0 349498.0 353983.0 355033.0 355331.0 355632.0 44305.6 44810.6 50812.0 53200.0 53528.5 1321.3 1328.0 1342.7 1356.2 1368.2 27758.3 28255.9 28582.3 28939.2 29188.1 43836.0 44524.3 49713.5 50272.7 50456.7 268657.0 271419.0 271437.0 274290.0 274425.0 30987.7 31215.5 31347.5 31377.2 31399.4 43570.0 44146.3 44199.0 44584.0 44974.3 36662.5 36827.4 37204.0 37507.0 38232.6 37304.4 37325.6 37518.0 37774.8 38151.0 36476.6 36501.3 36782.0 36810.8 36866.0 29640.3 30250.4 31062.8 31208.8 31232.7 23547.0 23892.5 24668.4 24742.4 25019.0 13:07:58 INFO - 2015-11-15 13:07:58,782 DEBUG : BROWSER_OUTPUT: 13:07:58 INFO - 2015-11-15 13:07:58,782 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26623.70 Median:447.09 stddev:84630.00 (18929.1%) stddev-sans-first:84844.40 13:07:58 INFO - 2015-11-15 13:07:58,783 DEBUG : BROWSER_OUTPUT: Values: 342.7 343.6 344.2 345.3 352.2 13899.7 14198.6 16339.2 16973.6 17075.4 15211.2 16996.2 17145.0 17183.7 17769.2 5314.1 5429.1 5434.3 5435.3 5438.3 4073.0 4187.4 5372.9 5394.9 5875.0 5975.5 6002.6 6017.5 6029.5 6033.7 4934.3 5023.8 5034.1 5040.2 6090.7 4339.8 4342.3 4346.3 4346.7 4348.4 13968.2 14083.2 14417.6 14441.0 14462.9 1944.9 1946.1 1968.0 2003.4 2148.5 9966.0 10190.1 10287.3 10350.7 10427.4 1773.1 1807.7 1808.9 1822.4 1874.6 59425.1 59920.4 60832.7 61073.4 62106.0 6891.2 7040.5 7076.9 7079.7 7121.6 8340.6 8342.2 8352.2 8362.9 8372.0 5557.2 5599.5 5612.1 5636.8 5647.9 5944.6 5966.5 5969.9 5975.9 5999.0 3266.5 3272.5 3279.5 3281.6 3299.0 1142.4 1171.0 1191.9 1200.5 1237.0 435.7 443.8 450.4 452.5 456.6 10410.4 11444.8 11709.5 12150.8 12314.8 460.8 466.6 466.6 475.5 477.5 6397.1 6610.8 6632.5 6706.6 6743.5 504828.0 505863.0 506192.0 528385.0 533148.0 75084.6 77928.6 78628.0 81029.6 81610.6 529.4 532.4 535.7 536.8 537.2 10871.1 11161.4 11205.7 11541.6 11874.6 35862.1 37154.0 37288.0 37629.6 38160.6 47516.5 48938.5 49023.3 49135.3 49267.3 6507.0 6648.9 6649.9 6659.5 6838.4 11197.7 11432.7 11561.7 11564.5 11625.9 9988.4 10024.9 10174.6 10222.6 10259.3 10116.8 10732.9 10744.6 10789.2 10909.2 9150.4 10967.4 11256.2 11292.2 11314.2 6815.5 6824.1 6843.7 6881.1 6885.1 10882.5 10923.2 10992.3 11101.3 11121.9 13:07:58 INFO - 2015-11-15 13:07:58,783 DEBUG : BROWSER_OUTPUT: 13:07:58 INFO - 2015-11-15 13:07:58,784 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5315.76 Median:6393.70 stddev:2782.85 (43.5%) stddev-sans-first:2774.55 13:07:58 INFO - 2015-11-15 13:07:58,785 DEBUG : BROWSER_OUTPUT: Values: 1332.6 1657.5 1708.8 1756.2 1765.8 6658.1 7367.4 7460.3 7499.9 7527.4 7374.7 7476.5 7514.1 7525.6 7534.9 1848.3 1873.4 2246.1 2247.6 2283.0 2288.3 2296.7 2299.2 2299.6 2301.9 2158.5 2162.0 2162.4 2163.5 2165.4 1937.6 1973.7 2185.6 2209.5 2225.4 2202.1 2207.2 2237.8 2248.9 2250.4 7548.0 7648.5 7657.9 7660.8 7665.0 4584.4 4657.4 4677.6 4680.1 4683.9 2907.2 2940.9 2943.2 2978.2 3042.8 956.4 956.6 968.8 969.5 996.5 10462.9 10465.1 10469.3 10478.7 10491.3 4213.5 4317.8 4354.9 4357.5 4396.4 9053.8 9104.0 9108.1 9114.8 9115.4 4700.3 4718.4 4721.5 4726.5 4738.5 4282.4 4305.3 4312.0 4315.1 4315.6 3574.9 3582.9 3593.2 3612.2 3651.4 1174.9 1177.0 1181.7 1193.3 1201.7 1019.2 1041.4 1043.5 1144.2 1280.4 7159.2 7198.6 7249.3 7252.4 7254.1 479.2 481.7 482.8 486.2 497.0 5221.3 5234.6 5284.6 5289.7 5296.5 8831.9 8909.2 9210.6 9231.3 9284.7 9111.4 9203.3 9216.1 9225.2 9226.7 6982.2 7071.1 7195.4 7203.0 7204.8 6645.7 6667.0 6678.4 6679.1 6701.2 7885.4 8011.3 8175.1 8254.1 8259.2 8100.5 8297.1 8303.0 8437.9 8442.2 6753.7 6762.0 6794.9 6841.1 6853.5 7245.1 7411.1 7411.3 7417.7 7424.4 6812.7 6959.4 7019.9 7085.1 7101.0 5956.6 6258.5 6809.2 6903.3 6971.4 6919.7 6960.4 6966.1 6967.0 6974.6 6317.4 6394.0 6394.2 6398.3 6439.1 6355.9 6384.5 6393.4 6396.3 6403.4 13:07:58 INFO - 2015-11-15 13:07:58,785 DEBUG : BROWSER_OUTPUT: 13:07:58 INFO - 2015-11-15 13:07:58,785 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5360.03 Median:6165.85 stddev:1625.97 (26.4%) stddev-sans-first:1585.82 13:07:58 INFO - 2015-11-15 13:07:58,785 DEBUG : BROWSER_OUTPUT: Values: 314.9 317.3 323.5 325.4 328.1 6045.2 6118.7 6129.3 6145.0 6219.1 6067.5 6074.2 6080.9 6081.7 6084.0 4443.1 4521.4 4532.3 4648.8 4662.1 4638.4 4647.8 4665.1 4674.2 4679.1 4609.3 4610.1 4612.0 4612.5 4617.7 4390.9 4511.4 4515.4 4580.7 4627.5 3997.6 4013.9 4014.6 4015.9 4033.4 5705.4 5720.0 5720.1 5727.9 5731.7 5229.6 5335.1 5340.0 5351.4 5365.7 6387.5 6394.5 6404.2 6406.3 6408.7 4445.2 4450.6 4451.6 4452.4 4453.0 6640.9 6643.7 6645.1 6651.2 6655.2 4469.4 4529.0 4551.8 4560.0 4564.6 4613.8 4614.5 4618.9 4623.4 4632.4 5348.2 5354.7 5357.1 5358.0 5359.3 6502.1 6502.1 6502.6 6508.6 6511.5 1553.1 1597.8 1598.9 1599.2 1600.8 1028.9 1054.8 1056.3 1072.6 1075.6 6185.2 6188.8 6192.1 6198.7 6202.0 6529.0 6540.6 6546.6 6550.7 6553.4 6066.4 6153.2 6192.9 6199.8 6200.6 3567.4 3594.0 3601.2 3603.2 3609.6 6914.0 6916.4 6916.5 6918.0 6919.5 6693.8 6795.6 6805.6 6807.4 6824.8 6842.0 6855.0 6887.9 6890.3 6891.4 6594.7 6601.0 6604.4 6616.7 6616.8 6422.3 6555.4 6556.3 6567.5 6580.6 6862.7 6878.0 6879.1 6896.8 6897.9 4467.6 4470.9 4470.9 4475.2 4476.3 6546.6 6596.2 6606.5 6609.2 6612.9 6230.5 6406.5 6408.4 6408.6 6410.8 6374.9 6375.6 6376.3 6384.0 6389.7 6178.5 6283.6 6287.0 6301.3 6301.7 6404.2 6406.5 6416.9 6422.5 6423.4 6213.9 6231.5 6259.6 6261.4 6263.9 13:07:58 INFO - 2015-11-15 13:07:58,785 DEBUG : BROWSER_OUTPUT: 13:07:58 INFO - 2015-11-15 13:07:58,785 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14128.06 Median:470.37 stddev:16296.08 (3464.5%) stddev-sans-first:16310.86 13:07:58 INFO - 2015-11-15 13:07:58,787 DEBUG : BROWSER_OUTPUT: Values: 757.8 762.2 768.6 782.3 810.8 13215.1 13423.0 16078.8 16080.3 16373.3 14967.6 15024.6 15060.9 15061.5 15065.9 683.1 839.9 847.9 849.8 850.3 678.3 825.0 827.4 831.0 832.2 873.9 880.1 880.1 880.7 881.6 693.0 693.4 859.9 878.3 883.6 633.0 634.6 635.4 637.7 642.2 14284.4 14382.9 14413.7 14476.1 14479.5 12506.4 12819.8 13268.7 13287.7 13506.1 10093.4 10143.6 10206.9 11815.6 11903.1 3619.3 3692.9 3712.2 3779.5 3879.4 45265.5 46314.5 51741.0 52113.5 52141.0 9992.0 10252.8 10411.3 10490.7 10902.8 18775.5 18824.0 18824.6 18831.3 18839.1 7605.2 7677.8 7881.5 8130.6 8346.3 4389.5 4454.3 4509.7 4525.0 4586.0 3178.9 3202.2 3204.9 3211.5 3213.1 463.0 470.1 470.7 473.1 475.9 668.6 685.6 697.7 699.7 715.8 8592.2 8631.8 8654.2 8730.0 9223.9 568.6 679.5 696.6 696.7 706.2 3949.2 4099.9 4164.4 4353.1 4498.0 58694.0 58949.7 59113.7 59410.7 59584.1 50149.2 50357.2 50425.7 51849.5 53684.7 44001.0 44431.3 44526.1 44962.3 46364.8 8193.7 8406.3 8885.6 8943.0 9170.9 35847.5 36596.6 36932.3 37487.1 37530.8 44422.6 47305.5 47722.0 47891.7 48018.5 8224.4 8284.0 8290.4 8291.3 8528.8 12566.9 12814.9 12818.2 12876.5 13011.9 11021.0 11579.7 11603.7 11672.5 11973.3 11687.4 12124.4 12299.3 12694.2 12696.2 10263.0 10482.1 10502.5 10641.4 10863.1 9484.4 9598.8 9944.9 10077.9 10296.5 8656.4 8843.2 9336.6 9505.7 9579.7 13:07:58 INFO - 2015-11-15 13:07:58,787 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:07:58 INFO - 2015-11-15 13:07:58,787 DEBUG : BROWSER_OUTPUT: 13:07:59 INFO - 2015-11-15 13:07:59,508 INFO : Browser exited with error code: 0 13:07:59 INFO - 2015-11-15 13:07:59,524 INFO : Completed test dromaeo_css (00:18:32) 13:07:59 INFO - 2015-11-15 13:07:59,524 INFO : Starting test kraken 13:07:59 INFO - 2015-11-15 13:07:59,524 DEBUG : operating with platform_type : linux_ 13:07:59 INFO - 2015-11-15 13:07:59,524 INFO : Initialising browser for kraken test... 13:07:59 INFO - 2015-11-15 13:07:59,530 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKAdGcY/profile http://localhost:60129/getInfo.html 13:08:03 INFO - 2015-11-15 13:08:03,312 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:08:03 INFO - 2015-11-15 13:08:03,312 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:08:03 INFO - 2015-11-15 13:08:03,312 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:08:03 INFO - 2015-11-15 13:08:03,312 DEBUG : BROWSER_OUTPUT: __metrics 13:08:03 INFO - 2015-11-15 13:08:03,409 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:08:04 INFO - 2015-11-15 13:08:04,699 INFO : Browser initialized. 13:08:04 INFO - 2015-11-15 13:08:04,699 INFO : Running cycle 1/1 for kraken test... 13:08:04 INFO - 2015-11-15 13:08:04,700 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKAdGcY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:08:16 INFO - 2015-11-15 13:08:16,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 141803520 13:08:16 INFO - 2015-11-15 13:08:16,484 DEBUG : BROWSER_OUTPUT: 13:08:18 INFO - 2015-11-15 13:08:18,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60129/tests/kraken/driver.html?testName=audio-beat-detection) 13:08:19 INFO - 2015-11-15 13:08:19,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 181125120 13:08:19 INFO - 2015-11-15 13:08:19,512 DEBUG : BROWSER_OUTPUT: 13:08:22 INFO - 2015-11-15 13:08:22,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60129/tests/kraken/driver.html?testName=audio-dft) 13:08:22 INFO - 2015-11-15 13:08:22,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 168411136 13:08:22 INFO - 2015-11-15 13:08:22,701 DEBUG : BROWSER_OUTPUT: 13:08:25 INFO - 2015-11-15 13:08:25,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60129/tests/kraken/driver.html?testName=audio-fft) 13:08:26 INFO - 2015-11-15 13:08:26,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 150757376 13:08:26 INFO - 2015-11-15 13:08:26,132 DEBUG : BROWSER_OUTPUT: 13:08:28 INFO - 2015-11-15 13:08:28,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60129/tests/kraken/driver.html?testName=audio-oscillator) 13:08:28 INFO - 2015-11-15 13:08:28,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 153460736 13:08:28 INFO - 2015-11-15 13:08:28,644 DEBUG : BROWSER_OUTPUT: 13:08:30 INFO - 2015-11-15 13:08:30,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60129/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:08:31 INFO - 2015-11-15 13:08:31,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 156725248 13:08:31 INFO - 2015-11-15 13:08:31,344 DEBUG : BROWSER_OUTPUT: 13:08:34 INFO - 2015-11-15 13:08:34,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60129/tests/kraken/driver.html?testName=imaging-darkroom) 13:08:34 INFO - 2015-11-15 13:08:34,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 156160000 13:08:34 INFO - 2015-11-15 13:08:34,875 DEBUG : BROWSER_OUTPUT: 13:08:38 INFO - 2015-11-15 13:08:38,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60129/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:38 INFO - 2015-11-15 13:08:38,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 157016064 13:08:38 INFO - 2015-11-15 13:08:38,813 DEBUG : BROWSER_OUTPUT: 13:08:41 INFO - 2015-11-15 13:08:41,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60129/tests/kraken/driver.html?testName=json-parse-financial) 13:08:42 INFO - 2015-11-15 13:08:42,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 156905472 13:08:42 INFO - 2015-11-15 13:08:42,176 DEBUG : BROWSER_OUTPUT: 13:08:43 INFO - 2015-11-15 13:08:43,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60129/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:44 INFO - 2015-11-15 13:08:44,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 164921344 13:08:44 INFO - 2015-11-15 13:08:44,290 DEBUG : BROWSER_OUTPUT: 13:08:46 INFO - 2015-11-15 13:08:46,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60129/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:46 INFO - 2015-11-15 13:08:46,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 163909632 13:08:46 INFO - 2015-11-15 13:08:46,685 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-15 13:08:48,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60129/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:49 INFO - 2015-11-15 13:08:49,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 175505408 13:08:49 INFO - 2015-11-15 13:08:49,335 DEBUG : BROWSER_OUTPUT: 13:08:51 INFO - 2015-11-15 13:08:51,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:52 INFO - 2015-11-15 13:08:52,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 180867072 13:08:52 INFO - 2015-11-15 13:08:52,312 DEBUG : BROWSER_OUTPUT: 13:08:54 INFO - 2015-11-15 13:08:54,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:55 INFO - 2015-11-15 13:08:55,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 179531776 13:08:55 INFO - 2015-11-15 13:08:55,394 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60129/tests/kraken/driver.html?testName=ai-astar) 13:08:57 INFO - 2015-11-15 13:08:57,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 239071232 13:08:57 INFO - 2015-11-15 13:08:57,306 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,306 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:08:57 INFO - 2015-11-15 13:08:57,306 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:08:57 INFO - 2015-11-15 13:08:57,307 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:08:57 INFO - 2015-11-15 13:08:57,307 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:08:57 INFO - 2015-11-15 13:08:57,307 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;106;110;112;113;99;109;109;109 13:08:57 INFO - 2015-11-15 13:08:57,307 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;127;147;173;129;156;147;129;170;124 13:08:57 INFO - 2015-11-15 13:08:57,307 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;159;161;160;158;161;163;160;162 13:08:57 INFO - 2015-11-15 13:08:57,307 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;84;89;72;72;72;119;89;72 13:08:57 INFO - 2015-11-15 13:08:57,308 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;136;90;90;90;142;89;90;134 13:08:57 INFO - 2015-11-15 13:08:57,308 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;108;109;109;109;109;109 13:08:57 INFO - 2015-11-15 13:08:57,308 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;145;145;145;146;146;145;146 13:08:57 INFO - 2015-11-15 13:08:57,308 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;95 13:08:57 INFO - 2015-11-15 13:08:57,308 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;56;57;57;57;56;64;53;55 13:08:57 INFO - 2015-11-15 13:08:57,308 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;68;69;69;74;69;69 13:08:57 INFO - 2015-11-15 13:08:57,308 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;88;87;85;85;84;84;84;86;87 13:08:57 INFO - 2015-11-15 13:08:57,309 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;123;126;113;122;114;123;118;119;115 13:08:57 INFO - 2015-11-15 13:08:57,309 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;160;150;147;148;137;146;147;148;138 13:08:57 INFO - 2015-11-15 13:08:57,309 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;66;66;65;65;65;67;65;65;65 13:08:57 INFO - 2015-11-15 13:08:57,309 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:08:57 INFO - 2015-11-15 13:08:57,310 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:08:57 INFO - 2015-11-15 13:08:57,310 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,901 13:08:57 INFO - 2015-11-15 13:08:57,310 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:08:57 INFO - 2015-11-15 13:08:57,310 DEBUG : BROWSER_OUTPUT: __startTimestamp1447621737300__endTimestamp 13:08:57 INFO - 2015-11-15 13:08:57,310 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,311 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:08:57 INFO - 2015-11-15 13:08:57,311 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:08:57 INFO - 2015-11-15 13:08:57,311 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,311 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:110.50 stddev:3.92 (3.5%) stddev-sans-first:4.15 13:08:57 INFO - 2015-11-15 13:08:57,311 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 106.0 110.0 112.0 113.0 99.0 109.0 109.0 109.0 13:08:57 INFO - 2015-11-15 13:08:57,312 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,312 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.00 Median:147.50 stddev:17.71 (12.0%) stddev-sans-first:18.75 13:08:57 INFO - 2015-11-15 13:08:57,312 DEBUG : BROWSER_OUTPUT: Values: 148.0 127.0 147.0 173.0 129.0 156.0 147.0 129.0 170.0 124.0 13:08:57 INFO - 2015-11-15 13:08:57,312 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,312 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 13:08:57 INFO - 2015-11-15 13:08:57,313 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 159.0 161.0 160.0 158.0 161.0 163.0 160.0 162.0 13:08:57 INFO - 2015-11-15 13:08:57,313 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,313 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:72.50 stddev:15.09 (20.8%) stddev-sans-first:15.69 13:08:57 INFO - 2015-11-15 13:08:57,313 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 84.0 89.0 72.0 72.0 72.0 119.0 89.0 72.0 13:08:57 INFO - 2015-11-15 13:08:57,313 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,315 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.30 Median:90.00 stddev:22.89 (25.4%) stddev-sans-first:23.76 13:08:57 INFO - 2015-11-15 13:08:57,315 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 136.0 90.0 90.0 90.0 142.0 89.0 90.0 134.0 13:08:57 INFO - 2015-11-15 13:08:57,315 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,315 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 13:08:57 INFO - 2015-11-15 13:08:57,315 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 108.0 109.0 109.0 109.0 109.0 109.0 13:08:57 INFO - 2015-11-15 13:08:57,315 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,316 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:08:57 INFO - 2015-11-15 13:08:57,316 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 13:08:57 INFO - 2015-11-15 13:08:57,316 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,316 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:08:57 INFO - 2015-11-15 13:08:57,316 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 13:08:57 INFO - 2015-11-15 13:08:57,317 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,317 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:2.83 (5.0%) stddev-sans-first:2.98 13:08:57 INFO - 2015-11-15 13:08:57,317 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 56.0 57.0 57.0 57.0 56.0 64.0 53.0 55.0 13:08:57 INFO - 2015-11-15 13:08:57,317 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,317 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:1.79 (2.6%) stddev-sans-first:1.86 13:08:57 INFO - 2015-11-15 13:08:57,318 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 68.0 69.0 69.0 74.0 69.0 69.0 13:08:57 INFO - 2015-11-15 13:08:57,318 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,318 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.50 stddev:1.43 (1.7%) stddev-sans-first:1.51 13:08:57 INFO - 2015-11-15 13:08:57,318 DEBUG : BROWSER_OUTPUT: Values: 85.0 88.0 87.0 85.0 85.0 84.0 84.0 84.0 86.0 87.0 13:08:57 INFO - 2015-11-15 13:08:57,318 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,318 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:122.00 stddev:4.40 (3.6%) stddev-sans-first:4.58 13:08:57 INFO - 2015-11-15 13:08:57,319 DEBUG : BROWSER_OUTPUT: Values: 122.0 123.0 126.0 113.0 122.0 114.0 123.0 118.0 119.0 115.0 13:08:57 INFO - 2015-11-15 13:08:57,319 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,319 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:147.50 stddev:7.05 (4.8%) stddev-sans-first:6.72 13:08:57 INFO - 2015-11-15 13:08:57,319 DEBUG : BROWSER_OUTPUT: Values: 137.0 160.0 150.0 147.0 148.0 137.0 146.0 147.0 148.0 138.0 13:08:57 INFO - 2015-11-15 13:08:57,319 DEBUG : BROWSER_OUTPUT: 13:08:57 INFO - 2015-11-15 13:08:57,319 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 13:08:57 INFO - 2015-11-15 13:08:57,319 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 66.0 65.0 65.0 65.0 67.0 65.0 65.0 65.0 13:08:57 INFO - 2015-11-15 13:08:57,321 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:08:57 INFO - 2015-11-15 13:08:57,321 DEBUG : BROWSER_OUTPUT: 13:08:58 INFO - 2015-11-15 13:08:58,092 INFO : Browser exited with error code: 0 13:08:58 INFO - 2015-11-15 13:08:58,146 INFO : Completed test kraken (00:00:58) 13:08:58 INFO - 2015-11-15 13:08:58,147 INFO : Starting test v8_7 13:08:58 INFO - 2015-11-15 13:08:58,147 DEBUG : operating with platform_type : linux_ 13:08:58 INFO - 2015-11-15 13:08:58,147 INFO : Initialising browser for v8_7 test... 13:08:58 INFO - 2015-11-15 13:08:58,153 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZtW7lk/profile http://localhost:60129/getInfo.html 13:09:01 INFO - 2015-11-15 13:09:01,732 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:09:01 INFO - 2015-11-15 13:09:01,732 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:09:01 INFO - 2015-11-15 13:09:01,732 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:09:01 INFO - 2015-11-15 13:09:01,732 DEBUG : BROWSER_OUTPUT: __metrics 13:09:01 INFO - 2015-11-15 13:09:01,848 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:09:03 INFO - 2015-11-15 13:09:03,161 INFO : Browser initialized. 13:09:03 INFO - 2015-11-15 13:09:03,161 INFO : Running cycle 1/1 for v8_7 test... 13:09:03 INFO - 2015-11-15 13:09:03,162 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZtW7lk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:09:14 INFO - 2015-11-15 13:09:14,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 140742656 13:09:14 INFO - 2015-11-15 13:09:14,923 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60129/tests/v8_7/run.html (next: http://localhost:60129/tests/v8_7/run.html) 13:09:36 INFO - 2015-11-15 13:09:36,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 612302848 13:09:36 INFO - 2015-11-15 13:09:36,621 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,622 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:09:36 INFO - 2015-11-15 13:09:36,622 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:09:36 INFO - 2015-11-15 13:09:36,622 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:09:36 INFO - 2015-11-15 13:09:36,622 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:09:36 INFO - 2015-11-15 13:09:36,622 DEBUG : BROWSER_OUTPUT: |0;Richards;170.38677798602828 13:09:36 INFO - 2015-11-15 13:09:36,622 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.3238308179616 13:09:36 INFO - 2015-11-15 13:09:36,622 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.37310073157005 13:09:36 INFO - 2015-11-15 13:09:36,622 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 13:09:36 INFO - 2015-11-15 13:09:36,623 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1957.03125 13:09:36 INFO - 2015-11-15 13:09:36,623 DEBUG : BROWSER_OUTPUT: |5;Earley;801.2820512820513 13:09:36 INFO - 2015-11-15 13:09:36,623 DEBUG : BROWSER_OUTPUT: |6;Boyer;12060.240963855422 13:09:36 INFO - 2015-11-15 13:09:36,623 DEBUG : BROWSER_OUTPUT: |7;RegExp;25450 13:09:36 INFO - 2015-11-15 13:09:36,623 DEBUG : BROWSER_OUTPUT: |8;Splay;634.5177664974619 13:09:36 INFO - 2015-11-15 13:09:36,623 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 13:09:36 INFO - 2015-11-15 13:09:36,623 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:09:36 INFO - 2015-11-15 13:09:36,623 DEBUG : BROWSER_OUTPUT: __startTimestamp1447621776615__endTimestamp 13:09:36 INFO - 2015-11-15 13:09:36,624 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,624 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:09:36 INFO - 2015-11-15 13:09:36,624 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:09:36 INFO - 2015-11-15 13:09:36,624 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,624 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.39 Median:170.39 stddev:0.00 (0.0%) 13:09:36 INFO - 2015-11-15 13:09:36,624 DEBUG : BROWSER_OUTPUT: Values: 170.4 13:09:36 INFO - 2015-11-15 13:09:36,624 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,624 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.32 Median:186.32 stddev:0.00 (0.0%) 13:09:36 INFO - 2015-11-15 13:09:36,625 DEBUG : BROWSER_OUTPUT: Values: 186.3 13:09:36 INFO - 2015-11-15 13:09:36,625 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,625 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 13:09:36 INFO - 2015-11-15 13:09:36,625 DEBUG : BROWSER_OUTPUT: Values: 281.4 13:09:36 INFO - 2015-11-15 13:09:36,625 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,625 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 13:09:36 INFO - 2015-11-15 13:09:36,625 DEBUG : BROWSER_OUTPUT: Values: 5045.2 13:09:36 INFO - 2015-11-15 13:09:36,626 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,626 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1957.03 Median:1957.03 stddev:0.00 (0.0%) 13:09:36 INFO - 2015-11-15 13:09:36,626 DEBUG : BROWSER_OUTPUT: Values: 1957.0 13:09:36 INFO - 2015-11-15 13:09:36,626 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,626 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:801.28 Median:801.28 stddev:0.00 (0.0%) 13:09:36 INFO - 2015-11-15 13:09:36,626 DEBUG : BROWSER_OUTPUT: Values: 801.3 13:09:36 INFO - 2015-11-15 13:09:36,626 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,626 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12060.24 Median:12060.24 stddev:0.00 (0.0%) 13:09:36 INFO - 2015-11-15 13:09:36,627 DEBUG : BROWSER_OUTPUT: Values: 12060.2 13:09:36 INFO - 2015-11-15 13:09:36,627 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,627 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 13:09:36 INFO - 2015-11-15 13:09:36,627 DEBUG : BROWSER_OUTPUT: Values: 25450.0 13:09:36 INFO - 2015-11-15 13:09:36,627 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,627 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:634.52 Median:634.52 stddev:0.00 (0.0%) 13:09:36 INFO - 2015-11-15 13:09:36,627 DEBUG : BROWSER_OUTPUT: Values: 634.5 13:09:36 INFO - 2015-11-15 13:09:36,627 DEBUG : BROWSER_OUTPUT: 13:09:36 INFO - 2015-11-15 13:09:36,628 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 13:09:36 INFO - 2015-11-15 13:09:36,628 DEBUG : BROWSER_OUTPUT: Values: 4822.1 13:09:36 INFO - 2015-11-15 13:09:36,628 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:09:36 INFO - 2015-11-15 13:09:36,628 DEBUG : BROWSER_OUTPUT: 13:09:37 INFO - 2015-11-15 13:09:37,504 INFO : Browser exited with error code: 0 13:09:37 INFO - 2015-11-15 13:09:37,521 INFO : Completed test v8_7 (00:00:39) 13:09:37 INFO - 2015-11-15 13:09:37,576 INFO : Completed test suite (00:20:10) 13:09:37 INFO - 2015-11-15 13:09:37,576 DEBUG : Working with test: dromaeo_css 13:09:37 INFO - 2015-11-15 13:09:37,576 DEBUG : Generating results file: dromaeo_css 13:09:37 INFO - 2015-11-15 13:09:37,577 DEBUG : Working with test: kraken 13:09:37 INFO - 2015-11-15 13:09:37,577 DEBUG : Generating results file: kraken 13:09:37 INFO - 2015-11-15 13:09:37,577 INFO : javascript benchmark 13:09:37 INFO - 2015-11-15 13:09:37,578 DEBUG : Working with test: v8_7 13:09:37 INFO - 2015-11-15 13:09:37,578 DEBUG : Generating results file: v8_7 13:09:37 INFO - 2015-11-15 13:09:37,578 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:09:37 INFO - 2015-11-15 13:09:37,714 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 13:09:37 INFO - 2015-11-15 13:09:37,715 DEBUG : process_Request line: dromaeo_css 6785.87 graph.html#tests=[[72,1,35]] 13:09:37 INFO - 2015-11-15 13:09:37,715 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:09:37 INFO - 2015-11-15 13:09:37,760 DEBUG : process_Request line: kraken 1491.80 graph.html#tests=[[232,1,35]] 13:09:37 INFO - 2015-11-15 13:09:37,760 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:09:37 INFO - 2015-11-15 13:09:37,870 DEBUG : process_Request line: v8_7 19822.59 graph.html#tests=[[230,1,35]] 13:09:37 INFO - 2015-11-15 13:09:37,872 INFO : javascript benchmark 13:09:37 INFO - 2015-11-15 13:09:37,875 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [342.7001373797926, 343.6426116838488, 344.2048867116959, 345.33178299989504, 352.22510476950714, 13899.722005559908, 14198.645033874158, 16339.183040847955, 16973.57566060849, 17075.402360917356, 15211.23943802811, 16996.235169417374, 17145.0, 17183.74224386632, 17769.20038598263, 5314.07003774339, 5429.077056900317, 5434.3207099112615, 5435.266239057736, 5438.3473983121885, 4072.9592704073025, 4187.392828039948, 5372.865678358034, 5394.91907621386, 5875.0, 5975.492083172936, 6002.579819412643, 6017.48851347636, 6029.547783916202, 6033.728482218289, 4934.309196712463, 5023.799048038074, 5034.119029169899, 5040.243963405482, 6090.695465226743, 4339.826406943718, 4342.305231162999, 4346.304591265382, 4346.695731298811, 4348.434703488558, 13968.231747253896, 14083.155010699391, 14417.639559011004, 14441.0, 14462.855371446361, 1944.912478938437, 1946.0950657944124, 1968.045497933501, 2003.4190084875368, 2148.4843637527038, 9966.0, 10190.133838623726, 10287.331323463952, 10350.689479315633, 10427.374357538572, 1773.1134432783608, 1807.7469154318405, 1808.9005104719236, 1822.3844764984879, 1874.578219900525, 59425.10862337025, 59920.40079599192, 60832.69583652098, 61073.38926610722, 62106.0, 6891.241963384024, 7040.5071644984355, 7076.893846592306, 7079.716811327592, 7121.608311542915, 8340.582970851434, 8342.16578342161, 8352.248297653241, 8362.874556881652, 8371.95814020926, 5557.249771280906, 5599.468050535193, 5612.130119831432, 5636.802711905064, 5647.887042259132, 5944.554158438134, 5966.463018328284, 5969.880602387928, 5975.850603734854, 5998.980173370537, 3266.5426840242385, 3272.4600440927456, 3279.508073788903, 3281.6062072551445, 3299.0, 1142.3774043146338, 1171.0, 1191.9284842909453, 1200.4837919694614, 1237.0, 435.7124297963329, 443.8158164361818, 450.36498537062585, 452.5203284518421, 456.6460992730594, 10410.375377477376, 11444.771104577861, 11709.473073711704, 12150.817737733942, 12314.815277770662, 460.75810199645457, 466.5707549054878, 466.6266986410858, 475.5030992612728, 477.4557005014286, 6397.136386587844, 6610.8347291318105, 6632.469402447792, 6706.5640733352175, 6743.52795304324, 504828.0, 505863.0, 506192.0, 528385.0, 533148.0, 75084.62457687677, 77928.61035694786, 78628.0, 81029.59485202536, 81610.59194703988, 529.4467281690643, 532.3585079978617, 535.686623325359, 536.8469986054034, 537.1754357061891, 10871.130309575057, 11161.386123762946, 11205.719857003314, 11541.596044138414, 11874.584389546324, 35862.103447414025, 37154.0, 37288.0, 37629.623703763704, 38160.618393815705, 47516.52483475121, 48938.51061489482, 49023.26465102955, 49135.26297105475, 49267.26099108445, 6506.967465162644, 6648.9002664961035, 6649.933500664932, 6659.500537459613, 6838.418734407631, 11197.66407007791, 11432.714182145513, 11561.7109572258, 11564.537418503165, 11625.88374116248, 9988.400695958266, 10024.899751002687, 10174.593016279267, 10222.6422075227, 10259.281850270409, 10116.797664046531, 10732.892671073188, 10744.570217191538, 10789.190810689386, 10909.18181136402, 9150.40522366044, 10967.396793176453, 11256.21206515536, 11292.209545331747, 11314.15143864197, 6815.488838337045, 6824.112865327675, 6843.692033858389, 6881.10545629085, 6885.1049363582415, 10882.510287036945, 10923.180761442765, 10992.28550144238, 11101.333919964827, 11121.88878111241], "dojo.html": [3208.4866421372585, 3252.36578867121, 3290.506424036394, 3298.9340213195737, 3310.05663385935, 5408.594355423349, 5497.422770609089, 5500.339959204896, 5512.062949298619, 5559.722013899304, 5513.558915286778, 5518.668879867211, 5572.749226284816, 5576.442355764431, 5648.011597970349, 4768.028395583131, 5035.597152227831, 5040.899182016357, 5058.494150584949, 5062.9240561391425, 4967.00659868026, 5087.236914462842, 5094.51602097802, 5169.586433085344, 5173.818916337929, 4872.171730805771, 5027.874303142414, 5033.395992480926, 5050.924236136424, 5094.592432605401, 5063.139266324733, 5071.7210553419545, 5077.974610126963, 5086.160783470723, 5109.489051094898, 4831.227003679394, 4946.08497427977, 5027.622928280393, 5051.065552872694, 5067.189249720064, 5317.12267475866, 5403.189521571757, 5425.647332923348, 5428.511433970962, 5433.592480563934, 6118.051701986199, 6140.0, 6140.263168419773, 6140.50875929929, 6143.938560614426, 5803.129530570406, 5923.407659234085, 5930.466258036754, 6141.969290153521, 6185.288691800455, 5648.943510564883, 5705.6006079574445, 5709.62887412321, 5711.114777209539, 5714.342850572154, 6163.044728067067, 6164.4143806338325, 6184.690765461709, 6188.659623720649, 6190.195274614362, 5758.942410575924, 5833.300003999547, 5909.8227053188475, 5952.226210592596, 5980.820575382745, 6069.2110025696375, 6083.422074902877, 6090.634561926298, 6094.146819445281, 6096.69516524172, 6043.153958445821, 6048.637081775108, 6050.515958723292, 6057.8485537861025, 6058.575899687068, 5731.512821410143, 5885.440883116097, 5924.200232968494, 5992.131140984533, 6029.397060293935, 4513.842015529506, 4548.385967894292, 4566.178087944136, 4581.931271030937, 4596.655250856199, 3985.880423587297, 4060.573639767782, 4080.204360149742, 4092.4066010428323, 4114.855980040684, 5590.552755779528, 5606.103023516218, 5644.774209031592, 5666.631668941505, 5704.030314846486, 6045.032794752907, 6061.727222275008, 6071.6660583667435, 6072.574919755575, 6073.817785466443, 5600.187972743929, 5723.112917497794, 5736.139579063174, 5737.971310143423, 5751.367349591542, 5122.1804511278015, 5189.688618682816, 5201.063808514428, 5205.193195054772, 5232.136697444955, 6223.688815559294, 6227.564070515021, 6228.34602366745, 6230.844228894314, 6231.563790534619, 5809.477147056617, 5922.111683247547, 6003.0, 6010.33886272501, 6026.276846778414, 6067.24159480065, 6072.757089716361, 6081.908771368345, 6086.543509236736, 6102.694865256808, 5780.537556995514, 5789.768409263751, 5793.768249269982, 5801.6519008859605, 5818.592698511064, 5878.735456904364, 5887.852803679943, 5905.498032667271, 5984.640921544721, 6004.249468816398, 5854.531637468907, 5855.23881895368, 5861.706914654165, 5876.0, 5877.706114694333, 5841.678707671119, 5842.152887831156, 5843.29880414353, 5844.211031510862, 5849.444302791228, 5673.404292549388, 5674.120511320752, 5756.769729210785, 5789.2763404574425, 5798.391168927202, 5718.971405142947, 5739.110437882135, 5746.281714785652, 5749.0, 5795.391483894299, 5607.243022191952, 5623.943760562342, 5631.239782629293, 5632.85917852057, 5646.35066967304], "mootools.html": [1332.6335257804108, 1657.511034244898, 1708.7949446066473, 1756.2009285774973, 1765.8145894681059, 6658.067870498128, 7367.373773229276, 7460.253974602537, 7499.887501687465, 7527.360174385184, 7374.705011799535, 7476.514026588268, 7514.0607424071995, 7525.623718814065, 7534.886976695354, 1848.2976468941783, 1873.38178401128, 2246.056656204398, 2247.5954328220914, 2282.995481987928, 2288.2563166970717, 2296.678465014891, 2299.2412503873766, 2299.6435552489306, 2301.9309420717404, 2158.460384903774, 2162.048698572623, 2162.4485756132162, 2163.459135216196, 2165.4261620670536, 1937.6415363157862, 1973.6644770389069, 2185.6284431646577, 2209.4697272654607, 2225.365770755343, 2202.0971401725214, 2207.2385027165765, 2237.765034671352, 2248.898799554024, 2250.437390652337, 7547.962260188719, 7648.541087534766, 7657.923420765776, 7660.770176894702, 7664.961675191644, 4584.358189853423, 4657.4411070671395, 4677.64917631179, 4680.063987202573, 4683.929741053887, 2907.185987923385, 2940.911772646824, 2943.1906225787866, 2978.1512269003447, 3042.7870049096573, 956.4070276428658, 956.5695437053354, 968.7868668892833, 969.5103972493916, 996.4519514267124, 10462.895371046345, 10465.110465610433, 10469.319494232926, 10478.685639430829, 10491.318064325871, 4213.452251207324, 4317.762523061199, 4354.912901741947, 4357.54245804186, 4396.406485124531, 9053.77365565866, 9104.0, 9108.134727200906, 9114.772130696785, 9115.407498512708, 4700.341952126705, 4718.41019872516, 4721.457032441244, 4726.480087190406, 4738.549837765407, 4282.421873047098, 4305.31115021595, 4312.029793296483, 4315.136972605429, 4315.633171180422, 3574.9285014299567, 3582.946255806165, 3593.1915319053005, 3612.169201083713, 3651.379265524867, 1174.8707642159357, 1177.0289511153333, 1181.6809461445362, 1193.2721040165493, 1201.7296108375544, 1019.1795604538418, 1041.4480325427535, 1043.4521876015, 1144.187626784992, 1280.3726174174587, 7159.212486626467, 7198.568085914757, 7249.347558719741, 7252.419806415474, 7254.056972593529, 479.1566842357476, 481.73263838569227, 482.7658585585988, 486.2293265174738, 497.04815278740807, 5221.347331583552, 5234.581233501311, 5284.550813180923, 5289.709066001406, 5296.523312901857, 8831.867521987175, 8909.1536304051, 9210.585523651453, 9231.261499080058, 9284.675036373694, 9111.407758495809, 9203.309751768644, 9216.078392160864, 9225.169734723908, 9226.723198304062, 6982.197047339621, 7071.116110486189, 7195.352418282275, 7203.027591275216, 7204.819879503054, 6645.667716614246, 6667.0, 6678.432333251728, 6679.0649309097735, 6701.1623547056615, 7885.408594355332, 8011.319037881845, 8175.059868115005, 8254.092049874389, 8259.21537453941, 8100.473469224482, 8297.08732039463, 8303.04514980785, 8437.915620843713, 8442.240198382175, 6753.729850805913, 6762.0, 6794.898076528757, 6841.110655614738, 6853.4859885507785, 7245.058142441449, 7411.110666720028, 7411.295926886937, 7417.740379086706, 7424.443166762622, 6812.727490900308, 6959.443244540324, 7019.859602808017, 7085.14978202619, 7101.041359416413, 5956.642601443928, 6258.468030217483, 6809.182898052265, 6903.275156108536, 6971.372576468142, 6919.723211071702, 6960.443164546926, 6966.12923384577, 6967.0, 6974.58152510851, 6317.431431171217, 6393.976963685788, 6394.200724909387, 6398.328175541501, 6439.098526206429, 6355.872882542416, 6384.457321127757, 6393.424591786761, 6396.296407395276, 6403.391677790602], "ext.html": [562.7467639562195, 594.2868557730723, 597.575721237921, 599.5862854630304, 612.3386742318297, 31344.529832052536, 40175.39736903945, 41133.38299925504, 41148.794256028756, 41204.0, 44028.77985610067, 44677.106457870825, 44749.32876006854, 44763.552364476345, 44823.1035379293, 7678.692852285902, 7817.76546703597, 8616.526091064989, 8743.344249181306, 8749.95625021874, 10506.369617822917, 10735.892641073606, 10741.462926853665, 10745.032947034766, 10747.516361763739, 10414.687559373193, 10477.476126193698, 10499.632512862052, 10502.527386267637, 10515.52680129396, 7779.76660700177, 7895.368370530344, 10387.22095842811, 10561.155107591374, 10852.403117828517, 10295.742606434898, 10404.271700980935, 10421.635242766542, 10436.060754532129, 10443.477826108665, 33448.16379590506, 40967.0, 41458.79270603628, 41505.377419338736, 41507.377389339184, 2808.3330036006855, 2879.6544414670166, 3368.96631033689, 3542.734294927865, 4065.024394145413, 30423.087307380814, 30575.694243057507, 30983.0, 31159.376812463623, 31859.0, 3365.5456513370627, 3455.8617655293756, 3493.336266109431, 3502.702270307027, 3571.178628915338, 286432.0, 287394.0, 287686.0, 288152.55923720455, 288576.0, 60492.0, 60782.39217607856, 60840.39159608436, 60885.0, 60901.39098609046, 66280.66859665768, 66806.66596667083, 66808.33191668021, 66960.66519667371, 67004.3299566998, 15027.474038408604, 15368.385264589291, 15432.768508472382, 15441.845581544041, 15540.30068646891, 12299.69250768738, 12493.500259989498, 12493.750124997448, 12502.562410315595, 12528.874711252953, 19807.20771169137, 20558.486037849172, 20654.48363790887, 20657.793422065588, 20666.17335306601, 7532.661030253542, 7589.0, 7646.617669116522, 7702.653380597886, 7801.648925798353, 924.7549399409162, 979.4270351844251, 993.4982833668951, 1006.3609607898891, 1115.2806439846415, 28165.43669126647, 28486.0, 28555.857220713762, 29066.27334316659, 29546.40907181844, 930.9674161404319, 1026.08165691707, 1039.6309310194772, 1056.6513050693407, 1118.8713297970676, 12826.486940522274, 14400.20798856052, 14734.263286835616, 14895.404183832525, 15251.0, 349498.0, 353983.0, 355033.0, 355331.0, 355632.0, 44305.55694443079, 44810.55189448064, 50812.0, 53200.0, 53528.46471535235, 1321.3261236769124, 1327.9668008299677, 1342.7113170668158, 1356.2269506381267, 1368.2269517722455, 27758.306042349104, 28255.858720706266, 28582.285442864093, 28939.227124858677, 29188.124356269345, 43836.0, 44524.332135018645, 49713.502864970884, 50272.748636258046, 50456.74771626118, 268657.0, 271419.0, 271437.0, 274290.0, 274425.0, 30987.69012309848, 31215.531767023967, 31347.529787052757, 31377.21556961003, 31399.372012560078, 43570.0, 44146.33780493231, 44199.0, 44584.0, 44974.325385118595, 36662.450063248536, 36827.447588286734, 37204.0, 37507.0, 38232.61767382402, 37304.44043339406, 37325.62674373222, 37518.0, 37774.81112594529, 38151.0, 36476.63523364732, 36501.26997460089, 36782.0, 36810.8159459201, 36866.0, 29640.258993525335, 30250.394992100475, 31062.844685776425, 31208.843955780078, 31232.68767312298, 23547.0, 23892.52214955726, 24668.38329041788, 24742.38144046413, 25019.0], "prototype.html": [314.8964914371994, 317.33201610609666, 323.4888875576589, 325.4126302024844, 328.1042753283536, 6045.214122164118, 6118.724657390417, 6129.295131059929, 6145.047517634763, 6219.129321894939, 6067.544934129935, 6074.240719910012, 6080.908786368197, 6081.695915204233, 6084.0, 4443.089166720831, 4521.367008618796, 4532.274836026237, 4648.837290694826, 4662.13750456165, 4638.4433867935895, 4647.814087436498, 4665.136949664306, 4674.228752255874, 4679.134360143385, 4609.285560738091, 4610.05493873755, 4612.0, 4612.515685852987, 4617.676762626617, 4390.934135987946, 4511.413516242867, 4515.435570553665, 4580.7022543534895, 4627.467841198271, 3997.5802540733093, 4013.8996525086814, 4014.6186112319283, 4015.9196816063513, 4033.3949907513816, 5705.372409035044, 5719.971400142973, 5720.056190728525, 5727.914081288784, 5731.742071606787, 5229.555487783543, 5335.146376579729, 5339.9733001335135, 5351.411344752074, 5365.678059316453, 6387.457066149383, 6394.520410969196, 6404.199475065617, 6406.327335629739, 6408.711607977652, 4445.222086134913, 4450.577195166454, 4451.621612162938, 4452.443444569429, 4452.9554704453185, 6640.867182656368, 6643.734250629921, 6645.06969024337, 6651.201855777289, 6655.234648015444, 4469.351943968171, 4528.954710452919, 4551.817927282872, 4559.99680070384, 4564.6348292136545, 4613.769311534477, 4614.538546145359, 4618.861434156981, 4623.398958135421, 4632.374629425052, 5348.224507446476, 5354.678719276856, 5357.062514060024, 5358.035553600389, 5359.3032905722785, 6502.089707440962, 6502.122213501211, 6502.577332473374, 6508.642024688593, 6511.511636627272, 1553.068159104551, 1597.8162511311116, 1598.936042558308, 1599.224376177553, 1600.8399160083898, 1028.9382637041651, 1054.8417737339307, 1056.2553399853084, 1072.5656109275756, 1075.5590208014676, 6185.195924529782, 6188.783392581238, 6192.071189321638, 6198.675496688742, 6202.007678771375, 6528.967355163289, 6540.640264785387, 6546.607203567706, 6550.705218265094, 6553.4101930826455, 6066.4217707474145, 6153.230846144232, 6192.907106393408, 6199.783007594712, 6200.627962322275, 3567.3578755823683, 3594.0475773919934, 3601.2077342984503, 3603.1892824114366, 3609.5848977367414, 6913.965430172918, 6916.412104971134, 6916.515843890879, 6918.0, 6919.481038922101, 6693.765718199839, 6795.626240556718, 6805.625690587065, 6807.353301436356, 6824.829379265558, 6842.04211410403, 6854.965725171442, 6887.862242755217, 6890.345417185359, 6891.448684105259, 6594.70323835419, 6601.042848786995, 6604.3725846044545, 6616.66916654175, 6616.801495955129, 6422.293547709654, 6555.3772391622715, 6556.3443655634055, 6567.474602031731, 6580.605163690194, 6862.725490980305, 6878.037074809431, 6879.140107486564, 6896.827579310558, 6897.931020689729, 4467.5755803198645, 4470.888227794201, 4470.888227794331, 4475.172093162775, 4476.328550717289, 6546.639934803441, 6596.208454985433, 6606.504512161511, 6609.20689517261, 6612.867742645024, 6230.532710046855, 6406.519511036784, 6408.359164083555, 6408.58344207625, 6410.775622853178, 6374.872502550016, 6375.585586936834, 6376.298607153117, 6384.0, 6389.7124629390855, 6178.474829639351, 6283.622982621057, 6287.0, 6301.338359472373, 6301.747930082929, 6404.231492220963, 6406.455451286693, 6416.903746443713, 6422.454091402096, 6423.357664233539, 6213.9067913982235, 6231.470325022424, 6259.593126446766, 6261.405166509357, 6263.937360626518], "yui.html": [757.7726681995401, 762.2073044034202, 768.596486844407, 782.2568559868123, 810.7648781853261, 13215.141015833977, 13423.0, 16078.7588186177, 16080.276387562559, 16373.345066197367, 14967.625809354771, 15024.624384390396, 15060.924695376536, 15061.472848450307, 15065.92467037666, 683.0505597219868, 839.9202075802789, 847.8812966184709, 849.8045449546609, 850.2772643253217, 678.3284548297199, 824.9876251856197, 827.383599218583, 830.9750707478785, 832.2177153475714, 873.8776571280026, 880.137465284022, 880.1462581296164, 880.7137680253911, 881.576843115305, 692.9965350173242, 693.445243804954, 859.909709480508, 878.3280790195505, 883.6421249394006, 632.9588576742497, 634.6223996721943, 635.3963734452243, 637.6939069246788, 642.2004604267717, 14284.357203925849, 14382.92808535961, 14413.711725765426, 14476.059056161315, 14479.493217737434, 12506.374681265901, 12819.807702884464, 13268.668283292995, 13287.73424531504, 13506.054576179671, 10093.394396336244, 10143.644972426004, 10206.897931020669, 11815.645530634094, 11903.107266955012, 3619.348517266891, 3692.9261414771554, 3712.1556368938523, 3779.527559055118, 3879.3792993121247, 45265.547344526465, 46314.53685463136, 51741.0, 52113.47886521124, 52141.0, 9991.950040249752, 10252.794944101226, 10411.323263987968, 10490.685279441628, 10902.836457453144, 18775.530611734815, 18824.0, 18824.623507529774, 18831.340903068325, 18839.05804709759, 7605.23947605235, 7677.769666910001, 7881.527108373516, 8130.552819594861, 8346.290565301895, 4389.473263208435, 4454.276700859092, 4509.729416235036, 4524.954750452519, 4585.95414045862, 3178.904632861018, 3202.151429871086, 3204.903852884417, 3211.4861622140347, 3213.0682102190103, 462.9722216667011, 470.0903751241359, 470.651717728885, 473.07985967293286, 475.852485729425, 668.5787953589305, 685.6092027544252, 697.745322957117, 699.6536714326339, 715.8138883890122, 8592.183742544448, 8631.78420539479, 8654.177853103945, 8730.0, 9223.907760922439, 568.610501806264, 679.480197648799, 696.6307856835886, 696.738722978883, 706.2337363960161, 3949.150932549458, 4099.877003689894, 4164.41752134187, 4353.06409122034, 4497.977510112429, 58694.0, 58949.70525147347, 59113.70443147843, 59410.70294648586, 59584.10623840646, 50149.24776128361, 50357.244641330406, 50425.74787126114, 51849.48150518446, 53684.73157634265, 44001.0, 44431.33352999708, 44526.10947781091, 44962.32556511655, 46364.768176158905, 8193.71322003727, 8406.28546573548, 8885.555722213734, 8942.955285223532, 9170.908290917005, 35847.46228806518, 36596.63403365932, 36932.261354772214, 37487.06282342963, 37530.812345938095, 44422.555774443135, 47305.52694473011, 47722.0, 47891.675483431434, 48018.5198148014, 8224.424290299621, 8284.0, 8290.419670622998, 8291.33669306466, 8528.829423411622, 12566.874331256571, 12814.935925320313, 12818.230906145662, 12876.484940602646, 13011.934940325238, 11021.0, 11579.710507237387, 11603.651890442963, 11672.47473863695, 11973.281603103842, 11687.415629218674, 12124.393780311126, 12299.262044277371, 12694.174878632859, 12696.238225706487, 10263.0, 10482.109020733018, 10502.474876256309, 10641.414722190353, 10863.135251411933, 9484.430934143973, 9598.808023839345, 9944.850827237453, 10077.949610251902, 10296.536655850356, 8656.350773692124, 8843.204111629726, 9336.579853906454, 9505.66730164441, 9579.712608621752]}, "summary": {"lowerIsBetter": false, "suite": 6785.873711023953, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7084.423363316995, "unit": "ms", "value": 7084.423363316995}, "dojo.html": {"lowerIsBetter": false, "filtered": 5499.629805100425, "unit": "ms", "value": 5499.629805100425}, "mootools.html": {"lowerIsBetter": false, "filtered": 4288.910185448439, "unit": "ms", "value": 4288.910185448439}, "ext.html": {"lowerIsBetter": false, "filtered": 18932.85668994789, "unit": "ms", "value": 18932.85668994789}, "prototype.html": {"lowerIsBetter": false, "filtered": 4821.67918831517, "unit": "ms", "value": 4821.67918831517}, "yui.html": {"lowerIsBetter": false, "filtered": 6400.24908562717, "unit": "ms", "value": 6400.24908562717}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447620566, "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": "20151115103014", "branch": "Firefox", "revision": "7cd2d806bd069c0260ff73f023ac85f892b863bf"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 160.0, 159.0, 161.0, 160.0, 158.0, 161.0, 163.0, 160.0, 162.0], "ai-astar": [109.0, 111.0, 106.0, 110.0, 112.0, 113.0, 99.0, 109.0, 109.0, 109.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 110.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0], "audio-beat-detection": [148.0, 127.0, 147.0, 173.0, 129.0, 156.0, 147.0, 129.0, 170.0, 124.0], "json-stringify-tinderbox": [68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 74.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [137.0, 160.0, 150.0, 147.0, 148.0, 137.0, 146.0, 147.0, 148.0, 138.0], "json-parse-financial": [58.0, 57.0, 56.0, 57.0, 57.0, 57.0, 56.0, 64.0, 53.0, 55.0], "stanford-crypto-sha256-iterative": [64.0, 66.0, 66.0, 65.0, 65.0, 65.0, 67.0, 65.0, 65.0, 65.0], "audio-fft": [73.0, 72.0, 84.0, 89.0, 72.0, 72.0, 72.0, 119.0, 89.0, 72.0], "imaging-darkroom": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "stanford-crypto-ccm": [122.0, 123.0, 126.0, 113.0, 122.0, 114.0, 123.0, 118.0, 119.0, 115.0], "audio-oscillator": [91.0, 91.0, 136.0, 90.0, 90.0, 90.0, 142.0, 89.0, 90.0, 134.0], "stanford-crypto-aes": [85.0, 88.0, 87.0, 85.0, 85.0, 84.0, 84.0, 84.0, 86.0, 87.0], "imaging-desaturate": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1491.8, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.4, "unit": "ms", "value": 81.4}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 145.8, "unit": "ms", "value": 145.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.0, "unit": "ms", "value": 145.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 119.5, "unit": "ms", "value": 119.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.5, "unit": "ms", "value": 145.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.0, "unit": "ms", "value": 57.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.3, "unit": "ms", "value": 104.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.7, "unit": "ms", "value": 108.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.5, "unit": "ms", "value": 160.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 65.3, "unit": "ms", "value": 65.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.1, "unit": "ms", "value": 69.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.0, "unit": "ms", "value": 109.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.5, "unit": "ms", "value": 85.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.2, "unit": "ms", "value": 95.2}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447620566, "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": "20151115103014", "branch": "Firefox", "revision": "7cd2d806bd069c0260ff73f023ac85f892b863bf"}}, {"talos_counters": {}, "results": {"DeltaBlue": [186.3238308179616], "Encrypt": [281.37310073157005], "NavierStokes": [4822.115384615385], "Decrypt": [5045.226130653266], "Splay": [634.5177664974619], "Richards": [170.38677798602828], "RegExp": [25450.0], "Earley": [801.2820512820513], "Boyer": [12060.240963855422], "RayTrace": [1957.03125]}, "summary": {"lowerIsBetter": false, "suite": 19822.587758776426, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 354.85530600000016, "unit": "score", "value": 354.85530600000016}, "Encrypt": {"lowerIsBetter": false, "filtered": 946.0072739999998, "unit": "score", "value": 946.0072739999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.75898306772911, "unit": "score", "value": 52.75898306772911}, "Splay": {"lowerIsBetter": false, "filtered": 128.429816, "unit": "score", "value": 128.429816}, "RegExp": {"lowerIsBetter": false, "filtered": 35.79508840864438, "unit": "score", "value": 35.79508840864438}, "Richards": {"lowerIsBetter": false, "filtered": 207.18743799999993, "unit": "score", "value": 207.18743799999993}, "Earley": {"lowerIsBetter": false, "filtered": 831.745824, "unit": "score", "value": 831.745824}, "Boyer": {"lowerIsBetter": false, "filtered": 55.2611678321678, "unit": "score", "value": 55.2611678321678}, "RayTrace": {"lowerIsBetter": false, "filtered": 378.11813173652706, "unit": "score", "value": 378.11813173652706}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447620566, "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": "20151115103014", "branch": "Firefox", "revision": "7cd2d806bd069c0260ff73f023ac85f892b863bf"}}] 13:09:37 INFO - RETURN: dromaeo_css: 6785.87 13:09:37 INFO - RETURN: kraken: 1491.80 13:09:37 INFO - RETURN: v8_7: 19822.59 13:09:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19822.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1491.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6785.87"}}} 13:09:37 INFO - Return code: 0 13:09:37 INFO - # TBPL SUCCESS # 13:09:37 INFO - Running post-action listener: _resource_record_post_action 13:09:37 INFO - Running post-run listener: _resource_record_post_run 13:09:39 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505982976; Read time: 8; Write time: 408000 13:09:39 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 174997504; Read time: 0; Write time: 173476 13:09:39 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 330985472; Read time: 8; Write time: 234524 13:09:39 INFO - Running post-run listener: _upload_blobber_files 13:09:39 INFO - Blob upload gear active. 13:09:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:09:39 INFO - Copying logs to upload dir... 13:09:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.715341 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-15 13:09:38.864416) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 13:09:38.868281) ========= 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=7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009971 build_url: 'https://queue.taskcluster.net/v1/task/WBQw9lwYT_2MEcVln3kEcg/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-15 13:09:38.919843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 13:09:38.920177) ========= 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=7d909545e45784438f4e8e36000001b3-1447617593.479240-35007780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 13:09:38.970423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 13:09:38.970726) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 13:09:38.971027) ========= ========= Total master_lag: 0.24 =========