builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1447336355.25 results: success (0) buildid: 20151112043002 builduid: a3d13aa182504984aad4155033c259ab revision: 3cc3b1968524248450c465c4ea2ee5596ffa65f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.249438) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.249982) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.250287) ========= 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=c402a24d74c70935940d60dd000001de-1447336145.299031-72231419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006708 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.273250) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.273628) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.305745) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.306093) ========= 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=c402a24d74c70935940d60dd000001de-1447336145.299031-72231419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004703 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.356696) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.356975) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.357351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.357618) ========= 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=c402a24d74c70935940d60dd000001de-1447336145.299031-72231419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 05:52:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-11-12 05:52:35 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184726 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.555405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.555677) ========= 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=c402a24d74c70935940d60dd000001de-1447336145.299031-72231419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016129 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.604931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:35.605304) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3cc3b1968524248450c465c4ea2ee5596ffa65f2 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3cc3b1968524248450c465c4ea2ee5596ffa65f2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c402a24d74c70935940d60dd000001de-1447336145.299031-72231419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 05:52:35,774 truncating revision to first 12 chars 2015-11-12 05:52:35,774 Setting DEBUG logging. 2015-11-12 05:52:35,774 attempt 1/10 2015-11-12 05:52:35,774 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3cc3b1968524?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 05:52:35,997 unpacking tar archive at: mozilla-central-3cc3b1968524/testing/mozharness/ program finished with exit code 0 elapsedTime=0.493137 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:36.112706) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:36.113026) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:36.119728) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:36.119993) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 05:52:36.120442) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-12 05:52:36.120723) ========= /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=c402a24d74c70935940d60dd000001de-1447336145.299031-72231419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:52:36 INFO - MultiFileLogger online at 20151112 05:52:36 in /builds/slave/test-pgo 05:52:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:52:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:52:36 INFO - {'append_to_log': False, 05:52:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:52:36 INFO - 'blob_upload_branch': 'Firefox', 05:52:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:52:36 INFO - 'branch': 'Firefox', 05:52:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:36 INFO - 'config_files': ('talos/linux_config.py',), 05:52:36 INFO - 'default_actions': ('clobber', 05:52:36 INFO - 'read-buildbot-config', 05:52:36 INFO - 'download-and-extract', 05:52:36 INFO - 'populate-webroot', 05:52:36 INFO - 'create-virtualenv', 05:52:36 INFO - 'install', 05:52:36 INFO - 'run-tests'), 05:52:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:36 INFO - 'download_minidump_stackwalk': True, 05:52:36 INFO - 'download_symbols': 'ondemand', 05:52:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:36 INFO - 'installer_path': 'installer.exe', 05:52:36 INFO - 'log_level': 'info', 05:52:36 INFO - 'log_name': 'talos', 05:52:36 INFO - 'log_to_console': True, 05:52:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:52:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:52:36 INFO - 'opt_config_files': (), 05:52:36 INFO - 'pip_index': False, 05:52:36 INFO - 'sps_profile': False, 05:52:36 INFO - 'sps_profile_interval': 0, 05:52:36 INFO - 'suite': 'dromaeojs', 05:52:36 INFO - 'system_bits': '64', 05:52:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:36 INFO - 'title': 'talos-linux64-ix-042', 05:52:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:36 INFO - 'use_talos_json': True, 05:52:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:52:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:36 INFO - 'work_dir': 'build'} 05:52:36 INFO - ##### 05:52:36 INFO - ##### Running clobber step. 05:52:36 INFO - ##### 05:52:36 INFO - Running pre-action listener: _resource_record_pre_action 05:52:36 INFO - Running main action method: clobber 05:52:36 INFO - rmtree: /builds/slave/test-pgo/build 05:52:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:52:36 INFO - Running post-action listener: _resource_record_post_action 05:52:36 INFO - ##### 05:52:36 INFO - ##### Running read-buildbot-config step. 05:52:36 INFO - ##### 05:52:36 INFO - Running pre-action listener: _resource_record_pre_action 05:52:36 INFO - Running main action method: read_buildbot_config 05:52:36 INFO - Using buildbot properties: 05:52:36 INFO - { 05:52:36 INFO - "properties": { 05:52:36 INFO - "buildnumber": 547, 05:52:36 INFO - "product": "firefox", 05:52:36 INFO - "script_repo_revision": "production", 05:52:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:52:36 INFO - "repository": "", 05:52:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:52:36 INFO - "buildid": "20151112043002", 05:52:36 INFO - "slavename": "talos-linux64-ix-042", 05:52:36 INFO - "pgo_build": "True", 05:52:36 INFO - "basedir": "/builds/slave/test-pgo", 05:52:36 INFO - "project": "", 05:52:36 INFO - "platform": "ubuntu64_hw", 05:52:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:52:36 INFO - "slavebuilddir": "test", 05:52:36 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:52:36 INFO - "branch": "mozilla-central", 05:52:36 INFO - "repo_path": "mozilla-central", 05:52:36 INFO - "stage_platform": "linux64-pgo", 05:52:36 INFO - "builduid": "a3d13aa182504984aad4155033c259ab", 05:52:36 INFO - "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2" 05:52:36 INFO - }, 05:52:36 INFO - "sourcestamp": { 05:52:36 INFO - "repository": "", 05:52:36 INFO - "hasPatch": false, 05:52:36 INFO - "project": "", 05:52:36 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:52:36 INFO - "changes": [ 05:52:36 INFO - { 05:52:36 INFO - "category": null, 05:52:36 INFO - "files": [ 05:52:36 INFO - { 05:52:36 INFO - "url": null, 05:52:36 INFO - "name": "https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:52:36 INFO - } 05:52:36 INFO - ], 05:52:36 INFO - "repository": "", 05:52:36 INFO - "rev": "3cc3b1968524248450c465c4ea2ee5596ffa65f2", 05:52:36 INFO - "who": "sendchange", 05:52:36 INFO - "when": 1447336282, 05:52:36 INFO - "number": 6653497, 05:52:36 INFO - "comments": "", 05:52:36 INFO - "project": "", 05:52:36 INFO - "at": "Thu 12 Nov 2015 05:51:22", 05:52:36 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:52:36 INFO - "revlink": "", 05:52:36 INFO - "properties": [ 05:52:36 INFO - [ 05:52:36 INFO - "buildid", 05:52:36 INFO - "20151112043002", 05:52:36 INFO - "Change" 05:52:36 INFO - ], 05:52:36 INFO - [ 05:52:36 INFO - "builduid", 05:52:36 INFO - "a3d13aa182504984aad4155033c259ab", 05:52:36 INFO - "Change" 05:52:36 INFO - ], 05:52:36 INFO - [ 05:52:36 INFO - "pgo_build", 05:52:36 INFO - "True", 05:52:36 INFO - "Change" 05:52:36 INFO - ] 05:52:36 INFO - ], 05:52:36 INFO - "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2" 05:52:36 INFO - } 05:52:36 INFO - ], 05:52:36 INFO - "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2" 05:52:36 INFO - } 05:52:36 INFO - } 05:52:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:52:36 INFO - Running post-action listener: _resource_record_post_action 05:52:36 INFO - ##### 05:52:36 INFO - ##### Running download-and-extract step. 05:52:36 INFO - ##### 05:52:36 INFO - Running pre-action listener: _resource_record_pre_action 05:52:36 INFO - Running main action method: download_and_extract 05:52:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:36 INFO - https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/test_packages.json 05:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/test_packages.json 05:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:52:37 INFO - Downloaded 1302 bytes. 05:52:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:52:37 INFO - Using the following test package requirements: 05:52:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:52:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'jsshell-linux-x86_64.zip'], 05:52:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:52:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:52:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:52:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:52:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:52:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:37 INFO - https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:38 INFO - Downloaded 22438691 bytes. 05:52:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:52:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:52:39 INFO - Return code: 0 05:52:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:39 INFO - https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:41 INFO - Downloaded 22438691 bytes. 05:52:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:52:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:52:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:52:42 INFO - Return code: 0 05:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:42 INFO - https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:52:44 INFO - Downloaded 11131693 bytes. 05:52:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:52:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:52:44 INFO - Return code: 0 05:52: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')]} 05:52:44 INFO - https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:52:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:52:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:52:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:52:45 INFO - Downloaded 57167715 bytes. 05:52:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:52:45 INFO - mkdir: /builds/slave/test-pgo/properties 05:52:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:52:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:52:45 INFO - Contents: 05:52:45 INFO - build_url:https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:52:45 INFO - Running post-action listener: _resource_record_post_action 05:52:45 INFO - Running post-action listener: set_extra_try_arguments 05:52:45 INFO - ##### 05:52:45 INFO - ##### Running populate-webroot step. 05:52:45 INFO - ##### 05:52:45 INFO - Running pre-action listener: _resource_record_pre_action 05:52:45 INFO - Running main action method: populate_webroot 05:52:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:52:45 INFO - '../fennec_ids.txt'], 05:52:45 INFO - 'tests': ['tcheck2']}, 05:52:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:45 INFO - '--tppagecycles', 05:52:45 INFO - '7'], 05:52:45 INFO - 'tests': ['tsvgm']}}, 05:52:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:52:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:52:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:52:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:52:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:52:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:45 INFO - 'talos_options': ['--e10s'], 05:52:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:45 INFO - 'tests': ['damp', 'tps']}, 05:52:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:45 INFO - 'talos_options': ['--e10s'], 05:52:45 INFO - 'tests': ['damp', 'tps']}, 05:52:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:52:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:45 INFO - 'other': {'tests': ['a11yr', 05:52:45 INFO - 'ts_paint', 05:52:45 INFO - 'tpaint', 05:52:45 INFO - 'sessionrestore', 05:52:45 INFO - 'sessionrestore_no_auto_restore']}, 05:52:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:52:45 INFO - 'tests': ['a11yr', 05:52:45 INFO - 'ts_paint', 05:52:45 INFO - 'tpaint', 05:52:45 INFO - 'sessionrestore', 05:52:45 INFO - 'sessionrestore_no_auto_restore']}, 05:52:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:52:45 INFO - 'tests': ['a11yr', 05:52:45 INFO - 'ts_paint', 05:52:45 INFO - 'tpaint', 05:52:45 INFO - 'sessionrestore', 05:52:45 INFO - 'sessionrestore_no_auto_restore']}, 05:52:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:52:45 INFO - 'tests': ['a11yr', 05:52:45 INFO - 'ts_paint', 05:52:45 INFO - 'tpaint', 05:52:45 INFO - 'sessionrestore', 05:52:45 INFO - 'sessionrestore_no_auto_restore']}, 05:52:45 INFO - 'other_l64': {'tests': ['a11yr', 05:52:45 INFO - 'ts_paint', 05:52:45 INFO - 'tpaint', 05:52:45 INFO - 'sessionrestore', 05:52:45 INFO - 'sessionrestore_no_auto_restore']}, 05:52:45 INFO - 'other_nol64': {'tests': ['a11yr', 05:52:45 INFO - 'ts_paint', 05:52:45 INFO - 'tpaint', 05:52:45 INFO - 'sessionrestore', 05:52:45 INFO - 'sessionrestore_no_auto_restore']}, 05:52:45 INFO - 'svgr': {'tests': ['tsvgx', 05:52:45 INFO - 'tsvgr_opacity', 05:52:45 INFO - 'tart', 05:52:45 INFO - 'tscrollx', 05:52:45 INFO - 'cart']}, 05:52:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:52:45 INFO - 'tests': ['tsvgx', 05:52:45 INFO - 'tsvgr_opacity', 05:52:45 INFO - 'tart', 05:52:45 INFO - 'tscrollx', 05:52:45 INFO - 'cart']}, 05:52:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:45 INFO - 'tests': ['tp5o']}, 05:52:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:45 INFO - 'talos_options': ['--e10s'], 05:52:45 INFO - 'tests': ['tp5o']}, 05:52:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:45 INFO - 'talos_options': ['--xperf_path', 05:52:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:45 INFO - 'tests': ['tp5n']}, 05:52:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:45 INFO - 'talos_options': ['--e10s', 05:52:45 INFO - '--xperf_path', 05:52:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:45 INFO - 'tests': ['tp5n']}}, 05:52:45 INFO - 'talos.zip': {'path': '', 05:52:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:45 INFO - Running post-action listener: _resource_record_post_action 05:52:45 INFO - ##### 05:52:45 INFO - ##### Running create-virtualenv step. 05:52:45 INFO - ##### 05:52:45 INFO - Running pre-action listener: _resource_record_pre_action 05:52:45 INFO - Running main action method: create_virtualenv 05:52:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:52:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:52:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:52:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:45 INFO - Using real prefix '/usr' 05:52:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:52:46 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:48 INFO - Installing pip.................done. 05:52:48 INFO - Return code: 0 05:52:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:48 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 0x7fd841d06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21716c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22326e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a90>, '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 0x22baf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bb2e0>, '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': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:52:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:52:48 INFO - Using env: {'DISPLAY': ':0', 05:52:48 INFO - 'HOME': '/home/cltbld', 05:52:48 INFO - 'LANG': 'en_US.UTF-8', 05:52:48 INFO - 'LANGUAGE': 'en_US:en', 05:52:48 INFO - 'LOGNAME': 'cltbld', 05:52:48 INFO - 'MAIL': '/var/mail/cltbld', 05:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:48 INFO - 'MOZ_NO_REMOTE': '1', 05:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:48 INFO - 'NO_EM_RESTART': '1', 05:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:48 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:48 INFO - 'SHELL': '/bin/bash', 05:52:48 INFO - 'SHLVL': '1', 05:52:48 INFO - 'TERM': 'linux', 05:52:48 INFO - 'TMOUT': '86400', 05:52:48 INFO - 'USER': 'cltbld', 05:52:48 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 05:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:48 INFO - '_': '/tools/buildbot/bin/python'} 05:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:52:48 INFO - Cleaning up... 05:52:48 INFO - Return code: 0 05:52:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:48 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 0x7fd841d06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21716c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22326e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a90>, '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 0x22baf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bb2e0>, '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': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:52:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:52:48 INFO - Using env: {'DISPLAY': ':0', 05:52:48 INFO - 'HOME': '/home/cltbld', 05:52:48 INFO - 'LANG': 'en_US.UTF-8', 05:52:48 INFO - 'LANGUAGE': 'en_US:en', 05:52:48 INFO - 'LOGNAME': 'cltbld', 05:52:48 INFO - 'MAIL': '/var/mail/cltbld', 05:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:48 INFO - 'MOZ_NO_REMOTE': '1', 05:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:48 INFO - 'NO_EM_RESTART': '1', 05:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:48 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:48 INFO - 'SHELL': '/bin/bash', 05:52:48 INFO - 'SHLVL': '1', 05:52:48 INFO - 'TERM': 'linux', 05:52:48 INFO - 'TMOUT': '86400', 05:52:48 INFO - 'USER': 'cltbld', 05:52:48 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 05:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:48 INFO - '_': '/tools/buildbot/bin/python'} 05:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:48 INFO - Downloading/unpacking psutil>=0.7.1 05:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:52:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:52:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:50 INFO - Installing collected packages: psutil 05:52:50 INFO - Running setup.py install for psutil 05:52:50 INFO - building 'psutil._psutil_linux' extension 05:52:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:52:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:52:50 INFO - building 'psutil._psutil_posix' extension 05:52:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:52:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:52:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:51 INFO - Successfully installed psutil 05:52:51 INFO - Cleaning up... 05:52:51 INFO - Return code: 0 05:52:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:51 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 0x7fd841d06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21716c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22326e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a90>, '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 0x22baf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bb2e0>, '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': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:52:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:52:51 INFO - Using env: {'DISPLAY': ':0', 05:52:51 INFO - 'HOME': '/home/cltbld', 05:52:51 INFO - 'LANG': 'en_US.UTF-8', 05:52:51 INFO - 'LANGUAGE': 'en_US:en', 05:52:51 INFO - 'LOGNAME': 'cltbld', 05:52:51 INFO - 'MAIL': '/var/mail/cltbld', 05:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:51 INFO - 'MOZ_NO_REMOTE': '1', 05:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:51 INFO - 'NO_EM_RESTART': '1', 05:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:51 INFO - 'SHELL': '/bin/bash', 05:52:51 INFO - 'SHLVL': '1', 05:52:51 INFO - 'TERM': 'linux', 05:52:51 INFO - 'TMOUT': '86400', 05:52:51 INFO - 'USER': 'cltbld', 05:52:51 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 05:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:51 INFO - '_': '/tools/buildbot/bin/python'} 05:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:52:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:52:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:52:52 INFO - Installing collected packages: mozsystemmonitor 05:52:52 INFO - Running setup.py install for mozsystemmonitor 05:52:53 INFO - Successfully installed mozsystemmonitor 05:52:53 INFO - Cleaning up... 05:52:53 INFO - Return code: 0 05:52:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd841d06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21716c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22326e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a90>, '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 0x22baf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bb2e0>, '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': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:52:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:52:53 INFO - Using env: {'DISPLAY': ':0', 05:52:53 INFO - 'HOME': '/home/cltbld', 05:52:53 INFO - 'LANG': 'en_US.UTF-8', 05:52:53 INFO - 'LANGUAGE': 'en_US:en', 05:52:53 INFO - 'LOGNAME': 'cltbld', 05:52:53 INFO - 'MAIL': '/var/mail/cltbld', 05:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:53 INFO - 'MOZ_NO_REMOTE': '1', 05:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:53 INFO - 'NO_EM_RESTART': '1', 05:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:53 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:53 INFO - 'SHELL': '/bin/bash', 05:52:53 INFO - 'SHLVL': '1', 05:52:53 INFO - 'TERM': 'linux', 05:52:53 INFO - 'TMOUT': '86400', 05:52:53 INFO - 'USER': 'cltbld', 05:52:53 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 05:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:53 INFO - '_': '/tools/buildbot/bin/python'} 05:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:52:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:52:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:55 INFO - Downloading docopt-0.6.1.tar.gz 05:52:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:52:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:55 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:55 INFO - Running setup.py install for blobuploader 05:52:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:52:55 INFO - Running setup.py install for requests 05:52:56 INFO - Running setup.py install for docopt 05:52:56 INFO - Successfully installed blobuploader requests docopt 05:52:56 INFO - Cleaning up... 05:52:56 INFO - Return code: 0 05:52:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:56 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 0x7fd841d06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21716c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22326e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a90>, '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 0x22baf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bb2e0>, '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': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:52:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:56 INFO - Using env: {'DISPLAY': ':0', 05:52:56 INFO - 'HOME': '/home/cltbld', 05:52:56 INFO - 'LANG': 'en_US.UTF-8', 05:52:56 INFO - 'LANGUAGE': 'en_US:en', 05:52:56 INFO - 'LOGNAME': 'cltbld', 05:52:56 INFO - 'MAIL': '/var/mail/cltbld', 05:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:56 INFO - 'MOZ_NO_REMOTE': '1', 05:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:56 INFO - 'NO_EM_RESTART': '1', 05:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:56 INFO - 'SHELL': '/bin/bash', 05:52:56 INFO - 'SHLVL': '1', 05:52:56 INFO - 'TERM': 'linux', 05:52:56 INFO - 'TMOUT': '86400', 05:52:56 INFO - 'USER': 'cltbld', 05:52:56 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 05:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:56 INFO - '_': '/tools/buildbot/bin/python'} 05:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:56 INFO - Running setup.py (path:/tmp/pip-Uj4ZJp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:56 INFO - Running setup.py (path:/tmp/pip-jmKviS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:56 INFO - Running setup.py (path:/tmp/pip-fCNKqo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:56 INFO - Running setup.py (path:/tmp/pip-3s6PTM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:56 INFO - Running setup.py (path:/tmp/pip-oCnPkO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:52:56 INFO - Running setup.py (path:/tmp/pip-TtrK7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:52:56 INFO - Running setup.py (path:/tmp/pip-RriN42-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:52:56 INFO - Running setup.py (path:/tmp/pip-sh5pJ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:52:57 INFO - Running setup.py (path:/tmp/pip-zFH0yu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:52:57 INFO - Running setup.py (path:/tmp/pip-72UueZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:52:57 INFO - Running setup.py (path:/tmp/pip-MEsEF8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:52:57 INFO - Running setup.py (path:/tmp/pip-XIGTp_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:52:57 INFO - Running setup.py (path:/tmp/pip-OQ0iqC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:52:57 INFO - Running setup.py (path:/tmp/pip-iU8yWz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:52:57 INFO - Running setup.py (path:/tmp/pip-iJvZHK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:52:57 INFO - Running setup.py (path:/tmp/pip-BlwaXp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:52:57 INFO - Running setup.py (path:/tmp/pip-lPIpYB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:52:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:57 INFO - Running setup.py install for manifestparser 05:52:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:52:57 INFO - Running setup.py install for mozcrash 05:52:57 INFO - Running setup.py install for mozdebug 05:52:57 INFO - Running setup.py install for mozdevice 05:52:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:52:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:52:58 INFO - Running setup.py install for mozfile 05:52:58 INFO - Running setup.py install for mozhttpd 05:52:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:52:58 INFO - Running setup.py install for mozinfo 05:52:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:52:58 INFO - Running setup.py install for mozInstall 05:52:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:52:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:52:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:52:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:52:58 INFO - Running setup.py install for mozleak 05:52:58 INFO - Running setup.py install for mozlog 05:52:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:52:58 INFO - Running setup.py install for moznetwork 05:52:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:52:58 INFO - Running setup.py install for mozprocess 05:52:58 INFO - Running setup.py install for mozprofile 05:52:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Running setup.py install for mozrunner 05:52:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Running setup.py install for mozscreenshot 05:52:59 INFO - Running setup.py install for moztest 05:52:59 INFO - Running setup.py install for mozversion 05:52:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:59 INFO - Cleaning up... 05:52:59 INFO - Return code: 0 05:52:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:52: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')]} 05:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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', '-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 0x7fd841d06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21716c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22326e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a90>, '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 0x22baf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bb2e0>, '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': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:52:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:59 INFO - Using env: {'DISPLAY': ':0', 05:52:59 INFO - 'HOME': '/home/cltbld', 05:52:59 INFO - 'LANG': 'en_US.UTF-8', 05:52:59 INFO - 'LANGUAGE': 'en_US:en', 05:52:59 INFO - 'LOGNAME': 'cltbld', 05:52:59 INFO - 'MAIL': '/var/mail/cltbld', 05:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:59 INFO - 'MOZ_NO_REMOTE': '1', 05:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:59 INFO - 'NO_EM_RESTART': '1', 05:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:59 INFO - 'SHELL': '/bin/bash', 05:52:59 INFO - 'SHLVL': '1', 05:52:59 INFO - 'TERM': 'linux', 05:52:59 INFO - 'TMOUT': '86400', 05:52:59 INFO - 'USER': 'cltbld', 05:52:59 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 05:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:59 INFO - '_': '/tools/buildbot/bin/python'} 05:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:59 INFO - Running setup.py (path:/tmp/pip-6sCLRm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:59 INFO - Running setup.py (path:/tmp/pip-xL86U2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:59 INFO - Running setup.py (path:/tmp/pip-LYVQxA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:59 INFO - Running setup.py (path:/tmp/pip-tODwcq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:59 INFO - Running setup.py (path:/tmp/pip-X4OHER-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:53:00 INFO - Running setup.py (path:/tmp/pip-lnBpBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:53:00 INFO - Running setup.py (path:/tmp/pip-eAGcxU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:53:00 INFO - Running setup.py (path:/tmp/pip-137kH0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:53:00 INFO - Running setup.py (path:/tmp/pip-l5s2wy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:53:00 INFO - Running setup.py (path:/tmp/pip-TN_GRM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:53:00 INFO - Running setup.py (path:/tmp/pip-xdBSJQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:53:00 INFO - Running setup.py (path:/tmp/pip-zjgfEA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:53:00 INFO - Running setup.py (path:/tmp/pip-eiktpD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:53:00 INFO - Running setup.py (path:/tmp/pip-Ozj04K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:53:00 INFO - Running setup.py (path:/tmp/pip-FRwF4C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:53:00 INFO - Running setup.py (path:/tmp/pip-dK1PPQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:53:00 INFO - Running setup.py (path:/tmp/pip-175P8n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:02 INFO - Downloading blessings-1.5.1.tar.gz 05:53:02 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:53:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:02 INFO - Installing collected packages: blessings 05:53:02 INFO - Running setup.py install for blessings 05:53:02 INFO - Successfully installed blessings 05:53:02 INFO - Cleaning up... 05:53:02 INFO - Return code: 0 05:53:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:53:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:53:03 INFO - Reading from file tmpfile_stdout 05:53:03 INFO - Current package versions: 05:53:03 INFO - argparse == 1.2.1 05:53:03 INFO - blessings == 1.5.1 05:53:03 INFO - blobuploader == 1.2.4 05:53:03 INFO - docopt == 0.6.1 05:53:03 INFO - manifestparser == 1.1 05:53:03 INFO - mozInstall == 1.12 05:53:03 INFO - mozcrash == 0.16 05:53:03 INFO - mozdebug == 0.1 05:53:03 INFO - mozdevice == 0.47 05:53:03 INFO - mozfile == 1.2 05:53:03 INFO - mozhttpd == 0.7 05:53:03 INFO - mozinfo == 0.9 05:53:03 INFO - mozleak == 0.1 05:53:03 INFO - mozlog == 3.0 05:53:03 INFO - moznetwork == 0.27 05:53:03 INFO - mozprocess == 0.22 05:53:03 INFO - mozprofile == 0.27 05:53:03 INFO - mozrunner == 6.11 05:53:03 INFO - mozscreenshot == 0.1 05:53:03 INFO - mozsystemmonitor == 0.0 05:53:03 INFO - moztest == 0.7 05:53:03 INFO - mozversion == 1.4 05:53:03 INFO - psutil == 3.1.1 05:53:03 INFO - requests == 1.2.3 05:53:03 INFO - wsgiref == 0.1.2 05:53:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:03 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 0x7fd841d06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21716c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22326e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a90>, '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 0x22baf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bb2e0>, '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': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:53:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:03 INFO - Using env: {'DISPLAY': ':0', 05:53:03 INFO - 'HOME': '/home/cltbld', 05:53:03 INFO - 'LANG': 'en_US.UTF-8', 05:53:03 INFO - 'LANGUAGE': 'en_US:en', 05:53:03 INFO - 'LOGNAME': 'cltbld', 05:53:03 INFO - 'MAIL': '/var/mail/cltbld', 05:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:03 INFO - 'MOZ_NO_REMOTE': '1', 05:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:03 INFO - 'NO_EM_RESTART': '1', 05:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:03 INFO - 'SHELL': '/bin/bash', 05:53:03 INFO - 'SHLVL': '1', 05:53:03 INFO - 'TERM': 'linux', 05:53:03 INFO - 'TMOUT': '86400', 05:53:03 INFO - 'USER': 'cltbld', 05:53:03 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 05:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:03 INFO - '_': '/tools/buildbot/bin/python'} 05:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:53:03 INFO - Cleaning up... 05:53:03 INFO - Return code: 0 05:53:03 INFO - Running post-action listener: _resource_record_post_action 05:53:03 INFO - Running post-action listener: _start_resource_monitoring 05:53:03 INFO - Starting resource monitoring. 05:53:03 INFO - ##### 05:53:03 INFO - ##### Running install step. 05:53:03 INFO - ##### 05:53:03 INFO - Running pre-action listener: _resource_record_pre_action 05:53:03 INFO - Running main action method: install 05:53:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:53:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:53:03 INFO - Reading from file tmpfile_stdout 05:53:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:53:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:53:03 INFO - Reading from file tmpfile_stdout 05:53:03 INFO - Output received: 05:53:03 INFO - Usage: mozinstall [options] installer 05:53:03 INFO - Options: 05:53:03 INFO - -h, --help show this help message and exit 05:53:03 INFO - -d DEST, --destination=DEST 05:53:03 INFO - Directory to install application into. [default: 05:53:03 INFO - "/builds/slave/test-pgo"] 05:53:03 INFO - --app=APP Application being installed. [default: firefox] 05:53:03 INFO - mkdir: /builds/slave/test-pgo/build/application 05:53:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:53:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:53:17 INFO - Reading from file tmpfile_stdout 05:53:17 INFO - Output received: 05:53:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:53:17 INFO - Running post-action listener: _resource_record_post_action 05:53:17 INFO - ##### 05:53:17 INFO - ##### Running run-tests step. 05:53:17 INFO - ##### 05:53:17 INFO - Running pre-action listener: _resource_record_pre_action 05:53:17 INFO - Running main action method: run_tests 05:53:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:53:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:53:17 INFO - Python 2.7.3 05:53:17 INFO - Return code: 0 05:53:17 INFO - grabbing minidump binary from tooltool 05:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:17 INFO - 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 0x2268a90>, '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 0x22baf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bb2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:53:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:53:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:53:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:18 INFO - Return code: 0 05:53:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:53:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:53:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:53:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:53:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:53:18 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/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:53:18 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/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 05:53:18 INFO - Using env: {'DISPLAY': ':0', 05:53:18 INFO - 'HOME': '/home/cltbld', 05:53:18 INFO - 'LANG': 'en_US.UTF-8', 05:53:18 INFO - 'LANGUAGE': 'en_US:en', 05:53:18 INFO - 'LOGNAME': 'cltbld', 05:53:18 INFO - 'MAIL': '/var/mail/cltbld', 05:53:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:53:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:18 INFO - 'MOZ_NO_REMOTE': '1', 05:53:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:18 INFO - 'NO_EM_RESTART': '1', 05:53:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:53:18 INFO - 'SHELL': '/bin/bash', 05:53:18 INFO - 'SHLVL': '1', 05:53:18 INFO - 'TERM': 'linux', 05:53:18 INFO - 'TMOUT': '86400', 05:53:18 INFO - 'USER': 'cltbld', 05:53:18 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447336145.299031-72231419', 05:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:18 INFO - '_': '/tools/buildbot/bin/python'} 05:53:18 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/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 05:53:18 INFO - mozversion INFO | application_buildid: 20151112043002 05:53:18 INFO - mozversion INFO | application_changeset: 3cc3b1968524248450c465c4ea2ee5596ffa65f2 05:53:18 INFO - mozversion INFO | application_display_name: Nightly 05:53:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:18 INFO - mozversion INFO | application_name: Firefox 05:53:18 INFO - mozversion INFO | application_remotingname: firefox 05:53:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:53:18 INFO - mozversion INFO | application_vendor: Mozilla 05:53:18 INFO - mozversion INFO | application_version: 45.0a1 05:53:18 INFO - mozversion INFO | platform_buildid: 20151112043002 05:53:18 INFO - mozversion INFO | platform_changeset: 3cc3b1968524248450c465c4ea2ee5596ffa65f2 05:53:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:53:18 INFO - mozversion INFO | platform_version: 45.0a1 05:53:18 INFO - 2015-11-12 05:53:18,231 DEBUG : using testdate: 1447336398 05:53:18 INFO - 2015-11-12 05:53:18,231 DEBUG : actual date: 1447336398 05:53:18 INFO - 2015-11-12 05:53:18,242 INFO : starting webserver on 'localhost:34886' 05:53:18 INFO - 2015-11-12 05:53:18,243 INFO : Starting test suite talos-linux64-ix-042 05:53:18 INFO - 2015-11-12 05:53:18,243 INFO : Starting test dromaeo_css 05:53:18 INFO - 2015-11-12 05:53:18,243 DEBUG : operating with platform_type : linux_ 05:53:18 INFO - 2015-11-12 05:53:18,243 INFO : Initialising browser for dromaeo_css test... 05:53:18 INFO - 2015-11-12 05:53:18,250 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSJn551/profile http://localhost:34886/getInfo.html 05:53:25 INFO - 2015-11-12 05:53:25,824 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:53:25 INFO - 2015-11-12 05:53:25,824 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:53:25 INFO - 2015-11-12 05:53:25,824 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:53:25 INFO - 2015-11-12 05:53:25,824 DEBUG : BROWSER_OUTPUT: __metrics 05:53:25 INFO - 2015-11-12 05:53:25,961 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:53:27 INFO - 2015-11-12 05:53:27,570 INFO : Browser initialized. 05:53:27 INFO - 2015-11-12 05:53:27,570 INFO : Running cycle 1/1 for dromaeo_css test... 05:53:27 INFO - 2015-11-12 05:53:27,571 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSJn551/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:53:39 INFO - 2015-11-12 05:53:39,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 139341824 05:53:39 INFO - 2015-11-12 05:53:39,299 DEBUG : BROWSER_OUTPUT: 05:54:30 INFO - 2015-11-12 05:54:30,015 DEBUG : BROWSER_OUTPUT: 1447336470011 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:56:39 INFO - 2015-11-12 05:56:39,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34886/tests/dromaeo/cssquery-ext.html) 05:56:40 INFO - 2015-11-12 05:56:40,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 238718976 05:56:40 INFO - 2015-11-12 05:56:40,916 DEBUG : BROWSER_OUTPUT: 05:59:43 INFO - 2015-11-12 05:59:43,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/dromaeo/cssquery-ext.html (next: http://localhost:34886/tests/dromaeo/cssquery-jquery.html) 05:59:43 INFO - 2015-11-12 05:59:43,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 220049408 05:59:43 INFO - 2015-11-12 05:59:43,881 DEBUG : BROWSER_OUTPUT: 06:02:45 INFO - 2015-11-12 06:02:45,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34886/tests/dromaeo/cssquery-mootools.html) 06:02:46 INFO - 2015-11-12 06:02:46,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 208969728 06:02:46 INFO - 2015-11-12 06:02:46,436 DEBUG : BROWSER_OUTPUT: 06:05:48 INFO - 2015-11-12 06:05:48,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34886/tests/dromaeo/cssquery-prototype.html) 06:05:48 INFO - 2015-11-12 06:05:48,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 195108864 06:05:48 INFO - 2015-11-12 06:05:48,757 DEBUG : BROWSER_OUTPUT: 06:08:51 INFO - 2015-11-12 06:08:51,193 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34886/tests/dromaeo/cssquery-yui.html) 06:08:51 INFO - 2015-11-12 06:08:51,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 201658368 06:08:51 INFO - 2015-11-12 06:08:51,787 DEBUG : BROWSER_OUTPUT: 06:11:54 INFO - 2015-11-12 06:11:54,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/dromaeo/cssquery-yui.html (next: http://localhost:34886/tests/dromaeo/cssquery-dojo.html) 06:11:54 INFO - 2015-11-12 06:11:54,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 245907456 06:11:54 INFO - 2015-11-12 06:11:54,512 DEBUG : BROWSER_OUTPUT: 06:11:54 INFO - 2015-11-12 06:11:54,512 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:11:54 INFO - 2015-11-12 06:11:54,512 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:11:54 INFO - 2015-11-12 06:11:54,512 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:11:54 INFO - 2015-11-12 06:11:54,513 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:11:54 INFO - 2015-11-12 06:11:54,513 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3161.4309424303624;3193.042087373787;3228.8062716237027;3240.9837950810243;3241.6920392562706;5208.218767184924;5325.520703136717;5336.17289320155;5395.7032363220005;5422.186671999197;5268.367795864492;5309.4425085365965;5318.734063296839;5380.946190538093;5472.671639701621;4882.048000639877;4894.167991441445;4895.265710143489;4962.578180854632;4963.801447942078;4792.90414191716;4935.851924442254;4955.975220123913;5022.096022715909;5044.470330615288;4790.784414701347;4878.146324393235;4889.511048895082;4893.95106048942;4910.705357678551;4897;4923.507649235084;4932.926006109911;4939.2838038484215;4947.307376967227;4748.691335063209;4847.2486764551195;4886.02279544089;4888.804447822083;4914.33656456381;5134.768935397916;5221.477852214786;5223.791048358099;5224.686518808883;5258.684478931276;5732.856678583027;5734.139879018139;5743.856403589902;5744.281964754406;5767.106098554731;5663.32040155184;5786.826395208151;5794.391588883191;5798.884022319572;5799.3620701722775;5414.864628384243;5438.782448702087;5442.863928401822;5447.972760136214;5478.780848766045;5828.912566311508;5834.766609335664;5843.970780146072;5856.619319744203;5864.413558644187;5500.257465242141;5590.608657394025;5626;5691.857703557444;5754.510866576388;5732.140178973104;5737.483626473638;5742.54059675225;5744.856378590569;5760.251167348218;5724.084146536534;5727.398623144593;5729;5729.5702822288495;5736.483716465538;5456.7544460499375;5580.748866301026;5648.491635752802;5711.114777209539;5742.856428589319;4458.375827384104;4474.932876006863;4491.461024676994;4491.550844915482;4499.167653984024;3876.7286289959998;4005.078831868628;4008.6392224699916;4011.4183443401125;4031.2139132869397;5412.648177868426;5469.835904922858;5488.780448782084;5501.257330260363;5516.117421212587;5743.282089738783;5746.396628353963;5750.338711048283;5755.079187330007;5791.276090488689;5241.580673546107;5338.039152952506;5458.044842152607;5458.590605704588;5463.125899856004;4988.476209997971;5083.415407228142;5094.261332106824;5098.745062746848;5135.383753949475;5992.43071908168;6004.099385092184;6005.909911351333;6006.939930600638;6007.189029481052;5634.74643641029;5636.267285252891;5764.279465066867;5807.651540907559;5807.680577568274;6108.328083910677;6116.4922381823235;6118.60229085108;6118.653896142841;6119.144993449551;5785.566082543742;5800.100984347433;5800.187973683604;5800.535957123504;5818.709064546841;5637.098064309691;5753.654780713171;5796.217510636179;5875.853103672443;5907.113932909926;5669.659820410624;5691.459311365414;5717.685527296038;5718.25662663851;5718.714064296852;5691.26013618227;5695.316562012585;5702.258706368146;5703.344115426779;5703.600747947769;5334.599905007218;5448.591355648421;5480.451954804487;5571.220029195835;5601.943980560142;5571.804986825604;5574.665520068809;5619.438056194348;5625.353084395347;5777;5417.8103766367985;5466.699331536804;5470.206820011155;5477.178423236546;5499.862503437286 06:11:54 INFO - 2015-11-12 06:11:54,513 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.9830505084847;599.1851082527761;610.5725991805737;611.3977731934046;616.7717944360587;30386.696133038662;39722.801385993065;40419;40585.18829623406;40603.39094913571;43315;43795.56204437955;43804.56195438045;43852.3422148668;43939.56060439395;7321.963390183042;7443.292887175709;8627.65489380424;8806.251468625174;8808.559572021406;10507.211959103099;10683.78632427351;10687.625933092344;10694.78610427795;10714.196435267386;10350;10412.062914337708;10429;10435.32170408921;10453.73865653361;7517.4737768356235;7688.5771282579435;10301.27891047627;10464.162866970624;10583.206259530489;10083.344582602107;10292.433916134609;10320.690379288633;10329.173666106768;10333.431661258628;40803.183936321104;40965.385519217234;41005.58994410077;41256;41293.58706412927;3217.8551965161623;3255.3814775192636;3266.395716792401;3267.607887053569;3300.4389253826907;30303;30500.389992200253;30680.69319306823;30930.69069309323;31526.842365788252;3259.608846938359;3284.3431313737346;3298.5546951161764;3325.88359407422;3361.3613413451367;270736;270766;271078.6446067777;271783;272475;54233.1865022025;54927.725361373734;56159.71920140373;57217;57537;60195.69902150461;60418.0937285941;60505.39494604998;60507.69746151241;60605.39394605997;14236.786448203078;14321.212333321559;14333;14347.78478322826;14367.353469093707;9194;9202.90797092034;9213.355065145375;9236;9273.72178834636;19058.1211100678;19279;19301.61396772057;19472.610547788965;19494.415167544998;7509.211532789088;7654.349380302625;7735.729249476354;7769.7669069928;7797.259260370256;888.9377743557889;917.9357444978921;937.5921474158763;953.4851180362665;1092.4373947417087;27824.860875695493;28091.297717556816;28544.429111417656;28558.71441285602;32471.675283246866;1011.0092109732503;1051.5846240734868;1095.7260684828793;1136.153565593638;1167.9007284380752;15061.472848450252;15149.242537873062;15155.848441515664;15265.160416176996;15396.307166177325;396912;400753;401074;402305;402441;53970.46029539733;54251.45748542543;54253;54436.183457248175;54528.45471545234;1102.2119184782919;1284.8715128487263;1286.2218357893528;1297.5199176304827;1328.448693792085;23247.53504929926;29763.851180743957;30158.84920575383;30193.849030754707;30272.69727302787;49567.256491153385;49766.50233497618;50355.74822125866;50397.74801125971;50566.49433505618;296566;307582;308284;308917;309303;27003.729962700123;32143.19642008875;32267.998460237763;32353.191170220933;32706.50940235946;37781.622183777814;38667;39108;39158.80420597879;39460.21079578335;32936.176595585304;33288;33468.832655836566;33572;33798;40362.596374035886;41263.587364125975;41383.793081034404;42006.579934200265;42630.147397052504;35526.11184720299;35803;35815.10462238465;40580.59419405886;41108.38337425001;32152.51771223387;33449.32405407513;33629.00653803268;33775;34045;25010;25224.24327270185;25386.365340866625;25506.872465637553;25528.23415297544 06:11:54 INFO - 2015-11-12 06:11:54,514 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.5727398484826;355.35503061942575;356.6807707102142;357.98210089495535;358.7596310471984;13970.231637259947;13988.300584970737;17140.22868970896;17485.300587976482;17993.28026878925;14172.787408188886;14725.779113313281;15125.394984200646;15133.545993620182;15380.923095384536;5289.894202115965;5453.182022696587;5460.6177567570285;5461.508464238218;5463.836084917439;3814.408766641175;3947.1118998225456;5475.233467314579;5520.806771762989;5875.177475153482;5981.551383646222;5993.910091348634;5999.280086389639;6018.247719035121;6023.668698221596;5808.56435767317;5928.940710592904;5935.317438494585;5950.5834591578605;5971.820845374646;5216.217567364888;5227.954409118153;5238.947610523884;5239.895202095937;5241.056609810233;19687;20090;20316.187352505884;20589.897050514803;20622;2191.1345018717675;2228.576570451609;2435.646831209465;2462.532118897404;2951.8524073796225;13061.673458163526;13291.53479628218;13355.465781368734;13420.79611689116;13604.387802548908;1809.9819001809944;1849.1794141942992;1849.2048419179748;1855.9814401855945;1872.372755127034;59584.40415595832;59783;60357;60948.39051609472;61023;9390.295727820441;9563.378380405251;9772.169365604002;9838.458884761263;9887.159591434665;12826;12832.946728523391;12838.55065072718;12847.293398863152;12852.614421567368;5064.41759197697;5204.869878253074;5205.167173252262;5481.890362192814;6641.369069938348;5295.073362161606;5339.385970613352;5349.384820745664;5426.647267927651;5558.277423934944;3204.6955539223736;3246.935061298761;3275.901722948315;3288.2272665923488;3294.225856923621;1121.8276900638853;1154.6766905266538;1174.3130268792852;1181.4506254591483;1202.5370232460566;470.40493775374176;474.83380816714566;480.15998732773556;481.62433302024476;485.63577317012243;11725.882741172649;11917.284962902253;12219.26684398939;12256.509739610316;12305.56930507428;439.73615830501444;469.3499503188109;480.3539239722568;484.82788610043633;509.26157072245394;6046.758129674764;6345.460635846005;6370.8088757337355;6480.222373315232;6761.121054262914;569234;572646;583483;597464;606087;75081;75845.62077189579;76831;77970;78219.60890195513;556.6298411556351;560.9523190528851;561.4722161168488;562.7636392715069;563.2621266141368;10987.285826421257;11260;11337.829932550854;11411.486483108447;11436.428178590872;33273.833630831694;33302.5004624926;34079.14802129967;34251.14372140716;35816.104597385274;42884.35673464963;43773.12453750843;44062.55937440584;44673.77663111794;46026;6590.1103351046995;6646.169228846395;6747.595144291358;6756.155480564929;6825.044493770975;12178.939105304771;12433.12968092225;12509.311987840756;12609.810852837032;12611.243325400505;10312.226583006155;10638.73403164927;10852.131829453467;11035.613753518588;11141.442927853737;10658.467076645982;10686.305390149615;10773.138148948223;11020.889791102307;11288.2662626929;9135.132162444557;9344.486053267136;10221.284510084222;11199.72000699989;11449.885501144881;6534.215894092739;6757.797266082025;6760.121184246016;6778.96610516964;6782.491313151632;10795.29830561011;10835.133189344675;11042.116630669689;11076.889231107585;11163.106951443702 06:11:54 INFO - 2015-11-12 06:11:54,515 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1293.7283170534188;1492.970140597188;1572.8584427401536;1662.1855290907451;1747.9213435395397;6756.121704178456;7294.489385742993;7523.172451030396;7525.849483010336;7544.0569928758905;7365.079365079365;7504.924950750491;7516.511426757271;7516.699332026726;7517.436192285573;1932.3816378758802;1965.3023176772253;2158.417227348615;2184.541246338267;2194.089452877054;2220.7224096987875;2227.7883601057956;2228.353777404559;2228.7882651148116;2229.732432108149;2156.6657168138963;2243.4391402149463;2244.8540844845033;2245.786650268222;2247.6628505724107;1935.2936178294963;1964.7327473779403;2152.698622192894;2165.307101727448;2186.9125234990584;2170.3597438755605;2180.2151225558787;2205.6801763744165;2207.9116835326568;2240.5070884405404;7320.560766353982;7381.446391520657;7383.2985866342615;7385.741499047561;7390.815229619248;4325.156594464081;4394.648428125743;4398;4414.249577571821;4419.558044195587;2879.3521457671854;2971.628546431696;2972.970270297291;3016.351484430858;3018;904.5477261369315;917.9632814687404;919.1130559010587;920.7329874336434;938.258775567301;10285;10289.176865850714;10291.433971131584;10308.072273495347;10311.742206444824;3949.960500395017;3999.4200840878493;4051.4125451809323;4058.3100872851687;4075.062735570776;8781.20969112783;8781.956090219635;8783.077776833468;8785.385023048326;8796.164364385373;4457.086297309044;4457.286834106528;4465.24090904547;4467.798949047301;4468.798904049326;4071.328230841878;4081.3265811141423;4084.65280451159;4087.795610219477;4095.1400205957084;3626;3651.6165802590876;3672.7979961102396;3679.6504332088944;3707.351213537674;1133.971650708739;1135.7047167736448;1136.6760473265244;1144.0504381363448;1152.567787079845;998.2213873178932;1016.8271393863062;1019.7144799456164;1103.150574057971;1267.512007876974;7014.824629384204;7051.541649792747;7079.04432901562;7079.787606371817;7107.218205997337;405.59643155060314;418.9985933618654;419.0926643816165;419.38560009586104;419.9643030342394;5396.64921780083;5486.396496385394;5515.61390702655;5515.972420137874;5523.944760552343;8683.348748843862;8737.169968852948;8917.643294268286;8922.197002269826;8949.060348663426;8900.554972251362;8916.28669706435;8924.643014279356;8944.910550894409;8970.282377409792;6585.5719378240265;6622.735090596419;6626.370494803083;6629.602223866584;6651.268360480343;6422.486201103807;6558.475321974326;6562.671866406756;6594.10979517759;6594.406503414716;7642.273983971514;7901.723439679584;7915.287624113857;7938.960305198437;7978.720744773905;7957.641906114354;8119.147489513516;8133.308668762985;8184.918150818416;8281.29608983243;6663.100481435138;6732.360425759545;6735.595864248161;6737.25890152073;6741.898871517029;7100.076989991268;7134.857302854018;7227.385672217921;7247.2390399009455;7256.7822965311125;6781;6823.385895269251;6916.51584389108;6924.099867017256;6957.443404527727;5833.329167145833;6635.933640663725;6732.360425759545;6766.458683305422;6929.618870962146;6918;6921.169459664872;6945.409640180439;6962.756303529555;6967.024616553788;6310.242770867525;6325.525585581007;6381.425671689571;6408.102865598727;6411.102445657519;6351.745930162927;6401.743930242738;6433.774817881352;6441.903371449338;6442.065900444316 06:11:54 INFO - 2015-11-12 06:11:54,519 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.4920077077447;329.6653896295261;330.7073240182438;333.19865722936333;337.20419809250166;5689.431056894308;5779.942200577993;5828.184054232411;5836.766529338826;5845.240118784557;5621.550275977912;5699.430056994299;5707;5729.255196824417;5743.081107022877;4416.668749843775;4421.513633500313;4428.667849911253;4430.5126436092005;4431.756253406062;4289.1850548395705;4343.348497725351;4356.716813407118;4414.8675539733695;4420.668449866257;4335.414719012924;4337.9566204338025;4340.956590434087;4370.104128653635;4370.519242883296;4333.65330773539;4334.783260836945;4338.978305108454;4339.8481053163305;4341.869743907656;3804.5814960354337;3805.4101614249835;3809.3333666608232;3814.7520411173186;3815.561210460805;5313.707746073965;5406.189071639246;5419.8374048778205;5519.365272993617;5525.778968841241;5099.954509325579;5113.181890897476;5118.334616499868;5123.359580052494;5126.307948426989;6075.453209211148;6082.878342433127;6092.08618707193;6095.6952152392205;6108.114323423123;4107.240160570304;4161.334186530141;4218.957810421887;4267.1892340455215;4275.337322714984;6258.092576576371;6259.061140828867;6263.498920086382;6270.278917924452;6274.780382686629;4355.60799528044;4358.324459708687;4362.8691139265875;4363.127374525107;4367.541408152162;4341.587549182823;4408.801603927831;4416.050549131952;4416.580424859633;4423.5576442355505;5094.057599344133;5121.718305493159;5125.948740512547;5127.102757017507;5134.871628209325;6170.938290617037;6176.629402235791;6182.721777520022;6183.443490085824;6185.103160041859;1610.114437059636;1611.04948080633;1613.1772795873953;1613.3062783003186;1613.3304678558268;1102.404701461218;1106.8671759388765;1108.6396921000708;1128.1482480727;1139.2424038014628;5954.07711804671;5999.250093738283;5999.460048595647;6001.729922153513;6006.429389208019;6327.114204011442;6340.619562826153;6347.1114044033875;6352.078948552434;6354.269259035178;5882.588218824727;5946.137810017523;5984.73068711909;5991;5991.340952495222;3478.3912815257227;3488.232588830453;3524.3479956208184;3527.012436517779;3529.7529172957647;6546.639934803631;6553.606783593;6588.176477940257;6594.934050659528;6596.472282217411;6418.229812422539;6425.807225783234;6433.292337842833;6436.903446448307;6438.45273151778;6468.126802881645;6598.439132673777;6609.1408116944485;6609.173853268341;6611.66941652925;6323.747050117944;6331.3352098029045;6340.841478963062;6341.334159913143;6347.143135676624;6071.241094863142;6151.292601350902;6179.3820617937845;6283.654399008098;6287.339829317856;6509.121268628674;6560.737570497126;6565.179352580927;6568.1789776277965;6587.440067594116;4391.5827996340295;4444.599986001146;4447.355133505559;4449.688521803443;4450.154470650566;6069.726862291119;6220;6220.657863817533;6230;6231.937680623136;6126.816195514141;6157.784477543264;6158.969205153946;6159.414855588712;6180.6291622502795;6141.815745527641;6142.877142457037;6147.354527774519;6147.969260153671;6148.9692551536955;5929.140274660236;6061.878762424815;6066.545009124245;6072.696365181811;6074.635521868702;6182.938170618416;6184.381561843959;6189.6286222826775;6190.628562286277;6192.59748116371;6001.789937352171;6037.728302226323;6048.243969503812;6049.032154855202;6064.727087280995 06:11:54 INFO - 2015-11-12 06:11:54,519 DEBUG : BROWSER_OUTPUT: |5;yui.html;736.4476642518111;752.6725874244701;809.3120847279811;827.4828232354778;841.8105926166613;13273.867261327383;13436.731265374687;13438.596842094728;13450.663733406658;13463.394147263372;12242.938785306062;12297.385130743472;12551.309677967709;13651.317434128303;13680.52118175864;670.9865802683944;803.3974519110652;814.5519964019766;814.7596459044596;816.1756625807947;676.164936303667;822.8354329134168;837.8910741603582;844.3793811548506;846.2510678049939;850.3877208409966;861.6381119929645;865.9783505412352;872.6771094694972;873.1704880363649;704.7181127548996;712.5368510468186;856.0797143071161;861.6208868098048;864.5849992003842;642.1331202876127;643.2506130358174;643.2666759893725;643.5848877474003;643.6234802640461;13274.336283185801;13401.66495837602;13551.796723049161;13552.728945421037;13604;9532.428054316693;10101.595936162545;11460.885391146065;12905.096643234978;13195.670108247275;9332.113449222314;9427.19868811145;9486.146246837818;9501.477418741966;9511.952440237823;3167.224030112614;3202.7758056936023;3247.447933851251;3292.341531693647;3331.800091994488;44322.55677443217;44483.77758111221;44673.88315292111;44698.329525057154;46132.30801537979;7167.354938055496;7323.560586364835;7353.117625884821;7363.77908662741;7444.330010299099;11274.54901803935;11339.716507087223;11358.94320528392;11380.544778208945;11395.772084558428;6157.753689852445;6200.193974783339;6286.748530058747;6339.334369891188;6423.903641445382;4178.498580170399;4228.090960443519;4249.38383934334;4253.510846252659;4280.293751530962;2833.744962953344;2867.655881294258;2875.180573536532;2877.2950627096498;2877.309445733009;447.17273044867386;452.2289496408681;453.94098767160716;457.1656726474198;458.64913341293936;652.6671397587264;671.9966400167967;685.0033201691526;689.2556039477453;689.5586824432268;8622.439541429787;8826.42628229163;8987.724108417946;9179.77050573741;9212.555093379875;523.3249108649875;614.8410246685031;661.8318667551775;676.6549059979347;699.7166147710185;3858.8070596470066;4032.1734044520804;4045.4943132108488;4087.693422993287;4160.313548264502;56803;57038;57242.7137864308;57828;57901.42098579044;47677.76161119172;48081.5191848077;49325.26012109821;50180.498195018314;50217;45873.54126458826;46125.30812037822;46602.76698616553;46939;47469.5253047472;8658.264047556027;8788.42875213109;8945.910540894507;9097.454152750855;9111.088891110836;31746.365072698878;33080.33839323248;33127.66872331342;33803;35013;44710;44965.32552011657;45524;45882.54117458916;45994.77002614966;7427.591482468516;7466.141393739789;7664.8850267244925;7684.46208765381;7715.57564333967;11727.648170554898;11820.940895295469;11858.169928105295;11879.940600296943;11983.551208548792;10573.735656608646;10601.893981060399;11190.888091118984;11387.829182562435;11539.88460115388;11208.49561769706;11356.318620882774;11574.826377604511;11645.708857278636;11737.88262117402;8233.423660343718;10115.696529104138;10337.638182663572;10458.581656733646;10669.946650266698;9484.95257523708;9726.659566915125;9889.109980101537;10167.918824268721;10168.491575421347;9421.481818500048;9631.325807193429;9669.516524173623;9701.951490242503;9856.260780441353 06:11:54 INFO - 2015-11-12 06:11:54,520 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:11:54 INFO - 2015-11-12 06:11:54,520 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:11:54 INFO - 2015-11-12 06:11:54,520 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,861 06:11:54 INFO - 2015-11-12 06:11:54,520 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:11:54 INFO - 2015-11-12 06:11:54,520 DEBUG : BROWSER_OUTPUT: __startTimestamp1447337514510__endTimestamp 06:11:54 INFO - 2015-11-12 06:11:54,521 DEBUG : BROWSER_OUTPUT: 06:11:54 INFO - 2015-11-12 06:11:54,521 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:11:54 INFO - 2015-11-12 06:11:54,521 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:11:54 INFO - 2015-11-12 06:11:54,521 DEBUG : BROWSER_OUTPUT: 06:11:54 INFO - 2015-11-12 06:11:54,521 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5357.23 Median:5500.26 stddev:592.13 (10.8%) stddev-sans-first:568.34 06:11:54 INFO - 2015-11-12 06:11:54,522 DEBUG : BROWSER_OUTPUT: Values: 3161.4 3193.0 3228.8 3241.0 3241.7 5208.2 5325.5 5336.2 5395.7 5422.2 5268.4 5309.4 5318.7 5380.9 5472.7 4882.0 4894.2 4895.3 4962.6 4963.8 4792.9 4935.9 4956.0 5022.1 5044.5 4790.8 4878.1 4889.5 4894.0 4910.7 4897.0 4923.5 4932.9 4939.3 4947.3 4748.7 4847.2 4886.0 4888.8 4914.3 5134.8 5221.5 5223.8 5224.7 5258.7 5732.9 5734.1 5743.9 5744.3 5767.1 5663.3 5786.8 5794.4 5798.9 5799.4 5414.9 5438.8 5442.9 5448.0 5478.8 5828.9 5834.8 5844.0 5856.6 5864.4 5500.3 5590.6 5626.0 5691.9 5754.5 5732.1 5737.5 5742.5 5744.9 5760.3 5724.1 5727.4 5729.0 5729.6 5736.5 5456.8 5580.7 5648.5 5711.1 5742.9 4458.4 4474.9 4491.5 4491.6 4499.2 3876.7 4005.1 4008.6 4011.4 4031.2 5412.6 5469.8 5488.8 5501.3 5516.1 5743.3 5746.4 5750.3 5755.1 5791.3 5241.6 5338.0 5458.0 5458.6 5463.1 4988.5 5083.4 5094.3 5098.7 5135.4 5992.4 6004.1 6005.9 6006.9 6007.2 5634.7 5636.3 5764.3 5807.7 5807.7 6108.3 6116.5 6118.6 6118.7 6119.1 5785.6 5800.1 5800.2 5800.5 5818.7 5637.1 5753.7 5796.2 5875.9 5907.1 5669.7 5691.5 5717.7 5718.3 5718.7 5691.3 5695.3 5702.3 5703.3 5703.6 5334.6 5448.6 5480.5 5571.2 5601.9 5571.8 5574.7 5619.4 5625.4 5777.0 5417.8 5466.7 5470.2 5477.2 5499.9 06:11:54 INFO - 2015-11-12 06:11:54,522 DEBUG : BROWSER_OUTPUT: 06:11:54 INFO - 2015-11-12 06:11:54,522 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49375.56 Median:18306.94 stddev:86865.78 (474.5%) stddev-sans-first:87032.16 06:11:54 INFO - 2015-11-12 06:11:54,523 DEBUG : BROWSER_OUTPUT: Values: 565.0 599.2 610.6 611.4 616.8 30386.7 39722.8 40419.0 40585.2 40603.4 43315.0 43795.6 43804.6 43852.3 43939.6 7322.0 7443.3 8627.7 8806.3 8808.6 10507.2 10683.8 10687.6 10694.8 10714.2 10350.0 10412.1 10429.0 10435.3 10453.7 7517.5 7688.6 10301.3 10464.2 10583.2 10083.3 10292.4 10320.7 10329.2 10333.4 40803.2 40965.4 41005.6 41256.0 41293.6 3217.9 3255.4 3266.4 3267.6 3300.4 30303.0 30500.4 30680.7 30930.7 31526.8 3259.6 3284.3 3298.6 3325.9 3361.4 270736.0 270766.0 271078.6 271783.0 272475.0 54233.2 54927.7 56159.7 57217.0 57537.0 60195.7 60418.1 60505.4 60507.7 60605.4 14236.8 14321.2 14333.0 14347.8 14367.4 9194.0 9202.9 9213.4 9236.0 9273.7 19058.1 19279.0 19301.6 19472.6 19494.4 7509.2 7654.3 7735.7 7769.8 7797.3 888.9 917.9 937.6 953.5 1092.4 27824.9 28091.3 28544.4 28558.7 32471.7 1011.0 1051.6 1095.7 1136.2 1167.9 15061.5 15149.2 15155.8 15265.2 15396.3 396912.0 400753.0 401074.0 402305.0 402441.0 53970.5 54251.5 54253.0 54436.2 54528.5 1102.2 1284.9 1286.2 1297.5 1328.4 23247.5 29763.9 30158.8 30193.8 30272.7 49567.3 49766.5 50355.7 50397.7 50566.5 296566.0 307582.0 308284.0 308917.0 309303.0 27003.7 32143.2 32268.0 32353.2 32706.5 37781.6 38667.0 39108.0 39158.8 39460.2 32936.2 33288.0 33468.8 33572.0 33798.0 40362.6 41263.6 41383.8 42006.6 42630.1 35526.1 35803.0 35815.1 40580.6 41108.4 32152.5 33449.3 33629.0 33775.0 34045.0 25010.0 25224.2 25386.4 25506.9 25528.2 06:11:54 INFO - 2015-11-12 06:11:54,523 DEBUG : BROWSER_OUTPUT: 06:11:54 INFO - 2015-11-12 06:11:54,523 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28781.54 Median:43328.74 stddev:95831.94 (221.2%) stddev-sans-first:96077.00 06:11:54 INFO - 2015-11-12 06:11:54,523 DEBUG : BROWSER_OUTPUT: Values: 354.6 355.4 356.7 358.0 358.8 13970.2 13988.3 17140.2 17485.3 17993.3 14172.8 14725.8 15125.4 15133.5 15380.9 5289.9 5453.2 5460.6 5461.5 5463.8 3814.4 3947.1 5475.2 5520.8 5875.2 5981.6 5993.9 5999.3 6018.2 6023.7 5808.6 5928.9 5935.3 5950.6 5971.8 5216.2 5228.0 5238.9 5239.9 5241.1 19687.0 20090.0 20316.2 20589.9 20622.0 2191.1 2228.6 2435.6 2462.5 2951.9 13061.7 13291.5 13355.5 13420.8 13604.4 1810.0 1849.2 1849.2 1856.0 1872.4 59584.4 59783.0 60357.0 60948.4 61023.0 9390.3 9563.4 9772.2 9838.5 9887.2 12826.0 12832.9 12838.6 12847.3 12852.6 5064.4 5204.9 5205.2 5481.9 6641.4 5295.1 5339.4 5349.4 5426.6 5558.3 3204.7 3246.9 3275.9 3288.2 3294.2 1121.8 1154.7 1174.3 1181.5 1202.5 470.4 474.8 480.2 481.6 485.6 11725.9 11917.3 12219.3 12256.5 12305.6 439.7 469.3 480.4 484.8 509.3 6046.8 6345.5 6370.8 6480.2 6761.1 569234.0 572646.0 583483.0 597464.0 606087.0 75081.0 75845.6 76831.0 77970.0 78219.6 556.6 561.0 561.5 562.8 563.3 10987.3 11260.0 11337.8 11411.5 11436.4 33273.8 33302.5 34079.1 34251.1 35816.1 42884.4 43773.1 44062.6 44673.8 46026.0 6590.1 6646.2 6747.6 6756.2 6825.0 12178.9 12433.1 12509.3 12609.8 12611.2 10312.2 10638.7 10852.1 11035.6 11141.4 10658.5 10686.3 10773.1 11020.9 11288.3 9135.1 9344.5 10221.3 11199.7 11449.9 6534.2 6757.8 6760.1 6779.0 6782.5 10795.3 10835.1 11042.1 11076.9 11163.1 06:11:54 INFO - 2015-11-12 06:11:54,523 DEBUG : BROWSER_OUTPUT: 06:11:54 INFO - 2015-11-12 06:11:54,523 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5205.97 Median:6409.60 stddev:2726.27 (42.5%) stddev-sans-first:2718.06 06:11:54 INFO - 2015-11-12 06:11:54,524 DEBUG : BROWSER_OUTPUT: Values: 1293.7 1493.0 1572.9 1662.2 1747.9 6756.1 7294.5 7523.2 7525.8 7544.1 7365.1 7504.9 7516.5 7516.7 7517.4 1932.4 1965.3 2158.4 2184.5 2194.1 2220.7 2227.8 2228.4 2228.8 2229.7 2156.7 2243.4 2244.9 2245.8 2247.7 1935.3 1964.7 2152.7 2165.3 2186.9 2170.4 2180.2 2205.7 2207.9 2240.5 7320.6 7381.4 7383.3 7385.7 7390.8 4325.2 4394.6 4398.0 4414.2 4419.6 2879.4 2971.6 2973.0 3016.4 3018.0 904.5 918.0 919.1 920.7 938.3 10285.0 10289.2 10291.4 10308.1 10311.7 3950.0 3999.4 4051.4 4058.3 4075.1 8781.2 8782.0 8783.1 8785.4 8796.2 4457.1 4457.3 4465.2 4467.8 4468.8 4071.3 4081.3 4084.7 4087.8 4095.1 3626.0 3651.6 3672.8 3679.7 3707.4 1134.0 1135.7 1136.7 1144.1 1152.6 998.2 1016.8 1019.7 1103.2 1267.5 7014.8 7051.5 7079.0 7079.8 7107.2 405.6 419.0 419.1 419.4 420.0 5396.6 5486.4 5515.6 5516.0 5523.9 8683.3 8737.2 8917.6 8922.2 8949.1 8900.6 8916.3 8924.6 8944.9 8970.3 6585.6 6622.7 6626.4 6629.6 6651.3 6422.5 6558.5 6562.7 6594.1 6594.4 7642.3 7901.7 7915.3 7939.0 7978.7 7957.6 8119.1 8133.3 8184.9 8281.3 6663.1 6732.4 6735.6 6737.3 6741.9 7100.1 7134.9 7227.4 7247.2 7256.8 6781.0 6823.4 6916.5 6924.1 6957.4 5833.3 6635.9 6732.4 6766.5 6929.6 6918.0 6921.2 6945.4 6962.8 6967.0 6310.2 6325.5 6381.4 6408.1 6411.1 6351.7 6401.7 6433.8 6441.9 6442.1 06:11:54 INFO - 2015-11-12 06:11:54,524 DEBUG : BROWSER_OUTPUT: 06:11:54 INFO - 2015-11-12 06:11:54,524 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5130.75 Median:5905.86 stddev:1534.44 (26.0%) stddev-sans-first:1495.65 06:11:54 INFO - 2015-11-12 06:11:54,526 DEBUG : BROWSER_OUTPUT: Values: 319.5 329.7 330.7 333.2 337.2 5689.4 5779.9 5828.2 5836.8 5845.2 5621.6 5699.4 5707.0 5729.3 5743.1 4416.7 4421.5 4428.7 4430.5 4431.8 4289.2 4343.3 4356.7 4414.9 4420.7 4335.4 4338.0 4341.0 4370.1 4370.5 4333.7 4334.8 4339.0 4339.8 4341.9 3804.6 3805.4 3809.3 3814.8 3815.6 5313.7 5406.2 5419.8 5519.4 5525.8 5100.0 5113.2 5118.3 5123.4 5126.3 6075.5 6082.9 6092.1 6095.7 6108.1 4107.2 4161.3 4219.0 4267.2 4275.3 6258.1 6259.1 6263.5 6270.3 6274.8 4355.6 4358.3 4362.9 4363.1 4367.5 4341.6 4408.8 4416.1 4416.6 4423.6 5094.1 5121.7 5125.9 5127.1 5134.9 6170.9 6176.6 6182.7 6183.4 6185.1 1610.1 1611.0 1613.2 1613.3 1613.3 1102.4 1106.9 1108.6 1128.1 1139.2 5954.1 5999.3 5999.5 6001.7 6006.4 6327.1 6340.6 6347.1 6352.1 6354.3 5882.6 5946.1 5984.7 5991.0 5991.3 3478.4 3488.2 3524.3 3527.0 3529.8 6546.6 6553.6 6588.2 6594.9 6596.5 6418.2 6425.8 6433.3 6436.9 6438.5 6468.1 6598.4 6609.1 6609.2 6611.7 6323.7 6331.3 6340.8 6341.3 6347.1 6071.2 6151.3 6179.4 6283.7 6287.3 6509.1 6560.7 6565.2 6568.2 6587.4 4391.6 4444.6 4447.4 4449.7 4450.2 6069.7 6220.0 6220.7 6230.0 6231.9 6126.8 6157.8 6159.0 6159.4 6180.6 6141.8 6142.9 6147.4 6148.0 6149.0 5929.1 6061.9 6066.5 6072.7 6074.6 6182.9 6184.4 6189.6 6190.6 6192.6 6001.8 6037.7 6048.2 6049.0 6064.7 06:11:54 INFO - 2015-11-12 06:11:54,526 DEBUG : BROWSER_OUTPUT: 06:11:54 INFO - 2015-11-12 06:11:54,526 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13126.91 Median:47879.64 stddev:15673.66 (32.7%) stddev-sans-first:15690.01 06:11:54 INFO - 2015-11-12 06:11:54,526 DEBUG : BROWSER_OUTPUT: Values: 736.4 752.7 809.3 827.5 841.8 13273.9 13436.7 13438.6 13450.7 13463.4 12242.9 12297.4 12551.3 13651.3 13680.5 671.0 803.4 814.6 814.8 816.2 676.2 822.8 837.9 844.4 846.3 850.4 861.6 866.0 872.7 873.2 704.7 712.5 856.1 861.6 864.6 642.1 643.3 643.3 643.6 643.6 13274.3 13401.7 13551.8 13552.7 13604.0 9532.4 10101.6 11460.9 12905.1 13195.7 9332.1 9427.2 9486.1 9501.5 9512.0 3167.2 3202.8 3247.4 3292.3 3331.8 44322.6 44483.8 44673.9 44698.3 46132.3 7167.4 7323.6 7353.1 7363.8 7444.3 11274.5 11339.7 11358.9 11380.5 11395.8 6157.8 6200.2 6286.7 6339.3 6423.9 4178.5 4228.1 4249.4 4253.5 4280.3 2833.7 2867.7 2875.2 2877.3 2877.3 447.2 452.2 453.9 457.2 458.6 652.7 672.0 685.0 689.3 689.6 8622.4 8826.4 8987.7 9179.8 9212.6 523.3 614.8 661.8 676.7 699.7 3858.8 4032.2 4045.5 4087.7 4160.3 56803.0 57038.0 57242.7 57828.0 57901.4 47677.8 48081.5 49325.3 50180.5 50217.0 45873.5 46125.3 46602.8 46939.0 47469.5 8658.3 8788.4 8945.9 9097.5 9111.1 31746.4 33080.3 33127.7 33803.0 35013.0 44710.0 44965.3 45524.0 45882.5 45994.8 7427.6 7466.1 7664.9 7684.5 7715.6 11727.6 11820.9 11858.2 11879.9 11983.6 10573.7 10601.9 11190.9 11387.8 11539.9 11208.5 11356.3 11574.8 11645.7 11737.9 8233.4 10115.7 10337.6 10458.6 10669.9 9485.0 9726.7 9889.1 10167.9 10168.5 9421.5 9631.3 9669.5 9702.0 9856.3 06:11:54 INFO - 2015-11-12 06:11:54,526 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:11:54 INFO - 2015-11-12 06:11:54,526 DEBUG : BROWSER_OUTPUT: 06:11:55 INFO - 2015-11-12 06:11:55,182 INFO : Browser exited with error code: 0 06:11:55 INFO - 2015-11-12 06:11:55,200 INFO : Completed test dromaeo_css (00:18:36) 06:11:55 INFO - 2015-11-12 06:11:55,200 INFO : Starting test kraken 06:11:55 INFO - 2015-11-12 06:11:55,200 DEBUG : operating with platform_type : linux_ 06:11:55 INFO - 2015-11-12 06:11:55,200 INFO : Initialising browser for kraken test... 06:11:55 INFO - 2015-11-12 06:11:55,206 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZuVzkJ/profile http://localhost:34886/getInfo.html 06:11:59 INFO - 2015-11-12 06:11:59,246 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:11:59 INFO - 2015-11-12 06:11:59,247 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:11:59 INFO - 2015-11-12 06:11:59,247 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:11:59 INFO - 2015-11-12 06:11:59,247 DEBUG : BROWSER_OUTPUT: __metrics 06:11:59 INFO - 2015-11-12 06:11:59,408 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:00 INFO - 2015-11-12 06:12:00,776 INFO : Browser initialized. 06:12:00 INFO - 2015-11-12 06:12:00,776 INFO : Running cycle 1/1 for kraken test... 06:12:00 INFO - 2015-11-12 06:12:00,777 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZuVzkJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:12:12 INFO - 2015-11-12 06:12:12,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 139214848 06:12:12 INFO - 2015-11-12 06:12:12,522 DEBUG : BROWSER_OUTPUT: 06:12:14 INFO - 2015-11-12 06:12:14,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34886/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:15 INFO - 2015-11-12 06:12:15,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 181321728 06:12:15 INFO - 2015-11-12 06:12:15,562 DEBUG : BROWSER_OUTPUT: 06:12:18 INFO - 2015-11-12 06:12:18,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34886/tests/kraken/driver.html?testName=audio-dft) 06:12:18 INFO - 2015-11-12 06:12:18,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 170057728 06:12:18 INFO - 2015-11-12 06:12:18,685 DEBUG : BROWSER_OUTPUT: 06:12:21 INFO - 2015-11-12 06:12:21,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34886/tests/kraken/driver.html?testName=audio-fft) 06:12:22 INFO - 2015-11-12 06:12:22,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 149934080 06:12:22 INFO - 2015-11-12 06:12:22,099 DEBUG : BROWSER_OUTPUT: 06:12:24 INFO - 2015-11-12 06:12:24,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34886/tests/kraken/driver.html?testName=audio-oscillator) 06:12:24 INFO - 2015-11-12 06:12:24,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 153583616 06:12:24 INFO - 2015-11-12 06:12:24,633 DEBUG : BROWSER_OUTPUT: 06:12:26 INFO - 2015-11-12 06:12:26,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34886/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:27 INFO - 2015-11-12 06:12:27,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 154923008 06:12:27 INFO - 2015-11-12 06:12:27,343 DEBUG : BROWSER_OUTPUT: 06:12:30 INFO - 2015-11-12 06:12:30,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34886/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:30 INFO - 2015-11-12 06:12:30,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 156418048 06:12:30 INFO - 2015-11-12 06:12:30,813 DEBUG : BROWSER_OUTPUT: 06:12:34 INFO - 2015-11-12 06:12:34,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34886/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:34 INFO - 2015-11-12 06:12:34,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 155295744 06:12:34 INFO - 2015-11-12 06:12:34,795 DEBUG : BROWSER_OUTPUT: 06:12:37 INFO - 2015-11-12 06:12:37,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34886/tests/kraken/driver.html?testName=json-parse-financial) 06:12:38 INFO - 2015-11-12 06:12:38,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 156704768 06:12:38 INFO - 2015-11-12 06:12:38,182 DEBUG : BROWSER_OUTPUT: 06:12:39 INFO - 2015-11-12 06:12:39,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34886/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:40 INFO - 2015-11-12 06:12:40,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 166268928 06:12:40 INFO - 2015-11-12 06:12:40,331 DEBUG : BROWSER_OUTPUT: 06:12:42 INFO - 2015-11-12 06:12:42,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34886/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:42 INFO - 2015-11-12 06:12:42,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 166481920 06:12:42 INFO - 2015-11-12 06:12:42,708 DEBUG : BROWSER_OUTPUT: 06:12:44 INFO - 2015-11-12 06:12:44,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34886/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:45 INFO - 2015-11-12 06:12:45,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 175017984 06:12:45 INFO - 2015-11-12 06:12:45,371 DEBUG : BROWSER_OUTPUT: 06:12:47 INFO - 2015-11-12 06:12:47,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:48 INFO - 2015-11-12 06:12:48,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 183341056 06:12:48 INFO - 2015-11-12 06:12:48,372 DEBUG : BROWSER_OUTPUT: 06:12:50 INFO - 2015-11-12 06:12:50,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:51 INFO - 2015-11-12 06:12:51,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 180523008 06:12:51 INFO - 2015-11-12 06:12:51,492 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34886/tests/kraken/driver.html?testName=ai-astar) 06:12:53 INFO - 2015-11-12 06:12:53,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 239816704 06:12:53 INFO - 2015-11-12 06:12:53,412 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,412 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:12:53 INFO - 2015-11-12 06:12:53,412 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:12:53 INFO - 2015-11-12 06:12:53,412 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:12:53 INFO - 2015-11-12 06:12:53,412 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:12:53 INFO - 2015-11-12 06:12:53,412 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;105;109;109;111;98;109;112;110 06:12:53 INFO - 2015-11-12 06:12:53,412 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;123;147;162;124;149;146;124;157;123 06:12:53 INFO - 2015-11-12 06:12:53,413 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;160;160;162;158;161;159;162 06:12:53 INFO - 2015-11-12 06:12:53,413 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;83;91;72;71;70;101;90;77 06:12:53 INFO - 2015-11-12 06:12:53,413 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;145;90;90;90;131;89;89;133 06:12:53 INFO - 2015-11-12 06:12:53,413 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;110;110;110;109;110;109 06:12:53 INFO - 2015-11-12 06:12:53,413 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;146;146;146;146;145;145 06:12:53 INFO - 2015-11-12 06:12:53,413 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;96;96;96;97;96 06:12:53 INFO - 2015-11-12 06:12:53,413 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;60;58;58;58;58;58;66;56;56 06:12:53 INFO - 2015-11-12 06:12:53,414 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;66;69;66;65;66;67;67;66;66 06:12:53 INFO - 2015-11-12 06:12:53,414 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;87;85;85;85;93;92;86;85 06:12:53 INFO - 2015-11-12 06:12:53,414 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;131;123;114;121;124;118;132;118;117 06:12:53 INFO - 2015-11-12 06:12:53,414 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;147;148;152;149;139;155;148;147;138 06:12:53 INFO - 2015-11-12 06:12:53,414 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;67;65;70;68;66;73;65;65 06:12:53 INFO - 2015-11-12 06:12:53,415 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:12:53 INFO - 2015-11-12 06:12:53,415 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:12:53 INFO - 2015-11-12 06:12:53,415 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,913 06:12:53 INFO - 2015-11-12 06:12:53,415 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:12:53 INFO - 2015-11-12 06:12:53,415 DEBUG : BROWSER_OUTPUT: __startTimestamp1447337573406__endTimestamp 06:12:53 INFO - 2015-11-12 06:12:53,415 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,416 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:12:53 INFO - 2015-11-12 06:12:53,416 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:12:53 INFO - 2015-11-12 06:12:53,416 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,416 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:109.50 stddev:3.98 (3.6%) stddev-sans-first:4.21 06:12:53 INFO - 2015-11-12 06:12:53,416 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 105.0 109.0 109.0 111.0 98.0 109.0 112.0 110.0 06:12:53 INFO - 2015-11-12 06:12:53,416 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,417 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.20 Median:147.00 stddev:15.19 (10.3%) stddev-sans-first:15.91 06:12:53 INFO - 2015-11-12 06:12:53,417 DEBUG : BROWSER_OUTPUT: Values: 147.0 123.0 147.0 162.0 124.0 149.0 146.0 124.0 157.0 123.0 06:12:53 INFO - 2015-11-12 06:12:53,417 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,418 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 06:12:53 INFO - 2015-11-12 06:12:53,418 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 160.0 160.0 162.0 158.0 161.0 159.0 162.0 06:12:53 INFO - 2015-11-12 06:12:53,418 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,418 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:74.50 stddev:10.90 (14.6%) stddev-sans-first:11.19 06:12:53 INFO - 2015-11-12 06:12:53,418 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 83.0 91.0 72.0 71.0 70.0 101.0 90.0 77.0 06:12:53 INFO - 2015-11-12 06:12:53,418 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.60 Median:89.50 stddev:22.87 (25.6%) stddev-sans-first:23.64 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 145.0 90.0 90.0 90.0 131.0 89.0 89.0 133.0 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.00 stddev:2.88 (5.0%) stddev-sans-first:3.00 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: Values: 57.0 60.0 58.0 58.0 58.0 58.0 58.0 66.0 56.0 56.0 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,419 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:1.16 (1.8%) stddev-sans-first:1.13 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 69.0 66.0 65.0 66.0 67.0 67.0 66.0 66.0 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.00 stddev:3.12 (3.6%) stddev-sans-first:3.14 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 87.0 85.0 85.0 85.0 93.0 92.0 86.0 85.0 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:122.00 stddev:5.93 (4.9%) stddev-sans-first:6.20 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: Values: 119.0 131.0 123.0 114.0 121.0 124.0 118.0 132.0 118.0 117.0 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:148.00 stddev:6.06 (4.1%) stddev-sans-first:5.48 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: Values: 137.0 147.0 148.0 152.0 149.0 139.0 155.0 148.0 147.0 138.0 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:66.50 stddev:2.60 (3.9%) stddev-sans-first:2.73 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 67.0 65.0 70.0 68.0 66.0 73.0 65.0 65.0 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:12:53 INFO - 2015-11-12 06:12:53,420 DEBUG : BROWSER_OUTPUT: 06:12:54 INFO - 2015-11-12 06:12:54,342 INFO : Browser exited with error code: 0 06:12:54 INFO - 2015-11-12 06:12:54,392 INFO : Completed test kraken (00:00:59) 06:12:54 INFO - 2015-11-12 06:12:54,392 INFO : Starting test v8_7 06:12:54 INFO - 2015-11-12 06:12:54,392 DEBUG : operating with platform_type : linux_ 06:12:54 INFO - 2015-11-12 06:12:54,392 INFO : Initialising browser for v8_7 test... 06:12:54 INFO - 2015-11-12 06:12:54,398 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdCZc2F/profile http://localhost:34886/getInfo.html 06:12:58 INFO - 2015-11-12 06:12:58,620 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:12:58 INFO - 2015-11-12 06:12:58,620 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:12:58 INFO - 2015-11-12 06:12:58,620 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:12:58 INFO - 2015-11-12 06:12:58,620 DEBUG : BROWSER_OUTPUT: __metrics 06:12:58 INFO - 2015-11-12 06:12:58,737 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:13:00 INFO - 2015-11-12 06:13:00,169 INFO : Browser initialized. 06:13:00 INFO - 2015-11-12 06:13:00,169 INFO : Running cycle 1/1 for v8_7 test... 06:13:00 INFO - 2015-11-12 06:13:00,170 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdCZc2F/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:13:11 INFO - 2015-11-12 06:13:11,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 138854400 06:13:11 INFO - 2015-11-12 06:13:11,926 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34886/tests/v8_7/run.html (next: http://localhost:34886/tests/v8_7/run.html) 06:13:33 INFO - 2015-11-12 06:13:33,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 528781312 06:13:33 INFO - 2015-11-12 06:13:33,535 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,535 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:13:33 INFO - 2015-11-12 06:13:33,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:13:33 INFO - 2015-11-12 06:13:33,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:13:33 INFO - 2015-11-12 06:13:33,535 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:13:33 INFO - 2015-11-12 06:13:33,536 DEBUG : BROWSER_OUTPUT: |0;Richards;170.09695526450076 06:13:33 INFO - 2015-11-12 06:13:33,536 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;195.00780031201248 06:13:33 INFO - 2015-11-12 06:13:33,536 DEBUG : BROWSER_OUTPUT: |2;Encrypt;289.1844997108155 06:13:33 INFO - 2015-11-12 06:13:33,536 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 06:13:33 INFO - 2015-11-12 06:13:33,536 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2032.520325203252 06:13:33 INFO - 2015-11-12 06:13:33,536 DEBUG : BROWSER_OUTPUT: |5;Earley;805.1529790660226 06:13:33 INFO - 2015-11-12 06:13:33,537 DEBUG : BROWSER_OUTPUT: |6;Boyer;12023.809523809523 06:13:33 INFO - 2015-11-12 06:13:33,537 DEBUG : BROWSER_OUTPUT: |7;RegExp;25897.4358974359 06:13:33 INFO - 2015-11-12 06:13:33,537 DEBUG : BROWSER_OUTPUT: |8;Splay;600.9615384615385 06:13:33 INFO - 2015-11-12 06:13:33,537 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 06:13:33 INFO - 2015-11-12 06:13:33,537 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:13:33 INFO - 2015-11-12 06:13:33,538 DEBUG : BROWSER_OUTPUT: __startTimestamp1447337613532__endTimestamp 06:13:33 INFO - 2015-11-12 06:13:33,538 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,538 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:13:33 INFO - 2015-11-12 06:13:33,538 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:13:33 INFO - 2015-11-12 06:13:33,538 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,538 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.10 Median:170.10 stddev:0.00 (0.0%) 06:13:33 INFO - 2015-11-12 06:13:33,539 DEBUG : BROWSER_OUTPUT: Values: 170.1 06:13:33 INFO - 2015-11-12 06:13:33,539 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,539 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:195.01 Median:195.01 stddev:0.00 (0.0%) 06:13:33 INFO - 2015-11-12 06:13:33,539 DEBUG : BROWSER_OUTPUT: Values: 195.0 06:13:33 INFO - 2015-11-12 06:13:33,539 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,540 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:289.18 Median:289.18 stddev:0.00 (0.0%) 06:13:33 INFO - 2015-11-12 06:13:33,540 DEBUG : BROWSER_OUTPUT: Values: 289.2 06:13:33 INFO - 2015-11-12 06:13:33,540 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,540 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 06:13:33 INFO - 2015-11-12 06:13:33,541 DEBUG : BROWSER_OUTPUT: Values: 5050.5 06:13:33 INFO - 2015-11-12 06:13:33,541 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,541 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2032.52 Median:2032.52 stddev:0.00 (0.0%) 06:13:33 INFO - 2015-11-12 06:13:33,541 DEBUG : BROWSER_OUTPUT: Values: 2032.5 06:13:33 INFO - 2015-11-12 06:13:33,541 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,541 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:805.15 Median:805.15 stddev:0.00 (0.0%) 06:13:33 INFO - 2015-11-12 06:13:33,542 DEBUG : BROWSER_OUTPUT: Values: 805.2 06:13:33 INFO - 2015-11-12 06:13:33,542 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,542 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12023.81 Median:12023.81 stddev:0.00 (0.0%) 06:13:33 INFO - 2015-11-12 06:13:33,542 DEBUG : BROWSER_OUTPUT: Values: 12023.8 06:13:33 INFO - 2015-11-12 06:13:33,542 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,542 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25897.44 Median:25897.44 stddev:0.00 (0.0%) 06:13:33 INFO - 2015-11-12 06:13:33,543 DEBUG : BROWSER_OUTPUT: Values: 25897.4 06:13:33 INFO - 2015-11-12 06:13:33,543 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,544 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.96 Median:600.96 stddev:0.00 (0.0%) 06:13:33 INFO - 2015-11-12 06:13:33,544 DEBUG : BROWSER_OUTPUT: Values: 601.0 06:13:33 INFO - 2015-11-12 06:13:33,544 DEBUG : BROWSER_OUTPUT: 06:13:33 INFO - 2015-11-12 06:13:33,544 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 06:13:33 INFO - 2015-11-12 06:13:33,544 DEBUG : BROWSER_OUTPUT: Values: 4822.1 06:13:33 INFO - 2015-11-12 06:13:33,545 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:13:33 INFO - 2015-11-12 06:13:33,545 DEBUG : BROWSER_OUTPUT: 06:13:34 INFO - 2015-11-12 06:13:34,445 INFO : Browser exited with error code: 0 06:13:34 INFO - 2015-11-12 06:13:34,462 INFO : Completed test v8_7 (00:00:40) 06:13:34 INFO - 2015-11-12 06:13:34,588 INFO : Completed test suite (00:20:16) 06:13:34 INFO - 2015-11-12 06:13:34,588 DEBUG : Working with test: dromaeo_css 06:13:34 INFO - 2015-11-12 06:13:34,588 DEBUG : Generating results file: dromaeo_css 06:13:34 INFO - 2015-11-12 06:13:34,589 DEBUG : Working with test: kraken 06:13:34 INFO - 2015-11-12 06:13:34,589 DEBUG : Generating results file: kraken 06:13:34 INFO - 2015-11-12 06:13:34,589 INFO : javascript benchmark 06:13:34 INFO - 2015-11-12 06:13:34,590 DEBUG : Working with test: v8_7 06:13:34 INFO - 2015-11-12 06:13:34,590 DEBUG : Generating results file: v8_7 06:13:34 INFO - 2015-11-12 06:13:34,590 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:34 INFO - 2015-11-12 06:13:34,739 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:13:34 INFO - 2015-11-12 06:13:34,739 DEBUG : process_Request line: dromaeo_css 6639.31 graph.html#tests=[[72,1,35]] 06:13:34 INFO - 2015-11-12 06:13:34,740 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:34 INFO - 2015-11-12 06:13:34,770 DEBUG : process_Request line: kraken 1489.50 graph.html#tests=[[232,1,35]] 06:13:34 INFO - 2015-11-12 06:13:34,771 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:34 INFO - 2015-11-12 06:13:34,813 DEBUG : process_Request line: v8_7 19674.28 graph.html#tests=[[230,1,35]] 06:13:34 INFO - 2015-11-12 06:13:34,814 INFO : javascript benchmark 06:13:34 INFO - 2015-11-12 06:13:34,817 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [354.5727398484826, 355.35503061942575, 356.6807707102142, 357.98210089495535, 358.7596310471984, 13970.231637259947, 13988.300584970737, 17140.22868970896, 17485.300587976482, 17993.28026878925, 14172.787408188886, 14725.779113313281, 15125.394984200646, 15133.545993620182, 15380.923095384536, 5289.894202115965, 5453.182022696587, 5460.6177567570285, 5461.508464238218, 5463.836084917439, 3814.408766641175, 3947.1118998225456, 5475.233467314579, 5520.806771762989, 5875.177475153482, 5981.551383646222, 5993.910091348634, 5999.280086389639, 6018.247719035121, 6023.668698221596, 5808.56435767317, 5928.940710592904, 5935.317438494585, 5950.5834591578605, 5971.820845374646, 5216.217567364888, 5227.954409118153, 5238.947610523884, 5239.895202095937, 5241.056609810233, 19687.0, 20090.0, 20316.187352505884, 20589.897050514803, 20622.0, 2191.1345018717675, 2228.576570451609, 2435.646831209465, 2462.532118897404, 2951.8524073796225, 13061.673458163526, 13291.53479628218, 13355.465781368734, 13420.79611689116, 13604.387802548908, 1809.9819001809944, 1849.1794141942992, 1849.2048419179748, 1855.9814401855945, 1872.372755127034, 59584.40415595832, 59783.0, 60357.0, 60948.39051609472, 61023.0, 9390.295727820441, 9563.378380405251, 9772.169365604002, 9838.458884761263, 9887.159591434665, 12826.0, 12832.946728523391, 12838.55065072718, 12847.293398863152, 12852.614421567368, 5064.41759197697, 5204.869878253074, 5205.167173252262, 5481.890362192814, 6641.369069938348, 5295.073362161606, 5339.385970613352, 5349.384820745664, 5426.647267927651, 5558.277423934944, 3204.6955539223736, 3246.935061298761, 3275.901722948315, 3288.2272665923488, 3294.225856923621, 1121.8276900638853, 1154.6766905266538, 1174.3130268792852, 1181.4506254591483, 1202.5370232460566, 470.40493775374176, 474.83380816714566, 480.15998732773556, 481.62433302024476, 485.63577317012243, 11725.882741172649, 11917.284962902253, 12219.26684398939, 12256.509739610316, 12305.56930507428, 439.73615830501444, 469.3499503188109, 480.3539239722568, 484.82788610043633, 509.26157072245394, 6046.758129674764, 6345.460635846005, 6370.8088757337355, 6480.222373315232, 6761.121054262914, 569234.0, 572646.0, 583483.0, 597464.0, 606087.0, 75081.0, 75845.62077189579, 76831.0, 77970.0, 78219.60890195513, 556.6298411556351, 560.9523190528851, 561.4722161168488, 562.7636392715069, 563.2621266141368, 10987.285826421257, 11260.0, 11337.829932550854, 11411.486483108447, 11436.428178590872, 33273.833630831694, 33302.5004624926, 34079.14802129967, 34251.14372140716, 35816.104597385274, 42884.35673464963, 43773.12453750843, 44062.55937440584, 44673.77663111794, 46026.0, 6590.1103351046995, 6646.169228846395, 6747.595144291358, 6756.155480564929, 6825.044493770975, 12178.939105304771, 12433.12968092225, 12509.311987840756, 12609.810852837032, 12611.243325400505, 10312.226583006155, 10638.73403164927, 10852.131829453467, 11035.613753518588, 11141.442927853737, 10658.467076645982, 10686.305390149615, 10773.138148948223, 11020.889791102307, 11288.2662626929, 9135.132162444557, 9344.486053267136, 10221.284510084222, 11199.72000699989, 11449.885501144881, 6534.215894092739, 6757.797266082025, 6760.121184246016, 6778.96610516964, 6782.491313151632, 10795.29830561011, 10835.133189344675, 11042.116630669689, 11076.889231107585, 11163.106951443702], "dojo.html": [3161.4309424303624, 3193.042087373787, 3228.8062716237027, 3240.9837950810243, 3241.6920392562706, 5208.218767184924, 5325.520703136717, 5336.17289320155, 5395.7032363220005, 5422.186671999197, 5268.367795864492, 5309.4425085365965, 5318.734063296839, 5380.946190538093, 5472.671639701621, 4882.048000639877, 4894.167991441445, 4895.265710143489, 4962.578180854632, 4963.801447942078, 4792.90414191716, 4935.851924442254, 4955.975220123913, 5022.096022715909, 5044.470330615288, 4790.784414701347, 4878.146324393235, 4889.511048895082, 4893.95106048942, 4910.705357678551, 4897.0, 4923.507649235084, 4932.926006109911, 4939.2838038484215, 4947.307376967227, 4748.691335063209, 4847.2486764551195, 4886.02279544089, 4888.804447822083, 4914.33656456381, 5134.768935397916, 5221.477852214786, 5223.791048358099, 5224.686518808883, 5258.684478931276, 5732.856678583027, 5734.139879018139, 5743.856403589902, 5744.281964754406, 5767.106098554731, 5663.32040155184, 5786.826395208151, 5794.391588883191, 5798.884022319572, 5799.3620701722775, 5414.864628384243, 5438.782448702087, 5442.863928401822, 5447.972760136214, 5478.780848766045, 5828.912566311508, 5834.766609335664, 5843.970780146072, 5856.619319744203, 5864.413558644187, 5500.257465242141, 5590.608657394025, 5626.0, 5691.857703557444, 5754.510866576388, 5732.140178973104, 5737.483626473638, 5742.54059675225, 5744.856378590569, 5760.251167348218, 5724.084146536534, 5727.398623144593, 5729.0, 5729.5702822288495, 5736.483716465538, 5456.7544460499375, 5580.748866301026, 5648.491635752802, 5711.114777209539, 5742.856428589319, 4458.375827384104, 4474.932876006863, 4491.461024676994, 4491.550844915482, 4499.167653984024, 3876.7286289959998, 4005.078831868628, 4008.6392224699916, 4011.4183443401125, 4031.2139132869397, 5412.648177868426, 5469.835904922858, 5488.780448782084, 5501.257330260363, 5516.117421212587, 5743.282089738783, 5746.396628353963, 5750.338711048283, 5755.079187330007, 5791.276090488689, 5241.580673546107, 5338.039152952506, 5458.044842152607, 5458.590605704588, 5463.125899856004, 4988.476209997971, 5083.415407228142, 5094.261332106824, 5098.745062746848, 5135.383753949475, 5992.43071908168, 6004.099385092184, 6005.909911351333, 6006.939930600638, 6007.189029481052, 5634.74643641029, 5636.267285252891, 5764.279465066867, 5807.651540907559, 5807.680577568274, 6108.328083910677, 6116.4922381823235, 6118.60229085108, 6118.653896142841, 6119.144993449551, 5785.566082543742, 5800.100984347433, 5800.187973683604, 5800.535957123504, 5818.709064546841, 5637.098064309691, 5753.654780713171, 5796.217510636179, 5875.853103672443, 5907.113932909926, 5669.659820410624, 5691.459311365414, 5717.685527296038, 5718.25662663851, 5718.714064296852, 5691.26013618227, 5695.316562012585, 5702.258706368146, 5703.344115426779, 5703.600747947769, 5334.599905007218, 5448.591355648421, 5480.451954804487, 5571.220029195835, 5601.943980560142, 5571.804986825604, 5574.665520068809, 5619.438056194348, 5625.353084395347, 5777.0, 5417.8103766367985, 5466.699331536804, 5470.206820011155, 5477.178423236546, 5499.862503437286], "mootools.html": [1293.7283170534188, 1492.970140597188, 1572.8584427401536, 1662.1855290907451, 1747.9213435395397, 6756.121704178456, 7294.489385742993, 7523.172451030396, 7525.849483010336, 7544.0569928758905, 7365.079365079365, 7504.924950750491, 7516.511426757271, 7516.699332026726, 7517.436192285573, 1932.3816378758802, 1965.3023176772253, 2158.417227348615, 2184.541246338267, 2194.089452877054, 2220.7224096987875, 2227.7883601057956, 2228.353777404559, 2228.7882651148116, 2229.732432108149, 2156.6657168138963, 2243.4391402149463, 2244.8540844845033, 2245.786650268222, 2247.6628505724107, 1935.2936178294963, 1964.7327473779403, 2152.698622192894, 2165.307101727448, 2186.9125234990584, 2170.3597438755605, 2180.2151225558787, 2205.6801763744165, 2207.9116835326568, 2240.5070884405404, 7320.560766353982, 7381.446391520657, 7383.2985866342615, 7385.741499047561, 7390.815229619248, 4325.156594464081, 4394.648428125743, 4398.0, 4414.249577571821, 4419.558044195587, 2879.3521457671854, 2971.628546431696, 2972.970270297291, 3016.351484430858, 3018.0, 904.5477261369315, 917.9632814687404, 919.1130559010587, 920.7329874336434, 938.258775567301, 10285.0, 10289.176865850714, 10291.433971131584, 10308.072273495347, 10311.742206444824, 3949.960500395017, 3999.4200840878493, 4051.4125451809323, 4058.3100872851687, 4075.062735570776, 8781.20969112783, 8781.956090219635, 8783.077776833468, 8785.385023048326, 8796.164364385373, 4457.086297309044, 4457.286834106528, 4465.24090904547, 4467.798949047301, 4468.798904049326, 4071.328230841878, 4081.3265811141423, 4084.65280451159, 4087.795610219477, 4095.1400205957084, 3626.0, 3651.6165802590876, 3672.7979961102396, 3679.6504332088944, 3707.351213537674, 1133.971650708739, 1135.7047167736448, 1136.6760473265244, 1144.0504381363448, 1152.567787079845, 998.2213873178932, 1016.8271393863062, 1019.7144799456164, 1103.150574057971, 1267.512007876974, 7014.824629384204, 7051.541649792747, 7079.04432901562, 7079.787606371817, 7107.218205997337, 405.59643155060314, 418.9985933618654, 419.0926643816165, 419.38560009586104, 419.9643030342394, 5396.64921780083, 5486.396496385394, 5515.61390702655, 5515.972420137874, 5523.944760552343, 8683.348748843862, 8737.169968852948, 8917.643294268286, 8922.197002269826, 8949.060348663426, 8900.554972251362, 8916.28669706435, 8924.643014279356, 8944.910550894409, 8970.282377409792, 6585.5719378240265, 6622.735090596419, 6626.370494803083, 6629.602223866584, 6651.268360480343, 6422.486201103807, 6558.475321974326, 6562.671866406756, 6594.10979517759, 6594.406503414716, 7642.273983971514, 7901.723439679584, 7915.287624113857, 7938.960305198437, 7978.720744773905, 7957.641906114354, 8119.147489513516, 8133.308668762985, 8184.918150818416, 8281.29608983243, 6663.100481435138, 6732.360425759545, 6735.595864248161, 6737.25890152073, 6741.898871517029, 7100.076989991268, 7134.857302854018, 7227.385672217921, 7247.2390399009455, 7256.7822965311125, 6781.0, 6823.385895269251, 6916.51584389108, 6924.099867017256, 6957.443404527727, 5833.329167145833, 6635.933640663725, 6732.360425759545, 6766.458683305422, 6929.618870962146, 6918.0, 6921.169459664872, 6945.409640180439, 6962.756303529555, 6967.024616553788, 6310.242770867525, 6325.525585581007, 6381.425671689571, 6408.102865598727, 6411.102445657519, 6351.745930162927, 6401.743930242738, 6433.774817881352, 6441.903371449338, 6442.065900444316], "ext.html": [564.9830505084847, 599.1851082527761, 610.5725991805737, 611.3977731934046, 616.7717944360587, 30386.696133038662, 39722.801385993065, 40419.0, 40585.18829623406, 40603.39094913571, 43315.0, 43795.56204437955, 43804.56195438045, 43852.3422148668, 43939.56060439395, 7321.963390183042, 7443.292887175709, 8627.65489380424, 8806.251468625174, 8808.559572021406, 10507.211959103099, 10683.78632427351, 10687.625933092344, 10694.78610427795, 10714.196435267386, 10350.0, 10412.062914337708, 10429.0, 10435.32170408921, 10453.73865653361, 7517.4737768356235, 7688.5771282579435, 10301.27891047627, 10464.162866970624, 10583.206259530489, 10083.344582602107, 10292.433916134609, 10320.690379288633, 10329.173666106768, 10333.431661258628, 40803.183936321104, 40965.385519217234, 41005.58994410077, 41256.0, 41293.58706412927, 3217.8551965161623, 3255.3814775192636, 3266.395716792401, 3267.607887053569, 3300.4389253826907, 30303.0, 30500.389992200253, 30680.69319306823, 30930.69069309323, 31526.842365788252, 3259.608846938359, 3284.3431313737346, 3298.5546951161764, 3325.88359407422, 3361.3613413451367, 270736.0, 270766.0, 271078.6446067777, 271783.0, 272475.0, 54233.1865022025, 54927.725361373734, 56159.71920140373, 57217.0, 57537.0, 60195.69902150461, 60418.0937285941, 60505.39494604998, 60507.69746151241, 60605.39394605997, 14236.786448203078, 14321.212333321559, 14333.0, 14347.78478322826, 14367.353469093707, 9194.0, 9202.90797092034, 9213.355065145375, 9236.0, 9273.72178834636, 19058.1211100678, 19279.0, 19301.61396772057, 19472.610547788965, 19494.415167544998, 7509.211532789088, 7654.349380302625, 7735.729249476354, 7769.7669069928, 7797.259260370256, 888.9377743557889, 917.9357444978921, 937.5921474158763, 953.4851180362665, 1092.4373947417087, 27824.860875695493, 28091.297717556816, 28544.429111417656, 28558.71441285602, 32471.675283246866, 1011.0092109732503, 1051.5846240734868, 1095.7260684828793, 1136.153565593638, 1167.9007284380752, 15061.472848450252, 15149.242537873062, 15155.848441515664, 15265.160416176996, 15396.307166177325, 396912.0, 400753.0, 401074.0, 402305.0, 402441.0, 53970.46029539733, 54251.45748542543, 54253.0, 54436.183457248175, 54528.45471545234, 1102.2119184782919, 1284.8715128487263, 1286.2218357893528, 1297.5199176304827, 1328.448693792085, 23247.53504929926, 29763.851180743957, 30158.84920575383, 30193.849030754707, 30272.69727302787, 49567.256491153385, 49766.50233497618, 50355.74822125866, 50397.74801125971, 50566.49433505618, 296566.0, 307582.0, 308284.0, 308917.0, 309303.0, 27003.729962700123, 32143.19642008875, 32267.998460237763, 32353.191170220933, 32706.50940235946, 37781.622183777814, 38667.0, 39108.0, 39158.80420597879, 39460.21079578335, 32936.176595585304, 33288.0, 33468.832655836566, 33572.0, 33798.0, 40362.596374035886, 41263.587364125975, 41383.793081034404, 42006.579934200265, 42630.147397052504, 35526.11184720299, 35803.0, 35815.10462238465, 40580.59419405886, 41108.38337425001, 32152.51771223387, 33449.32405407513, 33629.00653803268, 33775.0, 34045.0, 25010.0, 25224.24327270185, 25386.365340866625, 25506.872465637553, 25528.23415297544], "prototype.html": [319.4920077077447, 329.6653896295261, 330.7073240182438, 333.19865722936333, 337.20419809250166, 5689.431056894308, 5779.942200577993, 5828.184054232411, 5836.766529338826, 5845.240118784557, 5621.550275977912, 5699.430056994299, 5707.0, 5729.255196824417, 5743.081107022877, 4416.668749843775, 4421.513633500313, 4428.667849911253, 4430.5126436092005, 4431.756253406062, 4289.1850548395705, 4343.348497725351, 4356.716813407118, 4414.8675539733695, 4420.668449866257, 4335.414719012924, 4337.9566204338025, 4340.956590434087, 4370.104128653635, 4370.519242883296, 4333.65330773539, 4334.783260836945, 4338.978305108454, 4339.8481053163305, 4341.869743907656, 3804.5814960354337, 3805.4101614249835, 3809.3333666608232, 3814.7520411173186, 3815.561210460805, 5313.707746073965, 5406.189071639246, 5419.8374048778205, 5519.365272993617, 5525.778968841241, 5099.954509325579, 5113.181890897476, 5118.334616499868, 5123.359580052494, 5126.307948426989, 6075.453209211148, 6082.878342433127, 6092.08618707193, 6095.6952152392205, 6108.114323423123, 4107.240160570304, 4161.334186530141, 4218.957810421887, 4267.1892340455215, 4275.337322714984, 6258.092576576371, 6259.061140828867, 6263.498920086382, 6270.278917924452, 6274.780382686629, 4355.60799528044, 4358.324459708687, 4362.8691139265875, 4363.127374525107, 4367.541408152162, 4341.587549182823, 4408.801603927831, 4416.050549131952, 4416.580424859633, 4423.5576442355505, 5094.057599344133, 5121.718305493159, 5125.948740512547, 5127.102757017507, 5134.871628209325, 6170.938290617037, 6176.629402235791, 6182.721777520022, 6183.443490085824, 6185.103160041859, 1610.114437059636, 1611.04948080633, 1613.1772795873953, 1613.3062783003186, 1613.3304678558268, 1102.404701461218, 1106.8671759388765, 1108.6396921000708, 1128.1482480727, 1139.2424038014628, 5954.07711804671, 5999.250093738283, 5999.460048595647, 6001.729922153513, 6006.429389208019, 6327.114204011442, 6340.619562826153, 6347.1114044033875, 6352.078948552434, 6354.269259035178, 5882.588218824727, 5946.137810017523, 5984.73068711909, 5991.0, 5991.340952495222, 3478.3912815257227, 3488.232588830453, 3524.3479956208184, 3527.012436517779, 3529.7529172957647, 6546.639934803631, 6553.606783593, 6588.176477940257, 6594.934050659528, 6596.472282217411, 6418.229812422539, 6425.807225783234, 6433.292337842833, 6436.903446448307, 6438.45273151778, 6468.126802881645, 6598.439132673777, 6609.1408116944485, 6609.173853268341, 6611.66941652925, 6323.747050117944, 6331.3352098029045, 6340.841478963062, 6341.334159913143, 6347.143135676624, 6071.241094863142, 6151.292601350902, 6179.3820617937845, 6283.654399008098, 6287.339829317856, 6509.121268628674, 6560.737570497126, 6565.179352580927, 6568.1789776277965, 6587.440067594116, 4391.5827996340295, 4444.599986001146, 4447.355133505559, 4449.688521803443, 4450.154470650566, 6069.726862291119, 6220.0, 6220.657863817533, 6230.0, 6231.937680623136, 6126.816195514141, 6157.784477543264, 6158.969205153946, 6159.414855588712, 6180.6291622502795, 6141.815745527641, 6142.877142457037, 6147.354527774519, 6147.969260153671, 6148.9692551536955, 5929.140274660236, 6061.878762424815, 6066.545009124245, 6072.696365181811, 6074.635521868702, 6182.938170618416, 6184.381561843959, 6189.6286222826775, 6190.628562286277, 6192.59748116371, 6001.789937352171, 6037.728302226323, 6048.243969503812, 6049.032154855202, 6064.727087280995], "yui.html": [736.4476642518111, 752.6725874244701, 809.3120847279811, 827.4828232354778, 841.8105926166613, 13273.867261327383, 13436.731265374687, 13438.596842094728, 13450.663733406658, 13463.394147263372, 12242.938785306062, 12297.385130743472, 12551.309677967709, 13651.317434128303, 13680.52118175864, 670.9865802683944, 803.3974519110652, 814.5519964019766, 814.7596459044596, 816.1756625807947, 676.164936303667, 822.8354329134168, 837.8910741603582, 844.3793811548506, 846.2510678049939, 850.3877208409966, 861.6381119929645, 865.9783505412352, 872.6771094694972, 873.1704880363649, 704.7181127548996, 712.5368510468186, 856.0797143071161, 861.6208868098048, 864.5849992003842, 642.1331202876127, 643.2506130358174, 643.2666759893725, 643.5848877474003, 643.6234802640461, 13274.336283185801, 13401.66495837602, 13551.796723049161, 13552.728945421037, 13604.0, 9532.428054316693, 10101.595936162545, 11460.885391146065, 12905.096643234978, 13195.670108247275, 9332.113449222314, 9427.19868811145, 9486.146246837818, 9501.477418741966, 9511.952440237823, 3167.224030112614, 3202.7758056936023, 3247.447933851251, 3292.341531693647, 3331.800091994488, 44322.55677443217, 44483.77758111221, 44673.88315292111, 44698.329525057154, 46132.30801537979, 7167.354938055496, 7323.560586364835, 7353.117625884821, 7363.77908662741, 7444.330010299099, 11274.54901803935, 11339.716507087223, 11358.94320528392, 11380.544778208945, 11395.772084558428, 6157.753689852445, 6200.193974783339, 6286.748530058747, 6339.334369891188, 6423.903641445382, 4178.498580170399, 4228.090960443519, 4249.38383934334, 4253.510846252659, 4280.293751530962, 2833.744962953344, 2867.655881294258, 2875.180573536532, 2877.2950627096498, 2877.309445733009, 447.17273044867386, 452.2289496408681, 453.94098767160716, 457.1656726474198, 458.64913341293936, 652.6671397587264, 671.9966400167967, 685.0033201691526, 689.2556039477453, 689.5586824432268, 8622.439541429787, 8826.42628229163, 8987.724108417946, 9179.77050573741, 9212.555093379875, 523.3249108649875, 614.8410246685031, 661.8318667551775, 676.6549059979347, 699.7166147710185, 3858.8070596470066, 4032.1734044520804, 4045.4943132108488, 4087.693422993287, 4160.313548264502, 56803.0, 57038.0, 57242.7137864308, 57828.0, 57901.42098579044, 47677.76161119172, 48081.5191848077, 49325.26012109821, 50180.498195018314, 50217.0, 45873.54126458826, 46125.30812037822, 46602.76698616553, 46939.0, 47469.5253047472, 8658.264047556027, 8788.42875213109, 8945.910540894507, 9097.454152750855, 9111.088891110836, 31746.365072698878, 33080.33839323248, 33127.66872331342, 33803.0, 35013.0, 44710.0, 44965.32552011657, 45524.0, 45882.54117458916, 45994.77002614966, 7427.591482468516, 7466.141393739789, 7664.8850267244925, 7684.46208765381, 7715.57564333967, 11727.648170554898, 11820.940895295469, 11858.169928105295, 11879.940600296943, 11983.551208548792, 10573.735656608646, 10601.893981060399, 11190.888091118984, 11387.829182562435, 11539.88460115388, 11208.49561769706, 11356.318620882774, 11574.826377604511, 11645.708857278636, 11737.88262117402, 8233.423660343718, 10115.696529104138, 10337.638182663572, 10458.581656733646, 10669.946650266698, 9484.95257523708, 9726.659566915125, 9889.109980101537, 10167.918824268721, 10168.491575421347, 9421.481818500048, 9631.325807193429, 9669.516524173623, 9701.951490242503, 9856.260780441353]}, "summary": {"lowerIsBetter": false, "suite": 6639.312501584975, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7453.466751642477, "unit": "ms", "value": 7453.466751642477}, "dojo.html": {"lowerIsBetter": false, "filtered": 5319.0234595993925, "unit": "ms", "value": 5319.0234595993925}, "mootools.html": {"lowerIsBetter": false, "filtered": 4183.428918096896, "unit": "ms", "value": 4183.428918096896}, "ext.html": {"lowerIsBetter": false, "filtered": 18734.71137637413, "unit": "ms", "value": 18734.71137637413}, "prototype.html": {"lowerIsBetter": false, "filtered": 4640.578681555915, "unit": "ms", "value": 4640.578681555915}, "yui.html": {"lowerIsBetter": false, "filtered": 5939.580445242198, "unit": "ms", "value": 5939.580445242198}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-042"}, "testrun": {"date": 1447336398, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112043002", "branch": "Firefox", "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 160.0, 161.0, 160.0, 160.0, 162.0, 158.0, 161.0, 159.0, 162.0], "ai-astar": [109.0, 109.0, 105.0, 109.0, 109.0, 111.0, 98.0, 109.0, 112.0, 110.0], "imaging-gaussian-blur": [110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "audio-beat-detection": [147.0, 123.0, 147.0, 162.0, 124.0, 149.0, 146.0, 124.0, 157.0, 123.0], "json-stringify-tinderbox": [65.0, 66.0, 69.0, 66.0, 65.0, 66.0, 67.0, 67.0, 66.0, 66.0], "stanford-crypto-pbkdf2": [137.0, 147.0, 148.0, 152.0, 149.0, 139.0, 155.0, 148.0, 147.0, 138.0], "json-parse-financial": [57.0, 60.0, 58.0, 58.0, 58.0, 58.0, 58.0, 66.0, 56.0, 56.0], "stanford-crypto-sha256-iterative": [66.0, 66.0, 67.0, 65.0, 70.0, 68.0, 66.0, 73.0, 65.0, 65.0], "audio-fft": [72.0, 71.0, 83.0, 91.0, 72.0, 71.0, 70.0, 101.0, 90.0, 77.0], "imaging-darkroom": [145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "stanford-crypto-ccm": [119.0, 131.0, 123.0, 114.0, 121.0, 124.0, 118.0, 132.0, 118.0, 117.0], "audio-oscillator": [89.0, 90.0, 145.0, 90.0, 90.0, 90.0, 131.0, 89.0, 89.0, 133.0], "stanford-crypto-aes": [84.0, 86.0, 87.0, 85.0, 85.0, 85.0, 93.0, 92.0, 86.0, 85.0], "imaging-desaturate": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1489.5, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.8, "unit": "ms", "value": 79.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.0, "unit": "ms", "value": 146.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 140.2, "unit": "ms", "value": 140.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.7, "unit": "ms", "value": 121.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.4, "unit": "ms", "value": 145.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.5, "unit": "ms", "value": 58.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.6, "unit": "ms", "value": 103.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.1, "unit": "ms", "value": 108.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.4, "unit": "ms", "value": 160.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.1, "unit": "ms", "value": 67.1}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.3, "unit": "ms", "value": 66.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.6, "unit": "ms", "value": 109.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.8, "unit": "ms", "value": 86.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.0, "unit": "ms", "value": 96.0}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-042"}, "testrun": {"date": 1447336398, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112043002", "branch": "Firefox", "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2"}}, {"talos_counters": {}, "results": {"DeltaBlue": [195.00780031201248], "Encrypt": [289.1844997108155], "NavierStokes": [4822.115384615385], "Decrypt": [5050.50505050505], "Splay": [600.9615384615385], "Richards": [170.09695526450076], "RegExp": [25897.4358974359], "Earley": [805.1529790660226], "Boyer": [12023.809523809523], "RayTrace": [2032.520325203252]}, "summary": {"lowerIsBetter": false, "suite": 19674.278293462994, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 339.05310400000013, "unit": "score", "value": 339.05310400000013}, "Encrypt": {"lowerIsBetter": false, "filtered": 920.4538979999996, "unit": "score", "value": 920.4538979999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.70383799999996, "unit": "score", "value": 52.70383799999996}, "Splay": {"lowerIsBetter": false, "filtered": 135.60102399999994, "unit": "score", "value": 135.60102399999994}, "RegExp": {"lowerIsBetter": false, "filtered": 35.17664851485149, "unit": "score", "value": 35.17664851485149}, "Richards": {"lowerIsBetter": false, "filtered": 207.54045799999997, "unit": "score", "value": 207.54045799999997}, "Earley": {"lowerIsBetter": false, "filtered": 827.747046, "unit": "score", "value": 827.747046}, "Boyer": {"lowerIsBetter": false, "filtered": 55.42860594059401, "unit": "score", "value": 55.42860594059401}, "RayTrace": {"lowerIsBetter": false, "filtered": 364.0745880000001, "unit": "score", "value": 364.0745880000001}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-042"}, "testrun": {"date": 1447336398, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112043002", "branch": "Firefox", "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2"}}] 06:13:34 INFO - RETURN: dromaeo_css: 6639.31 06:13:34 INFO - RETURN: kraken: 1489.50 06:13:34 INFO - RETURN: v8_7: 19674.28 06:13:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19674.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1489.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6639.31"}}} 06:13:34 INFO - Return code: 0 06:13:34 INFO - # TBPL SUCCESS # 06:13:34 INFO - Running post-action listener: _resource_record_post_action 06:13:34 INFO - Running post-run listener: _resource_record_post_run 06:13:35 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518770688; Read time: 436; Write time: 990836 06:13:35 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 77983744; Read time: 0; Write time: 163164 06:13:35 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 388489216; Read time: 436; Write time: 692136 06:13:35 INFO - Running post-run listener: _upload_blobber_files 06:13:35 INFO - Blob upload gear active. 06:13:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:13:35 INFO - Copying logs to upload dir... 06:13:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.766593 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-12 06:13:35.898942) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 06:13:35.903167) ========= 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=c402a24d74c70935940d60dd000001de-1447336145.299031-72231419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010187 build_url: 'https://queue.taskcluster.net/v1/task/n4ZIgUj6SEmR-iyiBMSkjA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 06:13:35.955065) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 06:13:35.955382) ========= 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=c402a24d74c70935940d60dd000001de-1447336145.299031-72231419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 06:13:36.004917) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 06:13:36.005221) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 06:13:36.005515) ========= ========= Total master_lag: 0.22 =========