builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1447760808.88 results: success (0) buildid: 20151117013036 builduid: 73b1a5f5ce0d4c87aff898b693ece5db revision: e61e64f29a004f9a3042810a093b24dabbf56731 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:48.883421) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:48.883928) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:48.884278) ========= 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=a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009050 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:48.916903) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:48.917233) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:48.940501) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:48.940866) ========= 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=a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:48.990883) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:48.991224) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:48.991620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:48.991940) ========= 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=a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 03:46:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 208M=0s 2015-11-17 03:46:49 (208 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115819 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:49.120248) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:49.120605) ========= 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=a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018247 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:49.170903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 03:46:49.171285) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e61e64f29a004f9a3042810a093b24dabbf56731 --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 e61e64f29a004f9a3042810a093b24dabbf56731 --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=a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 03:46:49,545 truncating revision to first 12 chars 2015-11-17 03:46:49,545 Setting DEBUG logging. 2015-11-17 03:46:49,546 attempt 1/10 2015-11-17 03:46:49,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e61e64f29a00?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 03:46:50,321 unpacking tar archive at: mozilla-central-e61e64f29a00/testing/mozharness/ program finished with exit code 0 elapsedTime=1.066051 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 03:46:50.250787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:50.251151) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:50.260995) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:50.261328) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:50.261806) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-17 03:46:50.262214) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:46:50 INFO - MultiFileLogger online at 20151117 03:46:50 in /builds/slave/test-pgo 03:46:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:46:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:46:50 INFO - {'append_to_log': False, 03:46:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:46:50 INFO - 'blob_upload_branch': 'Firefox', 03:46:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:46:50 INFO - 'branch': 'Firefox', 03:46:50 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:50 INFO - 'config_files': ('talos/linux_config.py',), 03:46:50 INFO - 'default_actions': ('clobber', 03:46:50 INFO - 'read-buildbot-config', 03:46:50 INFO - 'download-and-extract', 03:46:50 INFO - 'populate-webroot', 03:46:50 INFO - 'create-virtualenv', 03:46:50 INFO - 'install', 03:46:50 INFO - 'run-tests'), 03:46:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:46:50 INFO - 'download_minidump_stackwalk': True, 03:46:50 INFO - 'download_symbols': 'ondemand', 03:46:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:46:50 INFO - 'tooltool.py': '/tools/tooltool.py', 03:46:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:46:50 INFO - '/tools/misc-python/virtualenv.py')}, 03:46:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:46:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:46:50 INFO - 'installer_path': 'installer.exe', 03:46:50 INFO - 'log_level': 'info', 03:46:50 INFO - 'log_name': 'talos', 03:46:50 INFO - 'log_to_console': True, 03:46:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:46:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:46:50 INFO - 'opt_config_files': (), 03:46:50 INFO - 'pip_index': False, 03:46:50 INFO - 'sps_profile': False, 03:46:50 INFO - 'sps_profile_interval': 0, 03:46:50 INFO - 'suite': 'dromaeojs-e10s', 03:46:50 INFO - 'system_bits': '64', 03:46:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:50 INFO - 'title': 'talos-linux64-ix-026', 03:46:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:46:50 INFO - 'use_talos_json': True, 03:46:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:46:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:50 INFO - 'work_dir': 'build'} 03:46:50 INFO - ##### 03:46:50 INFO - ##### Running clobber step. 03:46:50 INFO - ##### 03:46:50 INFO - Running pre-action listener: _resource_record_pre_action 03:46:50 INFO - Running main action method: clobber 03:46:50 INFO - rmtree: /builds/slave/test-pgo/build 03:46:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:46:51 INFO - Running post-action listener: _resource_record_post_action 03:46:51 INFO - ##### 03:46:51 INFO - ##### Running read-buildbot-config step. 03:46:51 INFO - ##### 03:46:51 INFO - Running pre-action listener: _resource_record_pre_action 03:46:51 INFO - Running main action method: read_buildbot_config 03:46:51 INFO - Using buildbot properties: 03:46:51 INFO - { 03:46:51 INFO - "properties": { 03:46:51 INFO - "buildnumber": 29, 03:46:51 INFO - "product": "firefox", 03:46:51 INFO - "script_repo_revision": "production", 03:46:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:46:51 INFO - "repository": "", 03:46:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:46:51 INFO - "buildid": "20151117013036", 03:46:51 INFO - "slavename": "talos-linux64-ix-026", 03:46:51 INFO - "pgo_build": "True", 03:46:51 INFO - "basedir": "/builds/slave/test-pgo", 03:46:51 INFO - "project": "", 03:46:51 INFO - "platform": "ubuntu64_hw", 03:46:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:46:51 INFO - "slavebuilddir": "test", 03:46:51 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 03:46:51 INFO - "branch": "mozilla-central", 03:46:51 INFO - "repo_path": "mozilla-central", 03:46:51 INFO - "stage_platform": "linux64-pgo", 03:46:51 INFO - "builduid": "73b1a5f5ce0d4c87aff898b693ece5db", 03:46:51 INFO - "revision": "e61e64f29a004f9a3042810a093b24dabbf56731" 03:46:51 INFO - }, 03:46:51 INFO - "sourcestamp": { 03:46:51 INFO - "repository": "", 03:46:51 INFO - "hasPatch": false, 03:46:51 INFO - "project": "", 03:46:51 INFO - "branch": "mozilla-central-linux64-pgo-talos", 03:46:51 INFO - "changes": [ 03:46:51 INFO - { 03:46:51 INFO - "category": null, 03:46:51 INFO - "files": [ 03:46:51 INFO - { 03:46:51 INFO - "url": null, 03:46:51 INFO - "name": "https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:46:51 INFO - } 03:46:51 INFO - ], 03:46:51 INFO - "repository": "", 03:46:51 INFO - "rev": "e61e64f29a004f9a3042810a093b24dabbf56731", 03:46:51 INFO - "who": "sendchange", 03:46:51 INFO - "when": 1447760719, 03:46:51 INFO - "number": 6671296, 03:46:51 INFO - "comments": "", 03:46:51 INFO - "project": "", 03:46:51 INFO - "at": "Tue 17 Nov 2015 03:45:19", 03:46:51 INFO - "branch": "mozilla-central-linux64-pgo-talos", 03:46:51 INFO - "revlink": "", 03:46:51 INFO - "properties": [ 03:46:51 INFO - [ 03:46:51 INFO - "buildid", 03:46:51 INFO - "20151117013036", 03:46:51 INFO - "Change" 03:46:51 INFO - ], 03:46:51 INFO - [ 03:46:51 INFO - "builduid", 03:46:51 INFO - "73b1a5f5ce0d4c87aff898b693ece5db", 03:46:51 INFO - "Change" 03:46:51 INFO - ], 03:46:51 INFO - [ 03:46:51 INFO - "pgo_build", 03:46:51 INFO - "True", 03:46:51 INFO - "Change" 03:46:51 INFO - ] 03:46:51 INFO - ], 03:46:51 INFO - "revision": "e61e64f29a004f9a3042810a093b24dabbf56731" 03:46:51 INFO - } 03:46:51 INFO - ], 03:46:51 INFO - "revision": "e61e64f29a004f9a3042810a093b24dabbf56731" 03:46:51 INFO - } 03:46:51 INFO - } 03:46:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:46:51 INFO - Running post-action listener: _resource_record_post_action 03:46:51 INFO - ##### 03:46:51 INFO - ##### Running download-and-extract step. 03:46:51 INFO - ##### 03:46:51 INFO - Running pre-action listener: _resource_record_pre_action 03:46:51 INFO - Running main action method: download_and_extract 03:46:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:46: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')]} 03:46:51 INFO - https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:46:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/test_packages.json 03:46:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/test_packages.json 03:46:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:46:52 INFO - Downloaded 1302 bytes. 03:46:52 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:46:52 INFO - Using the following test package requirements: 03:46:52 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:46:52 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:46:52 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:52 INFO - u'jsshell-linux-x86_64.zip'], 03:46:52 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:46:52 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:46:52 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:46:52 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:46:52 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:46:52 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:46:52 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:46:52 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:46:52 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')]} 03:46:52 INFO - https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/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 03:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/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 03:46:55 INFO - Downloaded 22461931 bytes. 03:46:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:46:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:46:56 INFO - Return code: 0 03:46:56 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 03:46: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')]} 03:46:56 INFO - https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/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 03:46:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/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 03:47:01 INFO - Downloaded 22461931 bytes. 03:47:01 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 03:47:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:47:01 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 03:47:03 INFO - Return code: 0 03:47: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')]} 03:47:03 INFO - https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:47:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/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 03:47:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/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 03:47:04 INFO - Downloaded 11131693 bytes. 03:47:04 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 03:47:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:04 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 03:47:04 INFO - Return code: 0 03:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:04 INFO - https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:47:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:47:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:47:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/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 03:47:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/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 03:47:06 INFO - Downloaded 57178026 bytes. 03:47:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:47:06 INFO - mkdir: /builds/slave/test-pgo/properties 03:47:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:47:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:47:06 INFO - Contents: 03:47:06 INFO - build_url:https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:47:06 INFO - Running post-action listener: _resource_record_post_action 03:47:06 INFO - Running post-action listener: set_extra_try_arguments 03:47:06 INFO - ##### 03:47:06 INFO - ##### Running populate-webroot step. 03:47:06 INFO - ##### 03:47:06 INFO - Running pre-action listener: _resource_record_pre_action 03:47:06 INFO - Running main action method: populate_webroot 03:47:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:47:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:47:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:47:06 INFO - '../fennec_ids.txt'], 03:47:06 INFO - 'tests': ['tcheck2']}, 03:47:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:47:06 INFO - '--tppagecycles', 03:47:06 INFO - '7'], 03:47:06 INFO - 'tests': ['tsvgm']}}, 03:47:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:47:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:47:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:47:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:47:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:47:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:47:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:06 INFO - 'talos_options': ['--e10s'], 03:47:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:06 INFO - 'tests': ['damp', 'tps']}, 03:47:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:06 INFO - 'talos_options': ['--e10s'], 03:47:06 INFO - 'tests': ['damp', 'tps']}, 03:47:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:47:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:47:06 INFO - 'other': {'tests': ['a11yr', 03:47:06 INFO - 'ts_paint', 03:47:06 INFO - 'tpaint', 03:47:06 INFO - 'sessionrestore', 03:47:06 INFO - 'sessionrestore_no_auto_restore']}, 03:47:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:47:06 INFO - 'tests': ['a11yr', 03:47:06 INFO - 'ts_paint', 03:47:06 INFO - 'tpaint', 03:47:06 INFO - 'sessionrestore', 03:47:06 INFO - 'sessionrestore_no_auto_restore']}, 03:47:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:47:06 INFO - 'tests': ['a11yr', 03:47:06 INFO - 'ts_paint', 03:47:06 INFO - 'tpaint', 03:47:06 INFO - 'sessionrestore', 03:47:06 INFO - 'sessionrestore_no_auto_restore']}, 03:47:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:47:06 INFO - 'tests': ['a11yr', 03:47:06 INFO - 'ts_paint', 03:47:06 INFO - 'tpaint', 03:47:06 INFO - 'sessionrestore', 03:47:06 INFO - 'sessionrestore_no_auto_restore']}, 03:47:06 INFO - 'other_l64': {'tests': ['a11yr', 03:47:06 INFO - 'ts_paint', 03:47:06 INFO - 'tpaint', 03:47:06 INFO - 'sessionrestore', 03:47:06 INFO - 'sessionrestore_no_auto_restore']}, 03:47:06 INFO - 'other_nol64': {'tests': ['a11yr', 03:47:06 INFO - 'ts_paint', 03:47:06 INFO - 'tpaint', 03:47:06 INFO - 'sessionrestore', 03:47:06 INFO - 'sessionrestore_no_auto_restore']}, 03:47:06 INFO - 'svgr': {'tests': ['tsvgx', 03:47:06 INFO - 'tsvgr_opacity', 03:47:06 INFO - 'tart', 03:47:06 INFO - 'tscrollx', 03:47:06 INFO - 'cart']}, 03:47:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:47:06 INFO - 'tests': ['tsvgx', 03:47:06 INFO - 'tsvgr_opacity', 03:47:06 INFO - 'tart', 03:47:06 INFO - 'tscrollx', 03:47:06 INFO - 'cart']}, 03:47:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:06 INFO - 'tests': ['tp5o']}, 03:47:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:06 INFO - 'talos_options': ['--e10s'], 03:47:06 INFO - 'tests': ['tp5o']}, 03:47:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:06 INFO - 'talos_options': ['--xperf_path', 03:47:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:06 INFO - 'tests': ['tp5n']}, 03:47:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:06 INFO - 'talos_options': ['--e10s', 03:47:06 INFO - '--xperf_path', 03:47:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:06 INFO - 'tests': ['tp5n']}}, 03:47:06 INFO - 'talos.zip': {'path': '', 03:47:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:47:06 INFO - Running post-action listener: _resource_record_post_action 03:47:06 INFO - ##### 03:47:06 INFO - ##### Running create-virtualenv step. 03:47:06 INFO - ##### 03:47:06 INFO - Running pre-action listener: _resource_record_pre_action 03:47:06 INFO - Running main action method: create_virtualenv 03:47:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:47:06 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 03:47:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:47:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:47:06 INFO - Using real prefix '/usr' 03:47:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:47:06 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:08 INFO - Installing pip.................done. 03:47:08 INFO - Return code: 0 03:47:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:47:08 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')]} 03:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:08 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')]} 03:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:08 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 0x7f3a1a8f9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a90>, '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 0x10f2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f32e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', '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 03:47:08 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 03:47:08 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 03:47:08 INFO - Using env: {'DISPLAY': ':0', 03:47:08 INFO - 'HOME': '/home/cltbld', 03:47:08 INFO - 'LANG': 'en_US.UTF-8', 03:47:08 INFO - 'LANGUAGE': 'en_US:en', 03:47:08 INFO - 'LOGNAME': 'cltbld', 03:47:08 INFO - 'MAIL': '/var/mail/cltbld', 03:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:08 INFO - 'MOZ_NO_REMOTE': '1', 03:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:08 INFO - 'NO_EM_RESTART': '1', 03:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:08 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:08 INFO - 'SHELL': '/bin/bash', 03:47:08 INFO - 'SHLVL': '1', 03:47:08 INFO - 'TERM': 'linux', 03:47:08 INFO - 'TMOUT': '86400', 03:47:08 INFO - 'USER': 'cltbld', 03:47:08 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', 03:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:08 INFO - '_': '/tools/buildbot/bin/python'} 03:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:09 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 03:47:09 INFO - Cleaning up... 03:47:09 INFO - Return code: 0 03:47:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:47:09 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')]} 03:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:09 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')]} 03:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:09 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 0x7f3a1a8f9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a90>, '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 0x10f2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f32e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', '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 03:47:09 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 03:47:09 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 03:47:09 INFO - Using env: {'DISPLAY': ':0', 03:47:09 INFO - 'HOME': '/home/cltbld', 03:47:09 INFO - 'LANG': 'en_US.UTF-8', 03:47:09 INFO - 'LANGUAGE': 'en_US:en', 03:47:09 INFO - 'LOGNAME': 'cltbld', 03:47:09 INFO - 'MAIL': '/var/mail/cltbld', 03:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:09 INFO - 'MOZ_NO_REMOTE': '1', 03:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:09 INFO - 'NO_EM_RESTART': '1', 03:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:09 INFO - 'SHELL': '/bin/bash', 03:47:09 INFO - 'SHLVL': '1', 03:47:09 INFO - 'TERM': 'linux', 03:47:09 INFO - 'TMOUT': '86400', 03:47:09 INFO - 'USER': 'cltbld', 03:47:09 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', 03:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:09 INFO - '_': '/tools/buildbot/bin/python'} 03:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:09 INFO - Downloading/unpacking psutil>=0.7.1 03:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:10 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:47:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:47:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:11 INFO - Installing collected packages: psutil 03:47:11 INFO - Running setup.py install for psutil 03:47:11 INFO - building 'psutil._psutil_linux' extension 03:47:11 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 03:47:11 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 03:47:11 INFO - building 'psutil._psutil_posix' extension 03:47:11 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 03:47:11 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 03:47:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:11 INFO - Successfully installed psutil 03:47:11 INFO - Cleaning up... 03:47:11 INFO - Return code: 0 03:47:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f3a1a8f9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a90>, '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 0x10f2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f32e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', '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 03:47:11 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 03:47:11 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 03:47:11 INFO - Using env: {'DISPLAY': ':0', 03:47:11 INFO - 'HOME': '/home/cltbld', 03:47:11 INFO - 'LANG': 'en_US.UTF-8', 03:47:11 INFO - 'LANGUAGE': 'en_US:en', 03:47:11 INFO - 'LOGNAME': 'cltbld', 03:47:11 INFO - 'MAIL': '/var/mail/cltbld', 03:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:11 INFO - 'MOZ_NO_REMOTE': '1', 03:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:11 INFO - 'NO_EM_RESTART': '1', 03:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:11 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:11 INFO - 'SHELL': '/bin/bash', 03:47:11 INFO - 'SHLVL': '1', 03:47:11 INFO - 'TERM': 'linux', 03:47:11 INFO - 'TMOUT': '86400', 03:47:11 INFO - 'USER': 'cltbld', 03:47:11 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', 03:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:11 INFO - '_': '/tools/buildbot/bin/python'} 03:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:47:11 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 03:47:11 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 03:47:11 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 03:47:11 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 03:47:11 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 03:47:11 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 03:47:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:47:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:47:13 INFO - Installing collected packages: mozsystemmonitor 03:47:13 INFO - Running setup.py install for mozsystemmonitor 03:47:13 INFO - Successfully installed mozsystemmonitor 03:47:13 INFO - Cleaning up... 03:47:13 INFO - Return code: 0 03:47:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f3a1a8f9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a90>, '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 0x10f2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f32e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', '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 03:47:13 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 03:47:13 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 03:47:13 INFO - Using env: {'DISPLAY': ':0', 03:47:13 INFO - 'HOME': '/home/cltbld', 03:47:13 INFO - 'LANG': 'en_US.UTF-8', 03:47:13 INFO - 'LANGUAGE': 'en_US:en', 03:47:13 INFO - 'LOGNAME': 'cltbld', 03:47:13 INFO - 'MAIL': '/var/mail/cltbld', 03:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:13 INFO - 'MOZ_NO_REMOTE': '1', 03:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:13 INFO - 'NO_EM_RESTART': '1', 03:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:13 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:13 INFO - 'SHELL': '/bin/bash', 03:47:13 INFO - 'SHLVL': '1', 03:47:13 INFO - 'TERM': 'linux', 03:47:13 INFO - 'TMOUT': '86400', 03:47:13 INFO - 'USER': 'cltbld', 03:47:13 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', 03:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:13 INFO - '_': '/tools/buildbot/bin/python'} 03:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:13 INFO - Downloading/unpacking blobuploader==1.2.4 03:47:13 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 03:47:13 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 03:47:13 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 03:47:13 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 03:47:13 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 03:47:13 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 03:47:15 INFO - Downloading blobuploader-1.2.4.tar.gz 03:47:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:47:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:47:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:47:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:47:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:47:16 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 03:47:16 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 03:47:16 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 03:47:16 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 03:47:16 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 03:47:16 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 03:47:16 INFO - Downloading docopt-0.6.1.tar.gz 03:47:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:47:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:47:16 INFO - Installing collected packages: blobuploader, requests, docopt 03:47:16 INFO - Running setup.py install for blobuploader 03:47:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:47:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:47:16 INFO - Running setup.py install for requests 03:47:16 INFO - Running setup.py install for docopt 03:47:16 INFO - Successfully installed blobuploader requests docopt 03:47:16 INFO - Cleaning up... 03:47:16 INFO - Return code: 0 03:47:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:16 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')]} 03:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:16 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')]} 03:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:16 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 0x7f3a1a8f9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a90>, '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 0x10f2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f32e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', '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 03:47:16 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 03:47:16 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 03:47:16 INFO - Using env: {'DISPLAY': ':0', 03:47:16 INFO - 'HOME': '/home/cltbld', 03:47:16 INFO - 'LANG': 'en_US.UTF-8', 03:47:16 INFO - 'LANGUAGE': 'en_US:en', 03:47:16 INFO - 'LOGNAME': 'cltbld', 03:47:16 INFO - 'MAIL': '/var/mail/cltbld', 03:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:16 INFO - 'MOZ_NO_REMOTE': '1', 03:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:16 INFO - 'NO_EM_RESTART': '1', 03:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:16 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:16 INFO - 'SHELL': '/bin/bash', 03:47:16 INFO - 'SHLVL': '1', 03:47:16 INFO - 'TERM': 'linux', 03:47:16 INFO - 'TMOUT': '86400', 03:47:16 INFO - 'USER': 'cltbld', 03:47:16 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', 03:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:16 INFO - '_': '/tools/buildbot/bin/python'} 03:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:17 INFO - Running setup.py (path:/tmp/pip-ujwgw7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:17 INFO - Running setup.py (path:/tmp/pip-n8fY0q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:17 INFO - Running setup.py (path:/tmp/pip-zcLMyj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:17 INFO - Running setup.py (path:/tmp/pip-7sa3_g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:17 INFO - Running setup.py (path:/tmp/pip-rcyRZk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:17 INFO - Running setup.py (path:/tmp/pip-WWwIAc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:17 INFO - Running setup.py (path:/tmp/pip-7ssrqD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:17 INFO - Running setup.py (path:/tmp/pip-p8baaB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:17 INFO - Running setup.py (path:/tmp/pip-pNXf5A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:17 INFO - Running setup.py (path:/tmp/pip-veu_7F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:17 INFO - Running setup.py (path:/tmp/pip-g91jpl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:17 INFO - Running setup.py (path:/tmp/pip-IFRXeO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:17 INFO - Running setup.py (path:/tmp/pip-Xtb6Oe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:18 INFO - Running setup.py (path:/tmp/pip-GmoMor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:18 INFO - Running setup.py (path:/tmp/pip-dGoKvq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:18 INFO - Running setup.py (path:/tmp/pip-mlHMyI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:18 INFO - Running setup.py (path:/tmp/pip-KTuJBp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:47:18 INFO - Running setup.py install for manifestparser 03:47:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:47:18 INFO - Running setup.py install for mozcrash 03:47:18 INFO - Running setup.py install for mozdebug 03:47:18 INFO - Running setup.py install for mozdevice 03:47:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:47:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:47:18 INFO - Running setup.py install for mozfile 03:47:18 INFO - Running setup.py install for mozhttpd 03:47:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:47:18 INFO - Running setup.py install for mozinfo 03:47:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:47:19 INFO - Running setup.py install for mozInstall 03:47:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:47:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:47:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:47:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:47:19 INFO - Running setup.py install for mozleak 03:47:19 INFO - Running setup.py install for mozlog 03:47:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:47:19 INFO - Running setup.py install for moznetwork 03:47:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:47:19 INFO - Running setup.py install for mozprocess 03:47:19 INFO - Running setup.py install for mozprofile 03:47:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:47:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:47:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:47:19 INFO - Running setup.py install for mozrunner 03:47:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:47:19 INFO - Running setup.py install for mozscreenshot 03:47:19 INFO - Running setup.py install for moztest 03:47:19 INFO - Running setup.py install for mozversion 03:47:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:47:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:47:20 INFO - Cleaning up... 03:47:20 INFO - Return code: 0 03:47:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:20 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 0x7f3a1a8f9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a90>, '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 0x10f2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f32e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', '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 03:47:20 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 03:47:20 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 03:47:20 INFO - Using env: {'DISPLAY': ':0', 03:47:20 INFO - 'HOME': '/home/cltbld', 03:47:20 INFO - 'LANG': 'en_US.UTF-8', 03:47:20 INFO - 'LANGUAGE': 'en_US:en', 03:47:20 INFO - 'LOGNAME': 'cltbld', 03:47:20 INFO - 'MAIL': '/var/mail/cltbld', 03:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:20 INFO - 'MOZ_NO_REMOTE': '1', 03:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:20 INFO - 'NO_EM_RESTART': '1', 03:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:20 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:20 INFO - 'SHELL': '/bin/bash', 03:47:20 INFO - 'SHLVL': '1', 03:47:20 INFO - 'TERM': 'linux', 03:47:20 INFO - 'TMOUT': '86400', 03:47:20 INFO - 'USER': 'cltbld', 03:47:20 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', 03:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:20 INFO - '_': '/tools/buildbot/bin/python'} 03:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:20 INFO - Running setup.py (path:/tmp/pip-2bqFYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:20 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)) 03:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:20 INFO - Running setup.py (path:/tmp/pip-WKw0a6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:20 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)) 03:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:20 INFO - Running setup.py (path:/tmp/pip-BT8Pkl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:20 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)) 03:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:20 INFO - Running setup.py (path:/tmp/pip-TNKtIv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:20 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)) 03:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:20 INFO - Running setup.py (path:/tmp/pip-tdpoi4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:20 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)) 03:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:20 INFO - Running setup.py (path:/tmp/pip-PTHk0S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:20 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)) 03:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:20 INFO - Running setup.py (path:/tmp/pip-y_IKY6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:20 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)) 03:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:20 INFO - Running setup.py (path:/tmp/pip-OnNg1h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:20 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)) 03:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:20 INFO - Running setup.py (path:/tmp/pip-YFi_DA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:20 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)) 03:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:20 INFO - Running setup.py (path:/tmp/pip-pSc_sW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:21 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)) 03:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:21 INFO - Running setup.py (path:/tmp/pip-YlCgjQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:21 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)) 03:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:21 INFO - Running setup.py (path:/tmp/pip-3UGUxi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:21 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)) 03:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:21 INFO - Running setup.py (path:/tmp/pip-nX5Dqh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:21 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)) 03:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:21 INFO - Running setup.py (path:/tmp/pip-F7ddZi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:21 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)) 03:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:21 INFO - Running setup.py (path:/tmp/pip-EFhQjm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:21 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)) 03:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:21 INFO - Running setup.py (path:/tmp/pip-_skGn6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:21 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)) 03:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:21 INFO - Running setup.py (path:/tmp/pip-TGmB6g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:21 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)) 03:47:21 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)) 03:47:21 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)) 03:47:21 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)) 03:47:21 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)) 03:47:21 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)) 03:47:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:21 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 03:47:21 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 03:47:21 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 03:47:21 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 03:47:21 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 03:47:21 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 03:47:23 INFO - Downloading blessings-1.5.1.tar.gz 03:47:23 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 03:47:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:47:23 INFO - Installing collected packages: blessings 03:47:23 INFO - Running setup.py install for blessings 03:47:23 INFO - Successfully installed blessings 03:47:23 INFO - Cleaning up... 03:47:23 INFO - Return code: 0 03:47:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:47:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:47:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:47:23 INFO - Reading from file tmpfile_stdout 03:47:23 INFO - Current package versions: 03:47:23 INFO - argparse == 1.2.1 03:47:23 INFO - blessings == 1.5.1 03:47:23 INFO - blobuploader == 1.2.4 03:47:23 INFO - docopt == 0.6.1 03:47:23 INFO - manifestparser == 1.1 03:47:23 INFO - mozInstall == 1.12 03:47:23 INFO - mozcrash == 0.16 03:47:23 INFO - mozdebug == 0.1 03:47:23 INFO - mozdevice == 0.47 03:47:23 INFO - mozfile == 1.2 03:47:23 INFO - mozhttpd == 0.7 03:47:23 INFO - mozinfo == 0.9 03:47:23 INFO - mozleak == 0.1 03:47:23 INFO - mozlog == 3.0 03:47:23 INFO - moznetwork == 0.27 03:47:23 INFO - mozprocess == 0.22 03:47:23 INFO - mozprofile == 0.27 03:47:23 INFO - mozrunner == 6.11 03:47:23 INFO - mozscreenshot == 0.1 03:47:23 INFO - mozsystemmonitor == 0.0 03:47:23 INFO - moztest == 0.7 03:47:23 INFO - mozversion == 1.4 03:47:23 INFO - psutil == 3.1.1 03:47:23 INFO - requests == 1.2.3 03:47:23 INFO - wsgiref == 0.1.2 03:47:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:23 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')]} 03:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:23 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')]} 03:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:23 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 0x7f3a1a8f9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a90>, '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 0x10f2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f32e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', '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 03:47:23 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 03:47:23 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 03:47:23 INFO - Using env: {'DISPLAY': ':0', 03:47:23 INFO - 'HOME': '/home/cltbld', 03:47:23 INFO - 'LANG': 'en_US.UTF-8', 03:47:23 INFO - 'LANGUAGE': 'en_US:en', 03:47:23 INFO - 'LOGNAME': 'cltbld', 03:47:23 INFO - 'MAIL': '/var/mail/cltbld', 03:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:23 INFO - 'MOZ_NO_REMOTE': '1', 03:47:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:23 INFO - 'NO_EM_RESTART': '1', 03:47:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:23 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:23 INFO - 'SHELL': '/bin/bash', 03:47:23 INFO - 'SHLVL': '1', 03:47:23 INFO - 'TERM': 'linux', 03:47:23 INFO - 'TMOUT': '86400', 03:47:23 INFO - 'USER': 'cltbld', 03:47:23 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', 03:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:23 INFO - '_': '/tools/buildbot/bin/python'} 03:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:23 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)) 03:47:23 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)) 03:47:23 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)) 03:47:23 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)) 03:47:23 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)) 03:47:23 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)) 03:47:23 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)) 03:47:23 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)) 03:47:23 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)) 03:47:23 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)) 03:47:23 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)) 03:47:23 INFO - Cleaning up... 03:47:23 INFO - Return code: 0 03:47:23 INFO - Running post-action listener: _resource_record_post_action 03:47:23 INFO - Running post-action listener: _start_resource_monitoring 03:47:23 INFO - Starting resource monitoring. 03:47:23 INFO - ##### 03:47:23 INFO - ##### Running install step. 03:47:23 INFO - ##### 03:47:23 INFO - Running pre-action listener: _resource_record_pre_action 03:47:23 INFO - Running main action method: install 03:47:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:47:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:47:24 INFO - Reading from file tmpfile_stdout 03:47:24 INFO - Detecting whether we're running mozinstall >=1.0... 03:47:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:47:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:47:24 INFO - Reading from file tmpfile_stdout 03:47:24 INFO - Output received: 03:47:24 INFO - Usage: mozinstall [options] installer 03:47:24 INFO - Options: 03:47:24 INFO - -h, --help show this help message and exit 03:47:24 INFO - -d DEST, --destination=DEST 03:47:24 INFO - Directory to install application into. [default: 03:47:24 INFO - "/builds/slave/test-pgo"] 03:47:24 INFO - --app=APP Application being installed. [default: firefox] 03:47:24 INFO - mkdir: /builds/slave/test-pgo/build/application 03:47:24 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'] 03:47:24 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 03:47:38 INFO - Reading from file tmpfile_stdout 03:47:38 INFO - Output received: 03:47:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:47:38 INFO - Running post-action listener: _resource_record_post_action 03:47:38 INFO - ##### 03:47:38 INFO - ##### Running run-tests step. 03:47:38 INFO - ##### 03:47:38 INFO - Running pre-action listener: _resource_record_pre_action 03:47:38 INFO - Running main action method: run_tests 03:47:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:47:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:47:38 INFO - Python 2.7.3 03:47:38 INFO - Return code: 0 03:47:38 INFO - grabbing minidump binary from tooltool 03:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:38 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 0x10a0a90>, '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 0x10f2f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f32e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:47:38 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 03:47:38 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 03:47:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:47:38 INFO - Return code: 0 03:47:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:47:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:47:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:47:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:47:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:47:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:47:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost 03:47:38 INFO - Using env: {'DISPLAY': ':0', 03:47:38 INFO - 'HOME': '/home/cltbld', 03:47:38 INFO - 'LANG': 'en_US.UTF-8', 03:47:38 INFO - 'LANGUAGE': 'en_US:en', 03:47:38 INFO - 'LOGNAME': 'cltbld', 03:47:38 INFO - 'MAIL': '/var/mail/cltbld', 03:47:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:47:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:38 INFO - 'MOZ_NO_REMOTE': '1', 03:47:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:38 INFO - 'NO_EM_RESTART': '1', 03:47:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:38 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:47:38 INFO - 'SHELL': '/bin/bash', 03:47:38 INFO - 'SHLVL': '1', 03:47:38 INFO - 'TERM': 'linux', 03:47:38 INFO - 'TMOUT': '86400', 03:47:38 INFO - 'USER': 'cltbld', 03:47:38 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106', 03:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:38 INFO - '_': '/tools/buildbot/bin/python'} 03:47:38 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] with output_timeout 3600 03:47:38 INFO - mozversion INFO | application_buildid: 20151117013036 03:47:38 INFO - mozversion INFO | application_changeset: e61e64f29a004f9a3042810a093b24dabbf56731 03:47:38 INFO - mozversion INFO | application_display_name: Nightly 03:47:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:47:38 INFO - mozversion INFO | application_name: Firefox 03:47:38 INFO - mozversion INFO | application_remotingname: firefox 03:47:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 03:47:38 INFO - mozversion INFO | application_vendor: Mozilla 03:47:38 INFO - mozversion INFO | application_version: 45.0a1 03:47:38 INFO - mozversion INFO | platform_buildid: 20151117013036 03:47:38 INFO - mozversion INFO | platform_changeset: e61e64f29a004f9a3042810a093b24dabbf56731 03:47:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 03:47:38 INFO - mozversion INFO | platform_version: 45.0a1 03:47:38 INFO - 2015-11-17 03:47:38,779 DEBUG : using testdate: 1447760858 03:47:38 INFO - 2015-11-17 03:47:38,780 DEBUG : actual date: 1447760858 03:47:38 INFO - 2015-11-17 03:47:38,789 INFO : starting webserver on 'localhost:39668' 03:47:38 INFO - 2015-11-17 03:47:38,789 INFO : Starting test suite talos-linux64-ix-026.e 03:47:38 INFO - 2015-11-17 03:47:38,790 INFO : Starting test dromaeo_css 03:47:38 INFO - 2015-11-17 03:47:38,790 DEBUG : operating with platform_type : linux_ 03:47:38 INFO - 2015-11-17 03:47:38,790 INFO : Initialising browser for dromaeo_css test... 03:47:38 INFO - 2015-11-17 03:47:38,807 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQmKiJ6/profile http://localhost:39668/getInfo.html 03:47:43 INFO - 2015-11-17 03:47:43,777 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:47:43 INFO - 2015-11-17 03:47:43,778 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:47:43 INFO - 2015-11-17 03:47:43,778 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:47:43 INFO - 2015-11-17 03:47:43,778 DEBUG : BROWSER_OUTPUT: __metrics 03:47:44 INFO - 2015-11-17 03:47:44,838 INFO : Browser initialized. 03:47:44 INFO - 2015-11-17 03:47:44,839 INFO : Running cycle 1/1 for dromaeo_css test... 03:47:44 INFO - 2015-11-17 03:47:44,839 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQmKiJ6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:47:56 INFO - 2015-11-17 03:47:56,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 141144064 03:47:56 INFO - 2015-11-17 03:47:56,679 DEBUG : BROWSER_OUTPUT: 03:48:46 INFO - 2015-11-17 03:48:46,294 DEBUG : BROWSER_OUTPUT: 1447760926290 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] 03:50:55 INFO - 2015-11-17 03:50:55,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39668/tests/dromaeo/cssquery-ext.html) 03:50:56 INFO - 2015-11-17 03:50:56,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 146210816 03:50:56 INFO - 2015-11-17 03:50:56,161 DEBUG : BROWSER_OUTPUT: 03:53:58 INFO - 2015-11-17 03:53:58,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/dromaeo/cssquery-ext.html (next: http://localhost:39668/tests/dromaeo/cssquery-jquery.html) 03:53:58 INFO - 2015-11-17 03:53:58,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 140406784 03:53:58 INFO - 2015-11-17 03:53:58,731 DEBUG : BROWSER_OUTPUT: 03:57:00 INFO - 2015-11-17 03:57:00,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39668/tests/dromaeo/cssquery-mootools.html) 03:57:01 INFO - 2015-11-17 03:57:01,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 141299712 03:57:01 INFO - 2015-11-17 03:57:01,010 DEBUG : BROWSER_OUTPUT: 04:00:02 INFO - 2015-11-17 04:00:02,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39668/tests/dromaeo/cssquery-prototype.html) 04:00:03 INFO - 2015-11-17 04:00:03,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 140541952 04:00:03 INFO - 2015-11-17 04:00:03,236 DEBUG : BROWSER_OUTPUT: 04:03:05 INFO - 2015-11-17 04:03:05,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39668/tests/dromaeo/cssquery-yui.html) 04:03:06 INFO - 2015-11-17 04:03:06,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 141369344 04:03:06 INFO - 2015-11-17 04:03:06,168 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2015-11-17 04:06:08,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/dromaeo/cssquery-yui.html (next: http://localhost:39668/tests/dromaeo/cssquery-dojo.html) 04:06:08 INFO - 2015-11-17 04:06:08,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 143978496 04:06:08 INFO - 2015-11-17 04:06:08,773 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2015-11-17 04:06:08,773 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:08 INFO - 2015-11-17 04:06:08,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:08 INFO - 2015-11-17 04:06:08,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:08 INFO - 2015-11-17 04:06:08,773 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:08 INFO - 2015-11-17 04:06:08,773 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3261.315123823997;3302.90091297261;3320.8173550454744;3348.8158151301677;3354.3123659649773;5401.4328495508;5511.834644960652;5548.7225638718055;5568.16477528371;5576.916346254804;5484.725763711808;5515.862103447415;5524.392316845144;5531.2809334786525;5562.193481945115;4977.402711674604;5040.8235711750185;5106.9489305106845;5223.921641175385;5255.448177941318;4894.461609222983;5138.383393992726;5140.5373516383515;5196.870078248036;5234.607404444663;4879.414470263556;4950;4966.6771659842;4966.850994470172;5037.042961837257;5031.798728050873;5048.116579598555;5062.721550314731;5064.4935506449065;5082.059818933472;4921.7785199666105;4974.154393753034;4989.950100499022;4995.625328100407;5046.318746969186;5307.310049693515;5323.334583177103;5357.276767636397;5385.057614917374;5448.591355648342;6080.331163572004;6103.267607887037;6103.786367477117;6106.6336019838955;6112.022076467788;5918.526517878559;5972.492338151263;6023.156758053876;6140.785072522485;6146.231721034871;5645.350784659735;5707.828765136969;5714.285714285715;5718.5711071669375;5754.165645981351;6191.938080619227;6200.937990620036;6203.96898015507;6206.658633775095;6217.626942383471;5771.422857714195;5895.911561326584;5896.557758168155;5967.701614919237;6028.879422411527;6052.455279024821;6091.908621370683;6119.479844213202;6126.356732543019;6126.509879209652;6007.30915944672;6041.72812223451;6048.092786082123;6059.757609695651;6066.181065556093;5854.853628659318;5942.078977758454;5948;6008.489278411296;6051.062085376773;4591.173588754056;4607.6083532900075;4640.628749700016;4651.093036857848;4676.275177347517;3912.139329347539;4021.9542918840725;4030.951952492373;4032.737872038308;4057.1479989202007;5648.689322087324;5735.369109397963;5743.282089738783;5809.215755872903;5868.501177399883;5982.252218472691;5995.400459953969;6006.219191505076;6018.6990650467305;6033.547483938634;5505.779768809202;5672.461116193955;5729.1119876419225;5731.083026715789;5746.655200687972;5171.3277273954145;5198.9740051299505;5200.557952573998;5200.687958722413;5240.633155679142;6228;6251.78118765841;6293.433590976742;6296.275928268308;6320.462760665303;5930.911036334544;5961.582689211714;5974.820755377345;6141.477974372228;6165.784197553064;6155.630662160284;6183.505319574513;6191.504679625709;6206.472449841814;6213.565050446426;5927.199828023162;5932.228810254639;5960.910586341121;5966.8209953699725;5969.343372229138;5871.882562348644;5972.910406343822;5977.133315669291;6010.759569617167;6089.421504957022;5946.07835785454;5954.612950158225;5995;6017.699115044318;6021.307549631673;5957.91063134062;5985.102234664835;5991.730372133352;5995.490383317467;5996.640201587744;5678.68767217807;5726.770929162787;5835.44563266489;5846.503047241032;5860.120981852756;5935.228420305332;6026.548008899263;6034.818955431344;6037.305709843425;6046.183765191819;5583.664980101207;5888.735006924784;5893.116032595145;5907.49786268172;5907.70461476933 04:06:08 INFO - 2015-11-17 04:06:08,773 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.5428148917887;560.4255637971079;562.0697745231641;570.1390899741389;574.8620331120529;39431.60568394319;40383.39424908629;40404.59595404045;40478.39282410759;40612.18775624489;43320;43766;43795.78102109493;43835.561644383546;43840.780796095976;8724.73825785226;8839.77900552488;8849.778755531132;8872.334574906876;8905.732828015138;8647.524386158759;8748.69379571715;8767.386282960195;8769.473831570094;8793.340499462534;8726;8777.780555486132;8818.955905220464;8845.646174153058;8850.690225842096;8771.947366316052;8831.205191532792;8849.159329863653;8864.335174861879;8869.866951995726;8642.22220000203;8706.477611343276;8747.606357713918;8778.122187781235;8801.823963520757;41015.794921025205;41717.58282417167;41780.1643967122;41842.37236441456;41846.79076604628;2766.8201566898088;3089.382123575294;3300.818454984975;3373.7301015918915;3726.8881933541766;30076.69923300761;30274.54588181179;30380.936667216763;30460.8476957616;31154.532682009787;3495.5106285120105;3526;3527.153483164022;3548.449990251515;3650.1604630934767;259683.9999999981;259846;260520;262135;263376;58281.12578311329;58362.70818645965;59144.40855591389;65240.34759652438;67767.66116169388;62438.375616244164;62632.37367626266;62685;62773.372266276754;62789.05816412757;16442.506724798277;16444.506664800076;16631.66736665284;16650.83349166493;16706.58233544171;12456.439460224312;12469.625911222678;12508.624741257778;12560.497580096693;12619.053570982029;20041.098150583257;20316;20370.898145509178;20570.38288851337;20576.176952921716;7959.363250940027;8209.220124088202;8251.381146414044;8286.70996515119;8350.958245208856;916.812053529025;928.8467402878584;966.1111777165025;985.9901400986042;1030.2891005206384;28282.43435131327;28333.291667708472;28545;28814;29106.854465727534;1028.218553899042;1040.9375437473775;1067.2102644043352;1138.93166410014;1146.2606618730872;14138.575842724735;14386.640333991734;14496;15690;15920.283587238602;310922;312846;313920;318662;318905;54328.728356358755;54376.45623543714;54401.45598544043;54523.45476545184;54564.454355455935;1377.0842389810864;1380.1236215003546;1380.2339701465783;1383.3014327764415;1487.0334282716321;28574.42851142924;29353.41293174082;29574.556381654722;29657.70342296636;29968.85015574908;47204.52795472139;47304.52695473001;47709.5229047719;47753;47781.76109119432;319523;320199;320275;320423;321952;31428.37143257168;32906.50640240446;33221;33339.66660333366;33423.16442088967;40557;42673.146537069704;43139.764517660675;43644.127117458105;44888.8377836553;36517.53929842883;37239.813800930824;37242.62757372392;37489.25021499609;38189.618103818604;36977.815110924275;37145.74949259141;37264.25471490609;37452.25095498129;37501.81249093737;35698.28603427865;35731;36110;36218;36238.63761362353;31119.844400777853;31525.738970440925;32496.675033249365;32676.183095421853;33189.83405082959;24781;24840.25479235626;24958.62562061607;25046.874765626057;25299.620505692797 04:06:08 INFO - 2015-11-17 04:06:08,773 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.4649040477664;351.5833737021631;355.03784743345534;355.6088302866845;355.66212098506423;12535.874641253584;12816.615501534969;16462.84760066796;16779.748303775454;17222.13889305536;11560.132990025739;11663.941680291588;11679.299242045483;11723.00354469869;12048.096392770534;4475.709078909877;4585.082983403316;4598.701084429518;4601.677882548223;4602.470715867667;4461.643068554524;4528.569785870337;4571.1771881061395;4580;4595.402597662299;4545.250033744428;4556.749378784166;4562.4753153387455;4755.667103302771;4854.271859221128;4780.569748722614;4796.808127674889;4800;4803.471618122004;4821.734804585764;4118.691098167649;4197.580241975778;4206.72656277341;4211.620954114113;4221.387898754694;13439.328033598282;13881.930590346983;13984.370703318375;13989.300534973312;14014.649633759136;2009.3067891577382;2047.846411519127;2065.1429656692453;2070.3685375960326;2086.050846864673;9498.95250523743;9605.519724013771;9678.370905891095;9992.25058120644;10032.749181270454;1737.3311275159028;1737.8522825559842;1750.8336708012719;1837.6508463391913;1894.7915729269769;60250;61780;62220;62253.37746622521;62572.99999999954;6972.651367431608;7033.613151276729;7036.577805331696;7055.576665400093;7070.823229419306;8226.712065077694;8232.135625759329;8274.834503310021;8281.461704989157;8289.088200297962;5631.436856314336;5672.546196304285;5705.372409035002;5719.656820590778;5731;6005.939940600625;6033;6041.184440100618;6060.484858787053;6104.603200791934;3230.4185246655356;3278.868845246211;3291.391092647868;3299.7195238405006;3303.3228188221356;1137.374444055766;1140.4753813245834;1144.6108323169994;1150.61454412771;1209.0206932384797;467.06819894311064;471.1378177934372;474.810075969608;478.17276112325175;479.7169669894779;11701.356425396685;12518.436670349856;12553;12722.554710585086;12767.042471814651;508.5346907579597;513.3147248423396;529.1850550152722;529.1876968852793;539.7382269599241;6480.675966201766;6502.219733631994;6644.435223006099;6665.633390163587;6742.089817874622;581265;605748;606455;608533;631184;75480;76111;76887.231127688;76972;79805.60097199593;562.0445243086688;563.3183847544435;566.6883214232156;566.8866226754666;567.5629765080947;10797.946010269898;11202.604747490761;11329.263597866442;11361.715957101138;11582;33112.834435827666;33736.66263337433;34021.149471263416;36496.27007459783;36758.63241367552;41854.372184417865;42395.364069538366;42960.57039429565;43284.567154329314;43505.78247108871;6819.556728812611;6838.794836154923;6859.691313890787;6865;6891.931080689129;11946.104042196695;12182.878171218174;12240.387980601112;12437.564685236335;12517.561885334333;9535.38020028696;10700.30448020876;10769.838452423062;10810.621628242974;10946;8857.33569982241;9529.523523823642;9730.854037189589;10005.299629025898;10135.442550659785;10132.44271565071;10169.389836609827;10191.490425478845;10264.64073757415;10313.432761197906;14226.71546569042;15071.924640376728;15248.542543723706;15571.143587102819;15675.921620391826;15552.144632044894;15583.76624350613;15850.365985360917;16038;16348.754768678717 04:06:08 INFO - 2015-11-17 04:06:08,773 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1429.8069760582318;1711.3325802936854;1768.1689605885229;1781.7149256119023;1788.4634609617112;7651.8087047823765;7734.303912647861;7946.44374893757;7974.122846486882;8001.5199088054615;7707.11368192658;7712.498687585303;7734.1105772836;7792.571408572526;7795.181505941865;2123.978760212401;2135.028562004284;2142.464383904024;2150.161437039556;2150.8709477431403;2266.7393249776324;2287.1537531113513;2343.753905839888;2343.789058984691;2348.236823032513;2263.0721404224273;2283.8743869087193;2313.4794671199015;2315.923095760471;2328.4062564046144;2238.9104435822546;2250.5386395788823;2264.728232612081;2266.841321107523;2268.591653502369;2317.8841057947034;2365.6096744037386;2366.5621859955963;2369.5024044950583;2370.6799582056547;7571.886421703679;7663.425243106733;7673.616319184019;7686.846263074764;7689.615519224072;4614;4631.2126938420215;4704.082703872747;4708.952910470885;4714.787834547454;3035.3322269100763;3075.077476756964;3116.7350775184136;3133.686631336871;3136.952945705816;1041.6770801051698;1049.8897615750313;1056.1234175634281;1067.765091679829;1075.4622688655672;10719.19606029551;10786.352818830896;10791.136709063256;10814.621488247953;10847.620333288376;4044.6157615026527;4063.89840253996;4080.81636326366;4109;4171;8685.39202255836;8809.383343165917;8819.603117859711;8845.778855528662;8851.51316677576;4665.836695715634;4671.953280467152;4676.392069031072;4688.226442636995;4696.389469369028;4301.870943871689;4311.935320970188;4329.740215587012;4345.152695224401;4350.760708161019;3429.811360375203;3469.930601387958;3486.163320802989;3495.9126021849656;3505.789652620851;1057.962971296001;1059.4861492176287;1064.7763969566322;1072.4316112460408;1077.353587847301;1083.1172594335592;1098.5056724474018;1152.3604399558158;1280.5966120671958;1383.6402535340683;7256.564606123649;7434.814129646802;7454.4781865268915;7495.138059123162;7502.062242219723;1031.4791030529684;1033.0960409641564;1049.286485190078;1108.539955918285;1135.2053562506278;5862.296524417097;5867.501262392659;5869.530437564985;5929.881402372014;5934.851628709317;9117.77205569866;9221.90778092224;9325.860112098324;9351.158395744416;9460.1485866271;9163.541822908961;9221.585028673726;9239.676611318706;9275.953620231856;9312.161905428544;7023.8761798112055;7073.186583542855;7079.1858936223;7100.751473698396;7139.89290160648;7078.398336141486;7087.22040575526;7107.786766397016;7108.253633368422;7108.289171082851;7993.880091798512;8155.877661835196;8181.590920454072;8246.505209687439;8251.587420628824;8428.831423371375;8459.450135741157;8495.065542790411;8531.317494600542;8600.09698981598;6754.527183097136;7038.225795162631;7043.436525077879;7060.6469676517;7087.787366379017;7595.620218989139;7597;7609.619519024137;7631.1605723371495;7663.080430348394;6720.462363011045;6799.150106236721;6964.547304425196;7065.399441047569;7282.708691652275;6976.127984002;6976.267491913276;7052.153741551047;7070.7525236616475;7119.003339532574;7132;7155.606441645759;7178.784636460915;7198.5320954137815;7209.783706488814;6505.121808555785;6543.149390579194;6545.705443254969;6550.868982620416;6558.8360290993105;6575.4410875076155;6649.235337936199;6654.168228971379;6664.067030615621;6690.899636505359 04:06:08 INFO - 2015-11-17 04:06:08,774 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.63023229099554;334.3346739987426;335.0768632417689;340.56577863224385;341.03147062342947;6259.311475737665;6292.119103325533;6336.936630633692;6368.363163683635;6372.585781924177;6175.197224360838;6292.653904035276;6296.590721603093;6309.842253943653;6326.588771729835;4751.263554149095;4775.068861571995;4789;4813.542713442235;4826.927596086052;4801;4805.231163013918;4815.205491093965;4821.325014497973;4836.564709176174;4700.694454860423;4787.784549695255;4790.993891282835;4790.993891282835;4798.880027999293;4757.928631070519;4767.523247675222;4768.761561921908;4772.045590881838;4781.976090119562;4127.030147915238;4135.937960930589;4140.0270936329935;4154.584541545852;4160.063985603245;5904.232449781543;5971.19388882504;5979.910301345483;5988.251468566429;5997.730102145414;5447.673139611636;5560.833175004756;5568.3596386415675;5584.832455026356;5599.468050535193;6642.867142657168;6680.799576012728;6693.966530167318;6698.497612679069;6725.562838415536;4596.49438561758;4600.125976064571;4601.884952876205;4604.861854144381;4614.584687378152;6835.453163746938;6966.268541803139;7019.8596028079155;7020.1575810902505;7032.12098487689;4664.696794708333;4700.576948074621;4702.811887524529;4708.717476951394;4711.882202944886;4769.117713223065;4781.282807578891;4787.4494433140635;4789.832355867528;4795.904081918342;5535.833924982257;5536.889262214733;5539.224508568804;5545.306836645419;5545.667259964334;6676.399124078759;6695.933040669628;6809.148856392951;6811.761588344384;6812.761553345609;1618.2717777000396;1657.3701993242732;1660.095248089794;1660.9501714948572;1673.6903672820324;1080.8486811846349;1086.8532748079067;1093.688298834844;1102.443266150589;1105.2429086076063;6359.586626869239;6386.10594516768;6421.325760795049;6436.710348034349;6438.45273151778;6826;6827.48793840464;6829.7268109276065;6843;6846.110005699227;6323.9051414228825;6363.745450181941;6409.294977552466;6409.743610255631;6470.9029364559565;3798.7910664913143;3835.0987517933263;3838.9808050960123;3847.249786291646;3849.8652547160714;7283.162436319785;7290.4167666586545;7301.707931682779;7311.232320606367;7312.049433573601;7090.361867431956;7252.3835473984245;7263.455240856957;7269.527480713737;7283.817904552428;7266;7274.127104747358;7280.708771649181;7283.963580182171;7284.745033923788;7007.579545227302;7027.824304392431;7033.859322813618;7036.572382528019;7036.683349249399;6733.797986060426;6920.792376228721;6971.407430368476;6977.79066628002;7012.509124361246;7236.38490728273;7268.0914885639295;7320.341169294789;7325.890111648223;7330.157031941395;4604.5165257648805;4635.605973492291;4649.023705021983;4662.696924699883;4664.3469914211355;6817.352351526597;6869.347411995853;6937.7224911002995;7035.261297563887;7045.189803172496;6805.3875151236625;6838.5213035089055;6848.075509806312;6850.0752398425575;6854.177498700188;6717.966410167918;6797.422219111431;6816.863662726817;6820.147481564804;6835.829104272234;6554.14796076507;6695.0626912231355;6713.6643167842385;6716.29478904708;6721.059051732664;6841.350071743176;6886.035954966409;6890.069840571659;6903.75836845708;6920.30796920304;6623;6647.800565983028;6679.899801503078;6700.966495167493;6708.262091170065 04:06:08 INFO - 2015-11-17 04:06:08,775 DEBUG : BROWSER_OUTPUT: |5;yui.html;687;741.5106030020186;773.7369294439893;780.1574299756264;787.232448362846;13475.258860762655;13680;13752.449902003907;13780.173189608618;13811.240381778998;12271.386430678474;12354.567590134347;14570.271486425663;14668.339924703387;14678.339474723636;804.8470790549806;816.3999460396633;817.7383237364046;819.7991492084448;826.8801023851538;791.9049714034323;791.9524828510279;791.9643616037264;794.0669713087128;819.5205804604284;829.2122483640566;830.862907620245;832.2883934236202;840.4117118017413;858.1675774498726;822.6627082895984;823.7199352220244;823.7569916874536;826.9586520673972;865.7575878753959;602.1449541650866;620.664840985867;633.9936600634027;635.0918186992599;635.3424205946823;13523.526676566273;13617.455301787917;13662.590122296248;13690.041697081208;13700;10104.191664666809;10243.641472548425;10451.895481045169;10902.454877256105;11456.65630031092;10017;10030.548625311878;10128.949355253177;10348.527600047648;10554.155667546578;3261.478163493853;3292.539044533767;3314.254292784128;3335.7331413486863;3400.7449441291756;46334;46561.53438465606;46694.29958550625;46761.76619116917;46865;7862.135165131831;7940.761777146695;7946.960265198637;7970.880436793453;7971.920280797234;12790.488380464678;12794.42425090873;12805.871941280655;12859.099863009687;12866.806997895039;6646.534742567974;6807.421369183576;6827.931720682829;6860.382565569123;7016.684249208798;4354.869353919387;4508.549145085531;4531.048479819209;4554.88612784683;4571.5428457154685;2935.5156399193893;3001.3397052648384;3005.4890668585954;3011.337505748732;3013.382256637384;472.0417552368697;476.9117713223065;480.2124515794101;486.7541891344848;495.8735522441754;667.3160010988776;669.6350488983516;684.1824020295799;692.536000879412;727.7380143148463;8877.866831997526;8967.282617390592;9118.544072796334;9127.77180570491;9197.264218862474;600.5675913342386;694.6075467361026;707.9221285658573;713.3116542536477;726.4152357352276;3787.3750831113107;4129.215449064668;4132.235536425771;4149.834006639761;4181.268278051329;54925.45074549203;59406;59781.70109149513;59871;60337.69831150816;47672.56982290537;48457;48778.75610621924;52478.47521524812;53082.46917530775;47461.52538474571;47769.76115119402;48265.75867120642;48387;49165.50834491681;8364.53995030255;8499.95750021246;8820.941487021599;8864.468131912106;8917.10828917103;35633.64366356303;37446.812765935996;37846;38530.2293954125;38990.80504597459;41642;44581.33128003018;44804.32793508035;47188.29217561808;47252.763736182475;8297.917020829957;8368.079511253878;8433.87349189775;8469.915300846913;8478.321734261368;11893.940530297294;11896.643100706993;11937.940310298392;12013.279203247834;12025.45885435175;11130.443477826238;11204.271722338022;11230.157738169833;11316.60391886313;11396.031337336088;10759.731006724582;10828.13374929988;11015.889841101487;11317.660470185907;11683.240589361665;10845.891541084487;11096.389698566334;11194.944025279821;11233.775324493628;11495.080393568662;9616.843702579454;9904.603815847573;9916.950415247878;10017.69946901594;10059.849102263326;9075.954620226856;9642.517874106126;9647.276454265817;9647.517624118625;9742.75643108928 04:06:08 INFO - 2015-11-17 04:06:08,775 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:08 INFO - 2015-11-17 04:06:08,775 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:06:08 INFO - 2015-11-17 04:06:08,775 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,283 04:06:08 INFO - 2015-11-17 04:06:08,775 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:06:08 INFO - 2015-11-17 04:06:08,775 DEBUG : BROWSER_OUTPUT: __startTimestamp1447761968767__endTimestamp 04:06:08 INFO - 2015-11-17 04:06:08,775 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2015-11-17 04:06:08,775 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:08 INFO - 2015-11-17 04:06:08,775 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:06:08 INFO - 2015-11-17 04:06:08,775 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2015-11-17 04:06:08,776 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5587.63 Median:5868.50 stddev:655.13 (11.2%) stddev-sans-first:631.21 04:06:08 INFO - 2015-11-17 04:06:08,776 DEBUG : BROWSER_OUTPUT: Values: 3261.3 3302.9 3320.8 3348.8 3354.3 5401.4 5511.8 5548.7 5568.2 5576.9 5484.7 5515.9 5524.4 5531.3 5562.2 4977.4 5040.8 5106.9 5223.9 5255.4 4894.5 5138.4 5140.5 5196.9 5234.6 4879.4 4950.0 4966.7 4966.9 5037.0 5031.8 5048.1 5062.7 5064.5 5082.1 4921.8 4974.2 4990.0 4995.6 5046.3 5307.3 5323.3 5357.3 5385.1 5448.6 6080.3 6103.3 6103.8 6106.6 6112.0 5918.5 5972.5 6023.2 6140.8 6146.2 5645.4 5707.8 5714.3 5718.6 5754.2 6191.9 6200.9 6204.0 6206.7 6217.6 5771.4 5895.9 5896.6 5967.7 6028.9 6052.5 6091.9 6119.5 6126.4 6126.5 6007.3 6041.7 6048.1 6059.8 6066.2 5854.9 5942.1 5948.0 6008.5 6051.1 4591.2 4607.6 4640.6 4651.1 4676.3 3912.1 4022.0 4031.0 4032.7 4057.1 5648.7 5735.4 5743.3 5809.2 5868.5 5982.3 5995.4 6006.2 6018.7 6033.5 5505.8 5672.5 5729.1 5731.1 5746.7 5171.3 5199.0 5200.6 5200.7 5240.6 6228.0 6251.8 6293.4 6296.3 6320.5 5930.9 5961.6 5974.8 6141.5 6165.8 6155.6 6183.5 6191.5 6206.5 6213.6 5927.2 5932.2 5960.9 5966.8 5969.3 5871.9 5972.9 5977.1 6010.8 6089.4 5946.1 5954.6 5995.0 6017.7 6021.3 5957.9 5985.1 5991.7 5995.5 5996.6 5678.7 5726.8 5835.4 5846.5 5860.1 5935.2 6026.5 6034.8 6037.3 6046.2 5583.7 5888.7 5893.1 5907.5 5907.7 04:06:08 INFO - 2015-11-17 04:06:08,776 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2015-11-17 04:06:08,776 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47449.97 Median:36747.68 stddev:78424.28 (213.4%) stddev-sans-first:78565.25 04:06:08 INFO - 2015-11-17 04:06:08,777 DEBUG : BROWSER_OUTPUT: Values: 557.5 560.4 562.1 570.1 574.9 39431.6 40383.4 40404.6 40478.4 40612.2 43320.0 43766.0 43795.8 43835.6 43840.8 8724.7 8839.8 8849.8 8872.3 8905.7 8647.5 8748.7 8767.4 8769.5 8793.3 8726.0 8777.8 8819.0 8845.6 8850.7 8771.9 8831.2 8849.2 8864.3 8869.9 8642.2 8706.5 8747.6 8778.1 8801.8 41015.8 41717.6 41780.2 41842.4 41846.8 2766.8 3089.4 3300.8 3373.7 3726.9 30076.7 30274.5 30380.9 30460.8 31154.5 3495.5 3526.0 3527.2 3548.4 3650.2 259684.0 259846.0 260520.0 262135.0 263376.0 58281.1 58362.7 59144.4 65240.3 67767.7 62438.4 62632.4 62685.0 62773.4 62789.1 16442.5 16444.5 16631.7 16650.8 16706.6 12456.4 12469.6 12508.6 12560.5 12619.1 20041.1 20316.0 20370.9 20570.4 20576.2 7959.4 8209.2 8251.4 8286.7 8351.0 916.8 928.8 966.1 986.0 1030.3 28282.4 28333.3 28545.0 28814.0 29106.9 1028.2 1040.9 1067.2 1138.9 1146.3 14138.6 14386.6 14496.0 15690.0 15920.3 310922.0 312846.0 313920.0 318662.0 318905.0 54328.7 54376.5 54401.5 54523.5 54564.5 1377.1 1380.1 1380.2 1383.3 1487.0 28574.4 29353.4 29574.6 29657.7 29968.9 47204.5 47304.5 47709.5 47753.0 47781.8 319523.0 320199.0 320275.0 320423.0 321952.0 31428.4 32906.5 33221.0 33339.7 33423.2 40557.0 42673.1 43139.8 43644.1 44888.8 36517.5 37239.8 37242.6 37489.3 38189.6 36977.8 37145.7 37264.3 37452.3 37501.8 35698.3 35731.0 36110.0 36218.0 36238.6 31119.8 31525.7 32496.7 32676.2 33189.8 24781.0 24840.3 24958.6 25046.9 25299.6 04:06:08 INFO - 2015-11-17 04:06:08,777 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2015-11-17 04:06:08,778 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29015.00 Median:43395.17 stddev:99305.47 (228.8%) stddev-sans-first:99560.71 04:06:08 INFO - 2015-11-17 04:06:08,778 DEBUG : BROWSER_OUTPUT: Values: 347.5 351.6 355.0 355.6 355.7 12535.9 12816.6 16462.8 16779.7 17222.1 11560.1 11663.9 11679.3 11723.0 12048.1 4475.7 4585.1 4598.7 4601.7 4602.5 4461.6 4528.6 4571.2 4580.0 4595.4 4545.3 4556.7 4562.5 4755.7 4854.3 4780.6 4796.8 4800.0 4803.5 4821.7 4118.7 4197.6 4206.7 4211.6 4221.4 13439.3 13881.9 13984.4 13989.3 14014.6 2009.3 2047.8 2065.1 2070.4 2086.1 9499.0 9605.5 9678.4 9992.3 10032.7 1737.3 1737.9 1750.8 1837.7 1894.8 60250.0 61780.0 62220.0 62253.4 62573.0 6972.7 7033.6 7036.6 7055.6 7070.8 8226.7 8232.1 8274.8 8281.5 8289.1 5631.4 5672.5 5705.4 5719.7 5731.0 6005.9 6033.0 6041.2 6060.5 6104.6 3230.4 3278.9 3291.4 3299.7 3303.3 1137.4 1140.5 1144.6 1150.6 1209.0 467.1 471.1 474.8 478.2 479.7 11701.4 12518.4 12553.0 12722.6 12767.0 508.5 513.3 529.2 529.2 539.7 6480.7 6502.2 6644.4 6665.6 6742.1 581265.0 605748.0 606455.0 608533.0 631184.0 75480.0 76111.0 76887.2 76972.0 79805.6 562.0 563.3 566.7 566.9 567.6 10797.9 11202.6 11329.3 11361.7 11582.0 33112.8 33736.7 34021.1 36496.3 36758.6 41854.4 42395.4 42960.6 43284.6 43505.8 6819.6 6838.8 6859.7 6865.0 6891.9 11946.1 12182.9 12240.4 12437.6 12517.6 9535.4 10700.3 10769.8 10810.6 10946.0 8857.3 9529.5 9730.9 10005.3 10135.4 10132.4 10169.4 10191.5 10264.6 10313.4 14226.7 15071.9 15248.5 15571.1 15675.9 15552.1 15583.8 15850.4 16038.0 16348.8 04:06:08 INFO - 2015-11-17 04:06:08,778 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2015-11-17 04:06:08,778 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5454.86 Median:6524.14 stddev:2810.42 (43.1%) stddev-sans-first:2802.02 04:06:08 INFO - 2015-11-17 04:06:08,779 DEBUG : BROWSER_OUTPUT: Values: 1429.8 1711.3 1768.2 1781.7 1788.5 7651.8 7734.3 7946.4 7974.1 8001.5 7707.1 7712.5 7734.1 7792.6 7795.2 2124.0 2135.0 2142.5 2150.2 2150.9 2266.7 2287.2 2343.8 2343.8 2348.2 2263.1 2283.9 2313.5 2315.9 2328.4 2238.9 2250.5 2264.7 2266.8 2268.6 2317.9 2365.6 2366.6 2369.5 2370.7 7571.9 7663.4 7673.6 7686.8 7689.6 4614.0 4631.2 4704.1 4709.0 4714.8 3035.3 3075.1 3116.7 3133.7 3137.0 1041.7 1049.9 1056.1 1067.8 1075.5 10719.2 10786.4 10791.1 10814.6 10847.6 4044.6 4063.9 4080.8 4109.0 4171.0 8685.4 8809.4 8819.6 8845.8 8851.5 4665.8 4672.0 4676.4 4688.2 4696.4 4301.9 4311.9 4329.7 4345.2 4350.8 3429.8 3469.9 3486.2 3495.9 3505.8 1058.0 1059.5 1064.8 1072.4 1077.4 1083.1 1098.5 1152.4 1280.6 1383.6 7256.6 7434.8 7454.5 7495.1 7502.1 1031.5 1033.1 1049.3 1108.5 1135.2 5862.3 5867.5 5869.5 5929.9 5934.9 9117.8 9221.9 9325.9 9351.2 9460.1 9163.5 9221.6 9239.7 9276.0 9312.2 7023.9 7073.2 7079.2 7100.8 7139.9 7078.4 7087.2 7107.8 7108.3 7108.3 7993.9 8155.9 8181.6 8246.5 8251.6 8428.8 8459.5 8495.1 8531.3 8600.1 6754.5 7038.2 7043.4 7060.6 7087.8 7595.6 7597.0 7609.6 7631.2 7663.1 6720.5 6799.2 6964.5 7065.4 7282.7 6976.1 6976.3 7052.2 7070.8 7119.0 7132.0 7155.6 7178.8 7198.5 7209.8 6505.1 6543.1 6545.7 6550.9 6558.8 6575.4 6649.2 6654.2 6664.1 6690.9 04:06:08 INFO - 2015-11-17 04:06:08,779 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2015-11-17 04:06:08,780 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5626.31 Median:6366.05 stddev:1729.03 (27.2%) stddev-sans-first:1687.60 04:06:08 INFO - 2015-11-17 04:06:08,780 DEBUG : BROWSER_OUTPUT: Values: 331.6 334.3 335.1 340.6 341.0 6259.3 6292.1 6336.9 6368.4 6372.6 6175.2 6292.7 6296.6 6309.8 6326.6 4751.3 4775.1 4789.0 4813.5 4826.9 4801.0 4805.2 4815.2 4821.3 4836.6 4700.7 4787.8 4791.0 4791.0 4798.9 4757.9 4767.5 4768.8 4772.0 4782.0 4127.0 4135.9 4140.0 4154.6 4160.1 5904.2 5971.2 5979.9 5988.3 5997.7 5447.7 5560.8 5568.4 5584.8 5599.5 6642.9 6680.8 6694.0 6698.5 6725.6 4596.5 4600.1 4601.9 4604.9 4614.6 6835.5 6966.3 7019.9 7020.2 7032.1 4664.7 4700.6 4702.8 4708.7 4711.9 4769.1 4781.3 4787.4 4789.8 4795.9 5535.8 5536.9 5539.2 5545.3 5545.7 6676.4 6695.9 6809.1 6811.8 6812.8 1618.3 1657.4 1660.1 1661.0 1673.7 1080.8 1086.9 1093.7 1102.4 1105.2 6359.6 6386.1 6421.3 6436.7 6438.5 6826.0 6827.5 6829.7 6843.0 6846.1 6323.9 6363.7 6409.3 6409.7 6470.9 3798.8 3835.1 3839.0 3847.2 3849.9 7283.2 7290.4 7301.7 7311.2 7312.0 7090.4 7252.4 7263.5 7269.5 7283.8 7266.0 7274.1 7280.7 7284.0 7284.7 7007.6 7027.8 7033.9 7036.6 7036.7 6733.8 6920.8 6971.4 6977.8 7012.5 7236.4 7268.1 7320.3 7325.9 7330.2 4604.5 4635.6 4649.0 4662.7 4664.3 6817.4 6869.3 6937.7 7035.3 7045.2 6805.4 6838.5 6848.1 6850.1 6854.2 6718.0 6797.4 6816.9 6820.1 6835.8 6554.1 6695.1 6713.7 6716.3 6721.1 6841.4 6886.0 6890.1 6903.8 6920.3 6623.0 6647.8 6679.9 6701.0 6708.3 04:06:08 INFO - 2015-11-17 04:06:08,780 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2015-11-17 04:06:08,780 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13572.78 Median:47721.17 stddev:16172.71 (33.9%) stddev-sans-first:16189.13 04:06:08 INFO - 2015-11-17 04:06:08,782 DEBUG : BROWSER_OUTPUT: Values: 687.0 741.5 773.7 780.2 787.2 13475.3 13680.0 13752.4 13780.2 13811.2 12271.4 12354.6 14570.3 14668.3 14678.3 804.8 816.4 817.7 819.8 826.9 791.9 792.0 792.0 794.1 819.5 829.2 830.9 832.3 840.4 858.2 822.7 823.7 823.8 827.0 865.8 602.1 620.7 634.0 635.1 635.3 13523.5 13617.5 13662.6 13690.0 13700.0 10104.2 10243.6 10451.9 10902.5 11456.7 10017.0 10030.5 10128.9 10348.5 10554.2 3261.5 3292.5 3314.3 3335.7 3400.7 46334.0 46561.5 46694.3 46761.8 46865.0 7862.1 7940.8 7947.0 7970.9 7971.9 12790.5 12794.4 12805.9 12859.1 12866.8 6646.5 6807.4 6827.9 6860.4 7016.7 4354.9 4508.5 4531.0 4554.9 4571.5 2935.5 3001.3 3005.5 3011.3 3013.4 472.0 476.9 480.2 486.8 495.9 667.3 669.6 684.2 692.5 727.7 8877.9 8967.3 9118.5 9127.8 9197.3 600.6 694.6 707.9 713.3 726.4 3787.4 4129.2 4132.2 4149.8 4181.3 54925.5 59406.0 59781.7 59871.0 60337.7 47672.6 48457.0 48778.8 52478.5 53082.5 47461.5 47769.8 48265.8 48387.0 49165.5 8364.5 8500.0 8820.9 8864.5 8917.1 35633.6 37446.8 37846.0 38530.2 38990.8 41642.0 44581.3 44804.3 47188.3 47252.8 8297.9 8368.1 8433.9 8469.9 8478.3 11893.9 11896.6 11937.9 12013.3 12025.5 11130.4 11204.3 11230.2 11316.6 11396.0 10759.7 10828.1 11015.9 11317.7 11683.2 10845.9 11096.4 11194.9 11233.8 11495.1 9616.8 9904.6 9917.0 10017.7 10059.8 9076.0 9642.5 9647.3 9647.5 9742.8 04:06:08 INFO - 2015-11-17 04:06:08,782 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:08 INFO - 2015-11-17 04:06:08,782 DEBUG : BROWSER_OUTPUT: 04:06:09 INFO - 2015-11-17 04:06:09,499 INFO : Browser exited with error code: 0 04:06:09 INFO - 2015-11-17 04:06:09,520 INFO : Completed test dromaeo_css (00:18:30) 04:06:09 INFO - 2015-11-17 04:06:09,520 INFO : Starting test kraken 04:06:09 INFO - 2015-11-17 04:06:09,520 DEBUG : operating with platform_type : linux_ 04:06:09 INFO - 2015-11-17 04:06:09,520 INFO : Initialising browser for kraken test... 04:06:09 INFO - 2015-11-17 04:06:09,526 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbOzU5c/profile http://localhost:39668/getInfo.html 04:06:14 INFO - 2015-11-17 04:06:14,168 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:06:14 INFO - 2015-11-17 04:06:14,169 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:06:14 INFO - 2015-11-17 04:06:14,169 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:06:14 INFO - 2015-11-17 04:06:14,169 DEBUG : BROWSER_OUTPUT: __metrics 04:06:15 INFO - 2015-11-17 04:06:15,191 INFO : Browser initialized. 04:06:15 INFO - 2015-11-17 04:06:15,191 INFO : Running cycle 1/1 for kraken test... 04:06:15 INFO - 2015-11-17 04:06:15,191 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbOzU5c/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:06:26 INFO - 2015-11-17 04:06:26,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 141209600 04:06:26 INFO - 2015-11-17 04:06:26,984 DEBUG : BROWSER_OUTPUT: 04:06:29 INFO - 2015-11-17 04:06:29,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39668/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:30 INFO - 2015-11-17 04:06:30,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 141283328 04:06:30 INFO - 2015-11-17 04:06:30,073 DEBUG : BROWSER_OUTPUT: 04:06:32 INFO - 2015-11-17 04:06:32,735 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39668/tests/kraken/driver.html?testName=audio-dft) 04:06:33 INFO - 2015-11-17 04:06:33,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 142147584 04:06:33 INFO - 2015-11-17 04:06:33,329 DEBUG : BROWSER_OUTPUT: 04:06:36 INFO - 2015-11-17 04:06:36,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39668/tests/kraken/driver.html?testName=audio-fft) 04:06:36 INFO - 2015-11-17 04:06:36,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 135933952 04:06:36 INFO - 2015-11-17 04:06:36,783 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2015-11-17 04:06:38,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39668/tests/kraken/driver.html?testName=audio-oscillator) 04:06:39 INFO - 2015-11-17 04:06:39,349 DEBUG : BROWSER_OUTPUT: RSS: Main: 136597504 04:06:39 INFO - 2015-11-17 04:06:39,349 DEBUG : BROWSER_OUTPUT: 04:06:41 INFO - 2015-11-17 04:06:41,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39668/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:06:42 INFO - 2015-11-17 04:06:42,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 137109504 04:06:42 INFO - 2015-11-17 04:06:42,095 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-17 04:06:45,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39668/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:45 INFO - 2015-11-17 04:06:45,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 138121216 04:06:45 INFO - 2015-11-17 04:06:45,702 DEBUG : BROWSER_OUTPUT: 04:06:49 INFO - 2015-11-17 04:06:49,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39668/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:49 INFO - 2015-11-17 04:06:49,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 139530240 04:06:49 INFO - 2015-11-17 04:06:49,679 DEBUG : BROWSER_OUTPUT: 04:06:52 INFO - 2015-11-17 04:06:52,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39668/tests/kraken/driver.html?testName=json-parse-financial) 04:06:53 INFO - 2015-11-17 04:06:53,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 138477568 04:06:53 INFO - 2015-11-17 04:06:53,099 DEBUG : BROWSER_OUTPUT: 04:06:54 INFO - 2015-11-17 04:06:54,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39668/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:55 INFO - 2015-11-17 04:06:55,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 138252288 04:06:55 INFO - 2015-11-17 04:06:55,255 DEBUG : BROWSER_OUTPUT: 04:06:57 INFO - 2015-11-17 04:06:57,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39668/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:57 INFO - 2015-11-17 04:06:57,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 138829824 04:06:57 INFO - 2015-11-17 04:06:57,688 DEBUG : BROWSER_OUTPUT: 04:06:59 INFO - 2015-11-17 04:06:59,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39668/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:07:00 INFO - 2015-11-17 04:07:00,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 139649024 04:07:00 INFO - 2015-11-17 04:07:00,347 DEBUG : BROWSER_OUTPUT: 04:07:02 INFO - 2015-11-17 04:07:02,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:07:03 INFO - 2015-11-17 04:07:03,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 140353536 04:07:03 INFO - 2015-11-17 04:07:03,413 DEBUG : BROWSER_OUTPUT: 04:07:05 INFO - 2015-11-17 04:07:05,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:07:06 INFO - 2015-11-17 04:07:06,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 139087872 04:07:06 INFO - 2015-11-17 04:07:06,561 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39668/tests/kraken/driver.html?testName=ai-astar) 04:07:08 INFO - 2015-11-17 04:07:08,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 139988992 04:07:08 INFO - 2015-11-17 04:07:08,495 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,498 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:08 INFO - 2015-11-17 04:07:08,498 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:08 INFO - 2015-11-17 04:07:08,498 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:08 INFO - 2015-11-17 04:07:08,498 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:08 INFO - 2015-11-17 04:07:08,499 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;106;111;110;111;123;111;112;113;110 04:07:08 INFO - 2015-11-17 04:07:08,499 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;133;155;169;134;155;153;126;158;126 04:07:08 INFO - 2015-11-17 04:07:08,499 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;164;162;161;163;164;165;167;163 04:07:08 INFO - 2015-11-17 04:07:08,499 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;73;73;72;73;132;71;72;72 04:07:08 INFO - 2015-11-17 04:07:08,499 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;130;89;89;91;144;90;91;132 04:07:08 INFO - 2015-11-17 04:07:08,499 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;109;110 04:07:08 INFO - 2015-11-17 04:07:08,499 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;146;146;146;146;147;146 04:07:08 INFO - 2015-11-17 04:07:08,500 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;97;97;98;96;97;96;96 04:07:08 INFO - 2015-11-17 04:07:08,500 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;61;61;61;61;61;59;61;63;60 04:07:08 INFO - 2015-11-17 04:07:08,500 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;70;70;70;70;70;69 04:07:08 INFO - 2015-11-17 04:07:08,500 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;88;86;85;86;85;87;86;87;85 04:07:08 INFO - 2015-11-17 04:07:08,500 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;122;121;122;126;126;120;116;120;127 04:07:08 INFO - 2015-11-17 04:07:08,500 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;155;150;150;139;148;152;148;148;139 04:07:08 INFO - 2015-11-17 04:07:08,500 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;69;67;66;68;66;68;66;67 04:07:08 INFO - 2015-11-17 04:07:08,500 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:08 INFO - 2015-11-17 04:07:08,501 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:07:08 INFO - 2015-11-17 04:07:08,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,722 04:07:08 INFO - 2015-11-17 04:07:08,501 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:07:08 INFO - 2015-11-17 04:07:08,501 DEBUG : BROWSER_OUTPUT: __startTimestamp1447762028496__endTimestamp 04:07:08 INFO - 2015-11-17 04:07:08,501 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,505 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:08 INFO - 2015-11-17 04:07:08,505 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:07:08 INFO - 2015-11-17 04:07:08,505 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,505 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:111.00 stddev:4.37 (3.9%) stddev-sans-first:4.59 04:07:08 INFO - 2015-11-17 04:07:08,506 DEBUG : BROWSER_OUTPUT: Values: 110.0 106.0 111.0 110.0 111.0 123.0 111.0 112.0 113.0 110.0 04:07:08 INFO - 2015-11-17 04:07:08,506 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,506 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.90 Median:154.00 stddev:14.96 (9.7%) stddev-sans-first:15.79 04:07:08 INFO - 2015-11-17 04:07:08,506 DEBUG : BROWSER_OUTPUT: Values: 150.0 133.0 155.0 169.0 134.0 155.0 153.0 126.0 158.0 126.0 04:07:08 INFO - 2015-11-17 04:07:08,506 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,507 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 04:07:08 INFO - 2015-11-17 04:07:08,507 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 164.0 162.0 161.0 163.0 164.0 165.0 167.0 163.0 04:07:08 INFO - 2015-11-17 04:07:08,507 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,507 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.50 Median:73.00 stddev:18.82 (25.8%) stddev-sans-first:19.85 04:07:08 INFO - 2015-11-17 04:07:08,507 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 73.0 73.0 72.0 73.0 132.0 71.0 72.0 72.0 04:07:08 INFO - 2015-11-17 04:07:08,507 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,507 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.70 Median:90.00 stddev:22.13 (24.6%) stddev-sans-first:22.99 04:07:08 INFO - 2015-11-17 04:07:08,507 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 130.0 89.0 89.0 91.0 144.0 90.0 91.0 132.0 04:07:08 INFO - 2015-11-17 04:07:08,507 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,508 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 97.0 97.0 98.0 96.0 97.0 96.0 96.0 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 61.0 61.0 61.0 61.0 59.0 61.0 63.0 60.0 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 70.0 70.0 70.0 70.0 70.0 69.0 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,509 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:1.20 (1.4%) stddev-sans-first:1.05 04:07:08 INFO - 2015-11-17 04:07:08,510 DEBUG : BROWSER_OUTPUT: Values: 84.0 88.0 86.0 85.0 86.0 85.0 87.0 86.0 87.0 85.0 04:07:08 INFO - 2015-11-17 04:07:08,510 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,510 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:123.00 stddev:3.41 (2.8%) stddev-sans-first:3.56 04:07:08 INFO - 2015-11-17 04:07:08,510 DEBUG : BROWSER_OUTPUT: Values: 124.0 122.0 121.0 122.0 126.0 126.0 120.0 116.0 120.0 127.0 04:07:08 INFO - 2015-11-17 04:07:08,510 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,510 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:149.00 stddev:5.65 (3.8%) stddev-sans-first:5.41 04:07:08 INFO - 2015-11-17 04:07:08,510 DEBUG : BROWSER_OUTPUT: Values: 140.0 155.0 150.0 150.0 139.0 148.0 152.0 148.0 148.0 139.0 04:07:08 INFO - 2015-11-17 04:07:08,510 DEBUG : BROWSER_OUTPUT: 04:07:08 INFO - 2015-11-17 04:07:08,510 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.42 04:07:08 INFO - 2015-11-17 04:07:08,510 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 67.0 66.0 68.0 66.0 68.0 66.0 67.0 04:07:08 INFO - 2015-11-17 04:07:08,510 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:08 INFO - 2015-11-17 04:07:08,510 DEBUG : BROWSER_OUTPUT: 04:07:09 INFO - 2015-11-17 04:07:09,479 INFO : Browser exited with error code: 0 04:07:09 INFO - 2015-11-17 04:07:09,529 INFO : Completed test kraken (00:01:00) 04:07:09 INFO - 2015-11-17 04:07:09,530 INFO : Starting test v8_7 04:07:09 INFO - 2015-11-17 04:07:09,530 DEBUG : operating with platform_type : linux_ 04:07:09 INFO - 2015-11-17 04:07:09,530 INFO : Initialising browser for v8_7 test... 04:07:09 INFO - 2015-11-17 04:07:09,536 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvw9FbT/profile http://localhost:39668/getInfo.html 04:07:13 INFO - 2015-11-17 04:07:13,887 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:07:13 INFO - 2015-11-17 04:07:13,887 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:07:13 INFO - 2015-11-17 04:07:13,887 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:07:13 INFO - 2015-11-17 04:07:13,888 DEBUG : BROWSER_OUTPUT: __metrics 04:07:14 INFO - 2015-11-17 04:07:14,903 INFO : Browser initialized. 04:07:14 INFO - 2015-11-17 04:07:14,903 INFO : Running cycle 1/1 for v8_7 test... 04:07:14 INFO - 2015-11-17 04:07:14,903 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvw9FbT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:07:26 INFO - 2015-11-17 04:07:26,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 141312000 04:07:26 INFO - 2015-11-17 04:07:26,678 DEBUG : BROWSER_OUTPUT: 04:07:47 INFO - 2015-11-17 04:07:47,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39668/tests/v8_7/run.html (next: http://localhost:39668/tests/v8_7/run.html) 04:07:48 INFO - 2015-11-17 04:07:48,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 136556544 04:07:48 INFO - 2015-11-17 04:07:48,250 DEBUG : BROWSER_OUTPUT: 04:07:48 INFO - 2015-11-17 04:07:48,250 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:48 INFO - 2015-11-17 04:07:48,250 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:48 INFO - 2015-11-17 04:07:48,250 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:48 INFO - 2015-11-17 04:07:48,250 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:48 INFO - 2015-11-17 04:07:48,250 DEBUG : BROWSER_OUTPUT: |0;Richards;162.39038648911983 04:07:48 INFO - 2015-11-17 04:07:48,251 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.90174630589138 04:07:48 INFO - 2015-11-17 04:07:48,251 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.1120448179272 04:07:48 INFO - 2015-11-17 04:07:48,251 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 04:07:48 INFO - 2015-11-17 04:07:48,251 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1048.2180293501049 04:07:48 INFO - 2015-11-17 04:07:48,251 DEBUG : BROWSER_OUTPUT: |5;Earley;719.626168224299 04:07:48 INFO - 2015-11-17 04:07:48,251 DEBUG : BROWSER_OUTPUT: |6;Boyer;12000 04:07:48 INFO - 2015-11-17 04:07:48,251 DEBUG : BROWSER_OUTPUT: |7;RegExp;25769.23076923077 04:07:48 INFO - 2015-11-17 04:07:48,252 DEBUG : BROWSER_OUTPUT: |8;Splay;650.1950585175553 04:07:48 INFO - 2015-11-17 04:07:48,252 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 04:07:48 INFO - 2015-11-17 04:07:48,252 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:48 INFO - 2015-11-17 04:07:48,252 DEBUG : BROWSER_OUTPUT: __startTimestamp1447762068242__endTimestamp 04:07:48 INFO - 2015-11-17 04:07:48,252 DEBUG : BROWSER_OUTPUT: 04:07:48 INFO - 2015-11-17 04:07:48,252 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:48 INFO - 2015-11-17 04:07:48,252 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:07:48 INFO - 2015-11-17 04:07:48,253 DEBUG : BROWSER_OUTPUT: 04:07:48 INFO - 2015-11-17 04:07:48,253 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.39 Median:162.39 stddev:0.00 (0.0%) 04:07:48 INFO - 2015-11-17 04:07:48,253 DEBUG : BROWSER_OUTPUT: Values: 162.4 04:07:48 INFO - 2015-11-17 04:07:48,253 DEBUG : BROWSER_OUTPUT: 04:07:48 INFO - 2015-11-17 04:07:48,253 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.90 Median:191.90 stddev:0.00 (0.0%) 04:07:48 INFO - 2015-11-17 04:07:48,253 DEBUG : BROWSER_OUTPUT: Values: 191.9 04:07:48 INFO - 2015-11-17 04:07:48,253 DEBUG : BROWSER_OUTPUT: 04:07:48 INFO - 2015-11-17 04:07:48,253 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 04:07:48 INFO - 2015-11-17 04:07:48,254 DEBUG : BROWSER_OUTPUT: Values: 280.1 04:07:48 INFO - 2015-11-17 04:07:48,254 DEBUG : BROWSER_OUTPUT: 04:07:48 INFO - 2015-11-17 04:07:48,254 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 04:07:48 INFO - 2015-11-17 04:07:48,254 DEBUG : BROWSER_OUTPUT: Values: 5025.1 04:07:48 INFO - 2015-11-17 04:07:48,254 DEBUG : BROWSER_OUTPUT: 04:07:48 INFO - 2015-11-17 04:07:48,254 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1048.22 Median:1048.22 stddev:0.00 (0.0%) 04:07:48 INFO - 2015-11-17 04:07:48,255 DEBUG : BROWSER_OUTPUT: Values: 1048.2 04:07:48 INFO - 2015-11-17 04:07:48,255 DEBUG : BROWSER_OUTPUT: 04:07:48 INFO - 2015-11-17 04:07:48,255 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:719.63 Median:719.63 stddev:0.00 (0.0%) 04:07:48 INFO - 2015-11-17 04:07:48,255 DEBUG : BROWSER_OUTPUT: Values: 719.6 04:07:48 INFO - 2015-11-17 04:07:48,255 DEBUG : BROWSER_OUTPUT: 04:07:48 INFO - 2015-11-17 04:07:48,255 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12000.00 Median:12000.00 stddev:0.00 (0.0%) 04:07:48 INFO - 2015-11-17 04:07:48,256 DEBUG : BROWSER_OUTPUT: Values: 12000.0 04:07:48 INFO - 2015-11-17 04:07:48,256 DEBUG : BROWSER_OUTPUT: 04:07:48 INFO - 2015-11-17 04:07:48,256 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25769.23 Median:25769.23 stddev:0.00 (0.0%) 04:07:48 INFO - 2015-11-17 04:07:48,256 DEBUG : BROWSER_OUTPUT: Values: 25769.2 04:07:48 INFO - 2015-11-17 04:07:48,256 DEBUG : BROWSER_OUTPUT: 04:07:48 INFO - 2015-11-17 04:07:48,256 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:650.20 Median:650.20 stddev:0.00 (0.0%) 04:07:48 INFO - 2015-11-17 04:07:48,256 DEBUG : BROWSER_OUTPUT: Values: 650.2 04:07:48 INFO - 2015-11-17 04:07:48,256 DEBUG : BROWSER_OUTPUT: 04:07:48 INFO - 2015-11-17 04:07:48,257 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:07:48 INFO - 2015-11-17 04:07:48,257 DEBUG : BROWSER_OUTPUT: Values: 4826.9 04:07:48 INFO - 2015-11-17 04:07:48,257 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:48 INFO - 2015-11-17 04:07:48,257 DEBUG : BROWSER_OUTPUT: 04:07:49 INFO - 2015-11-17 04:07:49,255 INFO : Browser exited with error code: 0 04:07:49 INFO - 2015-11-17 04:07:49,273 INFO : Completed test v8_7 (00:00:39) 04:07:49 INFO - 2015-11-17 04:07:49,330 INFO : Completed test suite (00:20:10) 04:07:49 INFO - 2015-11-17 04:07:49,330 DEBUG : Working with test: dromaeo_css 04:07:49 INFO - 2015-11-17 04:07:49,330 DEBUG : Generating results file: dromaeo_css 04:07:49 INFO - 2015-11-17 04:07:49,331 DEBUG : Working with test: kraken 04:07:49 INFO - 2015-11-17 04:07:49,332 DEBUG : Generating results file: kraken 04:07:49 INFO - 2015-11-17 04:07:49,332 INFO : javascript benchmark 04:07:49 INFO - 2015-11-17 04:07:49,332 DEBUG : Working with test: v8_7 04:07:49 INFO - 2015-11-17 04:07:49,332 DEBUG : Generating results file: v8_7 04:07:49 INFO - 2015-11-17 04:07:49,332 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:49 INFO - 2015-11-17 04:07:49,385 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 04:07:49 INFO - 2015-11-17 04:07:49,385 DEBUG : process_Request line: dromaeo_css 6849.47 graph.html#tests=[[72,1,43]] 04:07:49 INFO - 2015-11-17 04:07:49,385 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:49 INFO - 2015-11-17 04:07:49,418 DEBUG : process_Request line: kraken 1509.50 graph.html#tests=[[232,1,43]] 04:07:49 INFO - 2015-11-17 04:07:49,419 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:49 INFO - 2015-11-17 04:07:49,451 DEBUG : process_Request line: v8_7 21320.39 graph.html#tests=[[230,1,43]] 04:07:49 INFO - 2015-11-17 04:07:49,452 INFO : javascript benchmark 04:07:49 INFO - 2015-11-17 04:07:49,456 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [347.4649040477664, 351.5833737021631, 355.03784743345534, 355.6088302866845, 355.66212098506423, 12535.874641253584, 12816.615501534969, 16462.84760066796, 16779.748303775454, 17222.13889305536, 11560.132990025739, 11663.941680291588, 11679.299242045483, 11723.00354469869, 12048.096392770534, 4475.709078909877, 4585.082983403316, 4598.701084429518, 4601.677882548223, 4602.470715867667, 4461.643068554524, 4528.569785870337, 4571.1771881061395, 4580.0, 4595.402597662299, 4545.250033744428, 4556.749378784166, 4562.4753153387455, 4755.667103302771, 4854.271859221128, 4780.569748722614, 4796.808127674889, 4800.0, 4803.471618122004, 4821.734804585764, 4118.691098167649, 4197.580241975778, 4206.72656277341, 4211.620954114113, 4221.387898754694, 13439.328033598282, 13881.930590346983, 13984.370703318375, 13989.300534973312, 14014.649633759136, 2009.3067891577382, 2047.846411519127, 2065.1429656692453, 2070.3685375960326, 2086.050846864673, 9498.95250523743, 9605.519724013771, 9678.370905891095, 9992.25058120644, 10032.749181270454, 1737.3311275159028, 1737.8522825559842, 1750.8336708012719, 1837.6508463391913, 1894.7915729269769, 60250.0, 61780.0, 62220.0, 62253.37746622521, 62572.99999999954, 6972.651367431608, 7033.613151276729, 7036.577805331696, 7055.576665400093, 7070.823229419306, 8226.712065077694, 8232.135625759329, 8274.834503310021, 8281.461704989157, 8289.088200297962, 5631.436856314336, 5672.546196304285, 5705.372409035002, 5719.656820590778, 5731.0, 6005.939940600625, 6033.0, 6041.184440100618, 6060.484858787053, 6104.603200791934, 3230.4185246655356, 3278.868845246211, 3291.391092647868, 3299.7195238405006, 3303.3228188221356, 1137.374444055766, 1140.4753813245834, 1144.6108323169994, 1150.61454412771, 1209.0206932384797, 467.06819894311064, 471.1378177934372, 474.810075969608, 478.17276112325175, 479.7169669894779, 11701.356425396685, 12518.436670349856, 12553.0, 12722.554710585086, 12767.042471814651, 508.5346907579597, 513.3147248423396, 529.1850550152722, 529.1876968852793, 539.7382269599241, 6480.675966201766, 6502.219733631994, 6644.435223006099, 6665.633390163587, 6742.089817874622, 581265.0, 605748.0, 606455.0, 608533.0, 631184.0, 75480.0, 76111.0, 76887.231127688, 76972.0, 79805.60097199593, 562.0445243086688, 563.3183847544435, 566.6883214232156, 566.8866226754666, 567.5629765080947, 10797.946010269898, 11202.604747490761, 11329.263597866442, 11361.715957101138, 11582.0, 33112.834435827666, 33736.66263337433, 34021.149471263416, 36496.27007459783, 36758.63241367552, 41854.372184417865, 42395.364069538366, 42960.57039429565, 43284.567154329314, 43505.78247108871, 6819.556728812611, 6838.794836154923, 6859.691313890787, 6865.0, 6891.931080689129, 11946.104042196695, 12182.878171218174, 12240.387980601112, 12437.564685236335, 12517.561885334333, 9535.38020028696, 10700.30448020876, 10769.838452423062, 10810.621628242974, 10946.0, 8857.33569982241, 9529.523523823642, 9730.854037189589, 10005.299629025898, 10135.442550659785, 10132.44271565071, 10169.389836609827, 10191.490425478845, 10264.64073757415, 10313.432761197906, 14226.71546569042, 15071.924640376728, 15248.542543723706, 15571.143587102819, 15675.921620391826, 15552.144632044894, 15583.76624350613, 15850.365985360917, 16038.0, 16348.754768678717], "dojo.html": [3261.315123823997, 3302.90091297261, 3320.8173550454744, 3348.8158151301677, 3354.3123659649773, 5401.4328495508, 5511.834644960652, 5548.7225638718055, 5568.16477528371, 5576.916346254804, 5484.725763711808, 5515.862103447415, 5524.392316845144, 5531.2809334786525, 5562.193481945115, 4977.402711674604, 5040.8235711750185, 5106.9489305106845, 5223.921641175385, 5255.448177941318, 4894.461609222983, 5138.383393992726, 5140.5373516383515, 5196.870078248036, 5234.607404444663, 4879.414470263556, 4950.0, 4966.6771659842, 4966.850994470172, 5037.042961837257, 5031.798728050873, 5048.116579598555, 5062.721550314731, 5064.4935506449065, 5082.059818933472, 4921.7785199666105, 4974.154393753034, 4989.950100499022, 4995.625328100407, 5046.318746969186, 5307.310049693515, 5323.334583177103, 5357.276767636397, 5385.057614917374, 5448.591355648342, 6080.331163572004, 6103.267607887037, 6103.786367477117, 6106.6336019838955, 6112.022076467788, 5918.526517878559, 5972.492338151263, 6023.156758053876, 6140.785072522485, 6146.231721034871, 5645.350784659735, 5707.828765136969, 5714.285714285715, 5718.5711071669375, 5754.165645981351, 6191.938080619227, 6200.937990620036, 6203.96898015507, 6206.658633775095, 6217.626942383471, 5771.422857714195, 5895.911561326584, 5896.557758168155, 5967.701614919237, 6028.879422411527, 6052.455279024821, 6091.908621370683, 6119.479844213202, 6126.356732543019, 6126.509879209652, 6007.30915944672, 6041.72812223451, 6048.092786082123, 6059.757609695651, 6066.181065556093, 5854.853628659318, 5942.078977758454, 5948.0, 6008.489278411296, 6051.062085376773, 4591.173588754056, 4607.6083532900075, 4640.628749700016, 4651.093036857848, 4676.275177347517, 3912.139329347539, 4021.9542918840725, 4030.951952492373, 4032.737872038308, 4057.1479989202007, 5648.689322087324, 5735.369109397963, 5743.282089738783, 5809.215755872903, 5868.501177399883, 5982.252218472691, 5995.400459953969, 6006.219191505076, 6018.6990650467305, 6033.547483938634, 5505.779768809202, 5672.461116193955, 5729.1119876419225, 5731.083026715789, 5746.655200687972, 5171.3277273954145, 5198.9740051299505, 5200.557952573998, 5200.687958722413, 5240.633155679142, 6228.0, 6251.78118765841, 6293.433590976742, 6296.275928268308, 6320.462760665303, 5930.911036334544, 5961.582689211714, 5974.820755377345, 6141.477974372228, 6165.784197553064, 6155.630662160284, 6183.505319574513, 6191.504679625709, 6206.472449841814, 6213.565050446426, 5927.199828023162, 5932.228810254639, 5960.910586341121, 5966.8209953699725, 5969.343372229138, 5871.882562348644, 5972.910406343822, 5977.133315669291, 6010.759569617167, 6089.421504957022, 5946.07835785454, 5954.612950158225, 5995.0, 6017.699115044318, 6021.307549631673, 5957.91063134062, 5985.102234664835, 5991.730372133352, 5995.490383317467, 5996.640201587744, 5678.68767217807, 5726.770929162787, 5835.44563266489, 5846.503047241032, 5860.120981852756, 5935.228420305332, 6026.548008899263, 6034.818955431344, 6037.305709843425, 6046.183765191819, 5583.664980101207, 5888.735006924784, 5893.116032595145, 5907.49786268172, 5907.70461476933], "mootools.html": [1429.8069760582318, 1711.3325802936854, 1768.1689605885229, 1781.7149256119023, 1788.4634609617112, 7651.8087047823765, 7734.303912647861, 7946.44374893757, 7974.122846486882, 8001.5199088054615, 7707.11368192658, 7712.498687585303, 7734.1105772836, 7792.571408572526, 7795.181505941865, 2123.978760212401, 2135.028562004284, 2142.464383904024, 2150.161437039556, 2150.8709477431403, 2266.7393249776324, 2287.1537531113513, 2343.753905839888, 2343.789058984691, 2348.236823032513, 2263.0721404224273, 2283.8743869087193, 2313.4794671199015, 2315.923095760471, 2328.4062564046144, 2238.9104435822546, 2250.5386395788823, 2264.728232612081, 2266.841321107523, 2268.591653502369, 2317.8841057947034, 2365.6096744037386, 2366.5621859955963, 2369.5024044950583, 2370.6799582056547, 7571.886421703679, 7663.425243106733, 7673.616319184019, 7686.846263074764, 7689.615519224072, 4614.0, 4631.2126938420215, 4704.082703872747, 4708.952910470885, 4714.787834547454, 3035.3322269100763, 3075.077476756964, 3116.7350775184136, 3133.686631336871, 3136.952945705816, 1041.6770801051698, 1049.8897615750313, 1056.1234175634281, 1067.765091679829, 1075.4622688655672, 10719.19606029551, 10786.352818830896, 10791.136709063256, 10814.621488247953, 10847.620333288376, 4044.6157615026527, 4063.89840253996, 4080.81636326366, 4109.0, 4171.0, 8685.39202255836, 8809.383343165917, 8819.603117859711, 8845.778855528662, 8851.51316677576, 4665.836695715634, 4671.953280467152, 4676.392069031072, 4688.226442636995, 4696.389469369028, 4301.870943871689, 4311.935320970188, 4329.740215587012, 4345.152695224401, 4350.760708161019, 3429.811360375203, 3469.930601387958, 3486.163320802989, 3495.9126021849656, 3505.789652620851, 1057.962971296001, 1059.4861492176287, 1064.7763969566322, 1072.4316112460408, 1077.353587847301, 1083.1172594335592, 1098.5056724474018, 1152.3604399558158, 1280.5966120671958, 1383.6402535340683, 7256.564606123649, 7434.814129646802, 7454.4781865268915, 7495.138059123162, 7502.062242219723, 1031.4791030529684, 1033.0960409641564, 1049.286485190078, 1108.539955918285, 1135.2053562506278, 5862.296524417097, 5867.501262392659, 5869.530437564985, 5929.881402372014, 5934.851628709317, 9117.77205569866, 9221.90778092224, 9325.860112098324, 9351.158395744416, 9460.1485866271, 9163.541822908961, 9221.585028673726, 9239.676611318706, 9275.953620231856, 9312.161905428544, 7023.8761798112055, 7073.186583542855, 7079.1858936223, 7100.751473698396, 7139.89290160648, 7078.398336141486, 7087.22040575526, 7107.786766397016, 7108.253633368422, 7108.289171082851, 7993.880091798512, 8155.877661835196, 8181.590920454072, 8246.505209687439, 8251.587420628824, 8428.831423371375, 8459.450135741157, 8495.065542790411, 8531.317494600542, 8600.09698981598, 6754.527183097136, 7038.225795162631, 7043.436525077879, 7060.6469676517, 7087.787366379017, 7595.620218989139, 7597.0, 7609.619519024137, 7631.1605723371495, 7663.080430348394, 6720.462363011045, 6799.150106236721, 6964.547304425196, 7065.399441047569, 7282.708691652275, 6976.127984002, 6976.267491913276, 7052.153741551047, 7070.7525236616475, 7119.003339532574, 7132.0, 7155.606441645759, 7178.784636460915, 7198.5320954137815, 7209.783706488814, 6505.121808555785, 6543.149390579194, 6545.705443254969, 6550.868982620416, 6558.8360290993105, 6575.4410875076155, 6649.235337936199, 6654.168228971379, 6664.067030615621, 6690.899636505359], "ext.html": [557.5428148917887, 560.4255637971079, 562.0697745231641, 570.1390899741389, 574.8620331120529, 39431.60568394319, 40383.39424908629, 40404.59595404045, 40478.39282410759, 40612.18775624489, 43320.0, 43766.0, 43795.78102109493, 43835.561644383546, 43840.780796095976, 8724.73825785226, 8839.77900552488, 8849.778755531132, 8872.334574906876, 8905.732828015138, 8647.524386158759, 8748.69379571715, 8767.386282960195, 8769.473831570094, 8793.340499462534, 8726.0, 8777.780555486132, 8818.955905220464, 8845.646174153058, 8850.690225842096, 8771.947366316052, 8831.205191532792, 8849.159329863653, 8864.335174861879, 8869.866951995726, 8642.22220000203, 8706.477611343276, 8747.606357713918, 8778.122187781235, 8801.823963520757, 41015.794921025205, 41717.58282417167, 41780.1643967122, 41842.37236441456, 41846.79076604628, 2766.8201566898088, 3089.382123575294, 3300.818454984975, 3373.7301015918915, 3726.8881933541766, 30076.69923300761, 30274.54588181179, 30380.936667216763, 30460.8476957616, 31154.532682009787, 3495.5106285120105, 3526.0, 3527.153483164022, 3548.449990251515, 3650.1604630934767, 259683.9999999981, 259846.0, 260520.0, 262135.0, 263376.0, 58281.12578311329, 58362.70818645965, 59144.40855591389, 65240.34759652438, 67767.66116169388, 62438.375616244164, 62632.37367626266, 62685.0, 62773.372266276754, 62789.05816412757, 16442.506724798277, 16444.506664800076, 16631.66736665284, 16650.83349166493, 16706.58233544171, 12456.439460224312, 12469.625911222678, 12508.624741257778, 12560.497580096693, 12619.053570982029, 20041.098150583257, 20316.0, 20370.898145509178, 20570.38288851337, 20576.176952921716, 7959.363250940027, 8209.220124088202, 8251.381146414044, 8286.70996515119, 8350.958245208856, 916.812053529025, 928.8467402878584, 966.1111777165025, 985.9901400986042, 1030.2891005206384, 28282.43435131327, 28333.291667708472, 28545.0, 28814.0, 29106.854465727534, 1028.218553899042, 1040.9375437473775, 1067.2102644043352, 1138.93166410014, 1146.2606618730872, 14138.575842724735, 14386.640333991734, 14496.0, 15690.0, 15920.283587238602, 310922.0, 312846.0, 313920.0, 318662.0, 318905.0, 54328.728356358755, 54376.45623543714, 54401.45598544043, 54523.45476545184, 54564.454355455935, 1377.0842389810864, 1380.1236215003546, 1380.2339701465783, 1383.3014327764415, 1487.0334282716321, 28574.42851142924, 29353.41293174082, 29574.556381654722, 29657.70342296636, 29968.85015574908, 47204.52795472139, 47304.52695473001, 47709.5229047719, 47753.0, 47781.76109119432, 319523.0, 320199.0, 320275.0, 320423.0, 321952.0, 31428.37143257168, 32906.50640240446, 33221.0, 33339.66660333366, 33423.16442088967, 40557.0, 42673.146537069704, 43139.764517660675, 43644.127117458105, 44888.8377836553, 36517.53929842883, 37239.813800930824, 37242.62757372392, 37489.25021499609, 38189.618103818604, 36977.815110924275, 37145.74949259141, 37264.25471490609, 37452.25095498129, 37501.81249093737, 35698.28603427865, 35731.0, 36110.0, 36218.0, 36238.63761362353, 31119.844400777853, 31525.738970440925, 32496.675033249365, 32676.183095421853, 33189.83405082959, 24781.0, 24840.25479235626, 24958.62562061607, 25046.874765626057, 25299.620505692797], "prototype.html": [331.63023229099554, 334.3346739987426, 335.0768632417689, 340.56577863224385, 341.03147062342947, 6259.311475737665, 6292.119103325533, 6336.936630633692, 6368.363163683635, 6372.585781924177, 6175.197224360838, 6292.653904035276, 6296.590721603093, 6309.842253943653, 6326.588771729835, 4751.263554149095, 4775.068861571995, 4789.0, 4813.542713442235, 4826.927596086052, 4801.0, 4805.231163013918, 4815.205491093965, 4821.325014497973, 4836.564709176174, 4700.694454860423, 4787.784549695255, 4790.993891282835, 4790.993891282835, 4798.880027999293, 4757.928631070519, 4767.523247675222, 4768.761561921908, 4772.045590881838, 4781.976090119562, 4127.030147915238, 4135.937960930589, 4140.0270936329935, 4154.584541545852, 4160.063985603245, 5904.232449781543, 5971.19388882504, 5979.910301345483, 5988.251468566429, 5997.730102145414, 5447.673139611636, 5560.833175004756, 5568.3596386415675, 5584.832455026356, 5599.468050535193, 6642.867142657168, 6680.799576012728, 6693.966530167318, 6698.497612679069, 6725.562838415536, 4596.49438561758, 4600.125976064571, 4601.884952876205, 4604.861854144381, 4614.584687378152, 6835.453163746938, 6966.268541803139, 7019.8596028079155, 7020.1575810902505, 7032.12098487689, 4664.696794708333, 4700.576948074621, 4702.811887524529, 4708.717476951394, 4711.882202944886, 4769.117713223065, 4781.282807578891, 4787.4494433140635, 4789.832355867528, 4795.904081918342, 5535.833924982257, 5536.889262214733, 5539.224508568804, 5545.306836645419, 5545.667259964334, 6676.399124078759, 6695.933040669628, 6809.148856392951, 6811.761588344384, 6812.761553345609, 1618.2717777000396, 1657.3701993242732, 1660.095248089794, 1660.9501714948572, 1673.6903672820324, 1080.8486811846349, 1086.8532748079067, 1093.688298834844, 1102.443266150589, 1105.2429086076063, 6359.586626869239, 6386.10594516768, 6421.325760795049, 6436.710348034349, 6438.45273151778, 6826.0, 6827.48793840464, 6829.7268109276065, 6843.0, 6846.110005699227, 6323.9051414228825, 6363.745450181941, 6409.294977552466, 6409.743610255631, 6470.9029364559565, 3798.7910664913143, 3835.0987517933263, 3838.9808050960123, 3847.249786291646, 3849.8652547160714, 7283.162436319785, 7290.4167666586545, 7301.707931682779, 7311.232320606367, 7312.049433573601, 7090.361867431956, 7252.3835473984245, 7263.455240856957, 7269.527480713737, 7283.817904552428, 7266.0, 7274.127104747358, 7280.708771649181, 7283.963580182171, 7284.745033923788, 7007.579545227302, 7027.824304392431, 7033.859322813618, 7036.572382528019, 7036.683349249399, 6733.797986060426, 6920.792376228721, 6971.407430368476, 6977.79066628002, 7012.509124361246, 7236.38490728273, 7268.0914885639295, 7320.341169294789, 7325.890111648223, 7330.157031941395, 4604.5165257648805, 4635.605973492291, 4649.023705021983, 4662.696924699883, 4664.3469914211355, 6817.352351526597, 6869.347411995853, 6937.7224911002995, 7035.261297563887, 7045.189803172496, 6805.3875151236625, 6838.5213035089055, 6848.075509806312, 6850.0752398425575, 6854.177498700188, 6717.966410167918, 6797.422219111431, 6816.863662726817, 6820.147481564804, 6835.829104272234, 6554.14796076507, 6695.0626912231355, 6713.6643167842385, 6716.29478904708, 6721.059051732664, 6841.350071743176, 6886.035954966409, 6890.069840571659, 6903.75836845708, 6920.30796920304, 6623.0, 6647.800565983028, 6679.899801503078, 6700.966495167493, 6708.262091170065], "yui.html": [687.0, 741.5106030020186, 773.7369294439893, 780.1574299756264, 787.232448362846, 13475.258860762655, 13680.0, 13752.449902003907, 13780.173189608618, 13811.240381778998, 12271.386430678474, 12354.567590134347, 14570.271486425663, 14668.339924703387, 14678.339474723636, 804.8470790549806, 816.3999460396633, 817.7383237364046, 819.7991492084448, 826.8801023851538, 791.9049714034323, 791.9524828510279, 791.9643616037264, 794.0669713087128, 819.5205804604284, 829.2122483640566, 830.862907620245, 832.2883934236202, 840.4117118017413, 858.1675774498726, 822.6627082895984, 823.7199352220244, 823.7569916874536, 826.9586520673972, 865.7575878753959, 602.1449541650866, 620.664840985867, 633.9936600634027, 635.0918186992599, 635.3424205946823, 13523.526676566273, 13617.455301787917, 13662.590122296248, 13690.041697081208, 13700.0, 10104.191664666809, 10243.641472548425, 10451.895481045169, 10902.454877256105, 11456.65630031092, 10017.0, 10030.548625311878, 10128.949355253177, 10348.527600047648, 10554.155667546578, 3261.478163493853, 3292.539044533767, 3314.254292784128, 3335.7331413486863, 3400.7449441291756, 46334.0, 46561.53438465606, 46694.29958550625, 46761.76619116917, 46865.0, 7862.135165131831, 7940.761777146695, 7946.960265198637, 7970.880436793453, 7971.920280797234, 12790.488380464678, 12794.42425090873, 12805.871941280655, 12859.099863009687, 12866.806997895039, 6646.534742567974, 6807.421369183576, 6827.931720682829, 6860.382565569123, 7016.684249208798, 4354.869353919387, 4508.549145085531, 4531.048479819209, 4554.88612784683, 4571.5428457154685, 2935.5156399193893, 3001.3397052648384, 3005.4890668585954, 3011.337505748732, 3013.382256637384, 472.0417552368697, 476.9117713223065, 480.2124515794101, 486.7541891344848, 495.8735522441754, 667.3160010988776, 669.6350488983516, 684.1824020295799, 692.536000879412, 727.7380143148463, 8877.866831997526, 8967.282617390592, 9118.544072796334, 9127.77180570491, 9197.264218862474, 600.5675913342386, 694.6075467361026, 707.9221285658573, 713.3116542536477, 726.4152357352276, 3787.3750831113107, 4129.215449064668, 4132.235536425771, 4149.834006639761, 4181.268278051329, 54925.45074549203, 59406.0, 59781.70109149513, 59871.0, 60337.69831150816, 47672.56982290537, 48457.0, 48778.75610621924, 52478.47521524812, 53082.46917530775, 47461.52538474571, 47769.76115119402, 48265.75867120642, 48387.0, 49165.50834491681, 8364.53995030255, 8499.95750021246, 8820.941487021599, 8864.468131912106, 8917.10828917103, 35633.64366356303, 37446.812765935996, 37846.0, 38530.2293954125, 38990.80504597459, 41642.0, 44581.33128003018, 44804.32793508035, 47188.29217561808, 47252.763736182475, 8297.917020829957, 8368.079511253878, 8433.87349189775, 8469.915300846913, 8478.321734261368, 11893.940530297294, 11896.643100706993, 11937.940310298392, 12013.279203247834, 12025.45885435175, 11130.443477826238, 11204.271722338022, 11230.157738169833, 11316.60391886313, 11396.031337336088, 10759.731006724582, 10828.13374929988, 11015.889841101487, 11317.660470185907, 11683.240589361665, 10845.891541084487, 11096.389698566334, 11194.944025279821, 11233.775324493628, 11495.080393568662, 9616.843702579454, 9904.603815847573, 9916.950415247878, 10017.69946901594, 10059.849102263326, 9075.954620226856, 9642.517874106126, 9647.276454265817, 9647.517624118625, 9742.75643108928]}, "summary": {"lowerIsBetter": false, "suite": 6849.468520646914, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7143.492741300936, "unit": "ms", "value": 7143.492741300936}, "dojo.html": {"lowerIsBetter": false, "filtered": 5542.770185769333, "unit": "ms", "value": 5542.770185769333}, "mootools.html": {"lowerIsBetter": false, "filtered": 4487.708576084916, "unit": "ms", "value": 4487.708576084916}, "ext.html": {"lowerIsBetter": false, "filtered": 18799.414440929926, "unit": "ms", "value": 18799.414440929926}, "prototype.html": {"lowerIsBetter": false, "filtered": 5053.371023150353, "unit": "ms", "value": 5053.371023150353}, "yui.html": {"lowerIsBetter": false, "filtered": 6116.712731378139, "unit": "ms", "value": 6116.712731378139}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-026.e"}, "testrun": {"date": 1447760858, "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": "20151117013036", "branch": "Firefox", "revision": "e61e64f29a004f9a3042810a093b24dabbf56731"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 163.0, 164.0, 162.0, 161.0, 163.0, 164.0, 165.0, 167.0, 163.0], "ai-astar": [110.0, 106.0, 111.0, 110.0, 111.0, 123.0, 111.0, 112.0, 113.0, 110.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "audio-beat-detection": [150.0, 133.0, 155.0, 169.0, 134.0, 155.0, 153.0, 126.0, 158.0, 126.0], "json-stringify-tinderbox": [69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 69.0], "stanford-crypto-pbkdf2": [140.0, 155.0, 150.0, 150.0, 139.0, 148.0, 152.0, 148.0, 148.0, 139.0], "json-parse-financial": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 59.0, 61.0, 63.0, 60.0], "stanford-crypto-sha256-iterative": [69.0, 70.0, 69.0, 67.0, 66.0, 68.0, 66.0, 68.0, 66.0, 67.0], "audio-fft": [73.0, 74.0, 73.0, 73.0, 72.0, 73.0, 132.0, 71.0, 72.0, 72.0], "imaging-darkroom": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "stanford-crypto-ccm": [124.0, 122.0, 121.0, 122.0, 126.0, 126.0, 120.0, 116.0, 120.0, 127.0], "audio-oscillator": [91.0, 90.0, 130.0, 89.0, 89.0, 91.0, 144.0, 90.0, 91.0, 132.0], "stanford-crypto-aes": [84.0, 88.0, 86.0, 85.0, 86.0, 85.0, 87.0, 86.0, 87.0, 85.0], "imaging-desaturate": [97.0, 96.0, 96.0, 97.0, 97.0, 98.0, 96.0, 97.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1509.5000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.5, "unit": "ms", "value": 78.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.9, "unit": "ms", "value": 146.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.9, "unit": "ms", "value": 145.9}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 122.4, "unit": "ms", "value": 122.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.4, "unit": "ms", "value": 146.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 60.9, "unit": "ms", "value": 60.9}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.7, "unit": "ms", "value": 103.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.7, "unit": "ms", "value": 111.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.6, "unit": "ms", "value": 163.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.6, "unit": "ms", "value": 67.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.5, "unit": "ms", "value": 69.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.9, "unit": "ms", "value": 109.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.9, "unit": "ms", "value": 85.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.6, "unit": "ms", "value": 96.6}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-026.e"}, "testrun": {"date": 1447760858, "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": "20151117013036", "branch": "Firefox", "revision": "e61e64f29a004f9a3042810a093b24dabbf56731"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.90174630589138], "Encrypt": [280.1120448179272], "NavierStokes": [4826.923076923077], "Decrypt": [5025.125628140703], "Splay": [650.1950585175553], "Richards": [162.39038648911983], "RegExp": [25769.23076923077], "Earley": [719.626168224299], "Boyer": [12000.0], "RayTrace": [1048.2180293501049]}, "summary": {"lowerIsBetter": false, "suite": 21320.38517774824, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.54089799999997, "unit": "score", "value": 344.54089799999997}, "Encrypt": {"lowerIsBetter": false, "filtered": 950.2661699999999, "unit": "score", "value": 950.2661699999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.4422310756973, "unit": "score", "value": 307.4422310756973}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.970019, "unit": "score", "value": 52.970019}, "Splay": {"lowerIsBetter": false, "filtered": 125.33315799999995, "unit": "score", "value": 125.33315799999995}, "RegExp": {"lowerIsBetter": false, "filtered": 35.3516567164179, "unit": "score", "value": 35.3516567164179}, "Richards": {"lowerIsBetter": false, "filtered": 217.38971600000008, "unit": "score", "value": 217.38971600000008}, "Earley": {"lowerIsBetter": false, "filtered": 926.1239090909096, "unit": "score", "value": 926.1239090909096}, "Boyer": {"lowerIsBetter": false, "filtered": 55.53858333333334, "unit": "score", "value": 55.53858333333334}, "RayTrace": {"lowerIsBetter": false, "filtered": 705.9495059999997, "unit": "score", "value": 705.9495059999997}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-026.e"}, "testrun": {"date": 1447760858, "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": "20151117013036", "branch": "Firefox", "revision": "e61e64f29a004f9a3042810a093b24dabbf56731"}}] 04:07:49 INFO - RETURN: dromaeo_css: 6849.47 04:07:49 INFO - RETURN: kraken: 1509.50 04:07:49 INFO - RETURN: v8_7: 21320.39 04:07:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21320.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1509.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6849.47"}}} 04:07:49 INFO - Return code: 0 04:07:49 INFO - # TBPL SUCCESS # 04:07:49 INFO - Running post-action listener: _resource_record_post_action 04:07:49 INFO - Running post-run listener: _resource_record_post_run 04:07:50 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 8192; Write bytes: 530599936; Read time: 172; Write time: 538560 04:07:50 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 238546944; Read time: 0; Write time: 367420 04:07:50 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288104448; Read time: 160; Write time: 170352 04:07:50 INFO - Running post-run listener: _upload_blobber_files 04:07:50 INFO - Blob upload gear active. 04:07:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:07:50 INFO - Copying logs to upload dir... 04:07:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1260.042485 ========= master_lag: 3.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-17 04:07:54.172293) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 04:07:54.175621) ========= 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=a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009925 build_url: 'https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 04:07:54.199165) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:07:54.199517) ========= 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=a65b340e283ce644d68cb24e000001c9-1447756958.410351-943739106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:07:54.249461) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 04:07:54.249820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 04:07:54.250189) ========= ========= Total master_lag: 4.05 =========