builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1447392815.19 results: success (0) buildid: 20151112193228 builduid: f5ffbcd1ac6340e1bb67efbd2bb20ee8 revision: fcab41a159596b77bd65b4d62ffc9a42aacb5cac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.191358) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.191791) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.192146) ========= 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=61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006685 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.225356) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.225695) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.304168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.304520) ========= 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=61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004676 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.377469) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.377784) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.378217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.378540) ========= 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=61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 21:33:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-11-12 21:33:36 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182492 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.578012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.578378) ========= 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=61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017188 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:35.628613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-12 21:33:35.628998) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fcab41a159596b77bd65b4d62ffc9a42aacb5cac --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fcab41a159596b77bd65b4d62ffc9a42aacb5cac --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=61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 21:33:36,366 truncating revision to first 12 chars 2015-11-12 21:33:36,366 Setting DEBUG logging. 2015-11-12 21:33:36,366 attempt 1/10 2015-11-12 21:33:36,366 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fcab41a15959?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 21:33:37,059 unpacking tar archive at: mozilla-inbound-fcab41a15959/testing/mozharness/ program finished with exit code 0 elapsedTime=0.998006 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-12 21:33:36.644221) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:36.645017) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:36.657531) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:36.658339) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 21:33:36.659457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-12 21:33:36.660283) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:33:37 INFO - MultiFileLogger online at 20151112 21:33:37 in /builds/slave/test-pgo 21:33:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:33:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:33:37 INFO - {'append_to_log': False, 21:33:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:33:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:33:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:33:37 INFO - 'branch': 'Mozilla-Inbound', 21:33:37 INFO - 'buildbot_json_path': 'buildprops.json', 21:33:37 INFO - 'config_files': ('talos/linux_config.py',), 21:33:37 INFO - 'default_actions': ('clobber', 21:33:37 INFO - 'read-buildbot-config', 21:33:37 INFO - 'download-and-extract', 21:33:37 INFO - 'populate-webroot', 21:33:37 INFO - 'create-virtualenv', 21:33:37 INFO - 'install', 21:33:37 INFO - 'run-tests'), 21:33:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:33:37 INFO - 'download_minidump_stackwalk': True, 21:33:37 INFO - 'download_symbols': 'ondemand', 21:33:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:33:37 INFO - 'tooltool.py': '/tools/tooltool.py', 21:33:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:33:37 INFO - '/tools/misc-python/virtualenv.py')}, 21:33:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:33:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:33:37 INFO - 'installer_path': 'installer.exe', 21:33:37 INFO - 'log_level': 'info', 21:33:37 INFO - 'log_name': 'talos', 21:33:37 INFO - 'log_to_console': True, 21:33:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:33:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:33:37 INFO - 'opt_config_files': (), 21:33:37 INFO - 'pip_index': False, 21:33:37 INFO - 'sps_profile': False, 21:33:37 INFO - 'sps_profile_interval': 0, 21:33:37 INFO - 'suite': 'dromaeojs', 21:33:37 INFO - 'system_bits': '64', 21:33:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:33:37 INFO - 'title': 'talos-linux64-ix-045', 21:33:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:33:37 INFO - 'use_talos_json': True, 21:33:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:33:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:33:37 INFO - 'work_dir': 'build'} 21:33:37 INFO - ##### 21:33:37 INFO - ##### Running clobber step. 21:33:37 INFO - ##### 21:33:37 INFO - Running pre-action listener: _resource_record_pre_action 21:33:37 INFO - Running main action method: clobber 21:33:37 INFO - rmtree: /builds/slave/test-pgo/build 21:33:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:33:37 INFO - Running post-action listener: _resource_record_post_action 21:33:37 INFO - ##### 21:33:37 INFO - ##### Running read-buildbot-config step. 21:33:37 INFO - ##### 21:33:37 INFO - Running pre-action listener: _resource_record_pre_action 21:33:37 INFO - Running main action method: read_buildbot_config 21:33:37 INFO - Using buildbot properties: 21:33:37 INFO - { 21:33:37 INFO - "properties": { 21:33:37 INFO - "buildnumber": 1241, 21:33:37 INFO - "product": "firefox", 21:33:37 INFO - "script_repo_revision": "production", 21:33:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:33:37 INFO - "repository": "", 21:33:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:33:37 INFO - "buildid": "20151112193228", 21:33:37 INFO - "slavename": "talos-linux64-ix-045", 21:33:37 INFO - "pgo_build": "True", 21:33:37 INFO - "basedir": "/builds/slave/test-pgo", 21:33:37 INFO - "project": "", 21:33:37 INFO - "platform": "ubuntu64_hw", 21:33:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:33:37 INFO - "slavebuilddir": "test", 21:33:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:33:37 INFO - "branch": "mozilla-inbound", 21:33:37 INFO - "repo_path": "integration/mozilla-inbound", 21:33:37 INFO - "stage_platform": "linux64-pgo", 21:33:37 INFO - "builduid": "f5ffbcd1ac6340e1bb67efbd2bb20ee8", 21:33:37 INFO - "revision": "fcab41a159596b77bd65b4d62ffc9a42aacb5cac" 21:33:37 INFO - }, 21:33:37 INFO - "sourcestamp": { 21:33:37 INFO - "repository": "", 21:33:37 INFO - "hasPatch": false, 21:33:37 INFO - "project": "", 21:33:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 21:33:37 INFO - "changes": [ 21:33:37 INFO - { 21:33:37 INFO - "category": null, 21:33:37 INFO - "files": [ 21:33:37 INFO - { 21:33:37 INFO - "url": null, 21:33:37 INFO - "name": "https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:33:37 INFO - } 21:33:37 INFO - ], 21:33:37 INFO - "repository": "", 21:33:37 INFO - "rev": "fcab41a159596b77bd65b4d62ffc9a42aacb5cac", 21:33:37 INFO - "who": "sendchange", 21:33:37 INFO - "when": 1447392782, 21:33:37 INFO - "number": 6656323, 21:33:37 INFO - "comments": "", 21:33:37 INFO - "project": "", 21:33:37 INFO - "at": "Thu 12 Nov 2015 21:33:02", 21:33:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 21:33:37 INFO - "revlink": "", 21:33:37 INFO - "properties": [ 21:33:37 INFO - [ 21:33:37 INFO - "buildid", 21:33:37 INFO - "20151112193228", 21:33:37 INFO - "Change" 21:33:37 INFO - ], 21:33:37 INFO - [ 21:33:37 INFO - "builduid", 21:33:37 INFO - "f5ffbcd1ac6340e1bb67efbd2bb20ee8", 21:33:37 INFO - "Change" 21:33:37 INFO - ], 21:33:37 INFO - [ 21:33:37 INFO - "pgo_build", 21:33:37 INFO - "True", 21:33:37 INFO - "Change" 21:33:37 INFO - ] 21:33:37 INFO - ], 21:33:37 INFO - "revision": "fcab41a159596b77bd65b4d62ffc9a42aacb5cac" 21:33:37 INFO - } 21:33:37 INFO - ], 21:33:37 INFO - "revision": "fcab41a159596b77bd65b4d62ffc9a42aacb5cac" 21:33:37 INFO - } 21:33:37 INFO - } 21:33:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:33:37 INFO - Running post-action listener: _resource_record_post_action 21:33:37 INFO - ##### 21:33:37 INFO - ##### Running download-and-extract step. 21:33:37 INFO - ##### 21:33:37 INFO - Running pre-action listener: _resource_record_pre_action 21:33:37 INFO - Running main action method: download_and_extract 21:33:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:33:37 INFO - https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:33:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/test_packages.json 21:33:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/test_packages.json 21:33:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:33:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:33:40 INFO - Downloaded 1302 bytes. 21:33:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:33:40 INFO - Using the following test package requirements: 21:33:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:33:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:33:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:40 INFO - u'jsshell-linux-x86_64.zip'], 21:33:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:33:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:33:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:33:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:33:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:33:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:33:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:33:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:33:40 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')]} 21:33:40 INFO - https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:33:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:33:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:33:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/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 21:33:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/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 21:33:56 INFO - Downloaded 22443749 bytes. 21:33:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:33:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:33:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:33:57 INFO - Return code: 0 21:33:57 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 21:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:33:57 INFO - https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:33:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:33:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:33:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/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 21:33:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/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 21:33:59 INFO - Downloaded 22443749 bytes. 21:33:59 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 21:33:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:33:59 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 21:34:00 INFO - Return code: 0 21:34:00 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')]} 21:34:00 INFO - https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:34:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:34:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:34:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/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 21:34:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/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 21:34:01 INFO - Downloaded 11131693 bytes. 21:34:01 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 21:34:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:34:01 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 21:34:01 INFO - Return code: 0 21:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:01 INFO - https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:34:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:34:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:34:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/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 21:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bD0VolE1S1S7EfD3vfQP4g/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 21:34:04 INFO - Downloaded 57168124 bytes. 21:34:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:34:04 INFO - mkdir: /builds/slave/test-pgo/properties 21:34:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:34:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:34:04 INFO - Contents: 21:34:04 INFO - build_url:https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:34:04 INFO - Running post-action listener: _resource_record_post_action 21:34:04 INFO - Running post-action listener: set_extra_try_arguments 21:34:04 INFO - ##### 21:34:04 INFO - ##### Running populate-webroot step. 21:34:04 INFO - ##### 21:34:04 INFO - Running pre-action listener: _resource_record_pre_action 21:34:04 INFO - Running main action method: populate_webroot 21:34:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:34:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:34:04 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:34:04 INFO - '../fennec_ids.txt'], 21:34:04 INFO - 'tests': ['tcheck2']}, 21:34:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:34:04 INFO - '--tppagecycles', 21:34:04 INFO - '7'], 21:34:04 INFO - 'tests': ['tsvgm']}}, 21:34:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:34:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:34:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:34:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:34:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:34:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:34:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:04 INFO - 'talos_options': ['--e10s'], 21:34:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:04 INFO - 'tests': ['damp', 'tps']}, 21:34:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:04 INFO - 'talos_options': ['--e10s'], 21:34:04 INFO - 'tests': ['damp', 'tps']}, 21:34:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:34:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:34:04 INFO - 'other': {'tests': ['a11yr', 21:34:04 INFO - 'ts_paint', 21:34:04 INFO - 'tpaint', 21:34:04 INFO - 'sessionrestore', 21:34:04 INFO - 'sessionrestore_no_auto_restore']}, 21:34:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:34:04 INFO - 'tests': ['a11yr', 21:34:04 INFO - 'ts_paint', 21:34:04 INFO - 'tpaint', 21:34:04 INFO - 'sessionrestore', 21:34:04 INFO - 'sessionrestore_no_auto_restore']}, 21:34:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:34:04 INFO - 'tests': ['a11yr', 21:34:04 INFO - 'ts_paint', 21:34:04 INFO - 'tpaint', 21:34:04 INFO - 'sessionrestore', 21:34:04 INFO - 'sessionrestore_no_auto_restore']}, 21:34:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:34:04 INFO - 'tests': ['a11yr', 21:34:04 INFO - 'ts_paint', 21:34:04 INFO - 'tpaint', 21:34:04 INFO - 'sessionrestore', 21:34:04 INFO - 'sessionrestore_no_auto_restore']}, 21:34:04 INFO - 'other_l64': {'tests': ['a11yr', 21:34:04 INFO - 'ts_paint', 21:34:04 INFO - 'tpaint', 21:34:04 INFO - 'sessionrestore', 21:34:04 INFO - 'sessionrestore_no_auto_restore']}, 21:34:04 INFO - 'other_nol64': {'tests': ['a11yr', 21:34:04 INFO - 'ts_paint', 21:34:04 INFO - 'tpaint', 21:34:04 INFO - 'sessionrestore', 21:34:04 INFO - 'sessionrestore_no_auto_restore']}, 21:34:04 INFO - 'svgr': {'tests': ['tsvgx', 21:34:04 INFO - 'tsvgr_opacity', 21:34:04 INFO - 'tart', 21:34:04 INFO - 'tscrollx', 21:34:04 INFO - 'cart']}, 21:34:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:34:04 INFO - 'tests': ['tsvgx', 21:34:04 INFO - 'tsvgr_opacity', 21:34:04 INFO - 'tart', 21:34:04 INFO - 'tscrollx', 21:34:04 INFO - 'cart']}, 21:34:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:04 INFO - 'tests': ['tp5o']}, 21:34:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:04 INFO - 'talos_options': ['--e10s'], 21:34:04 INFO - 'tests': ['tp5o']}, 21:34:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:04 INFO - 'talos_options': ['--xperf_path', 21:34:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:04 INFO - 'tests': ['tp5n']}, 21:34:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:04 INFO - 'talos_options': ['--e10s', 21:34:04 INFO - '--xperf_path', 21:34:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:04 INFO - 'tests': ['tp5n']}}, 21:34:04 INFO - 'talos.zip': {'path': '', 21:34:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:34:04 INFO - Running post-action listener: _resource_record_post_action 21:34:04 INFO - ##### 21:34:04 INFO - ##### Running create-virtualenv step. 21:34:04 INFO - ##### 21:34:04 INFO - Running pre-action listener: _resource_record_pre_action 21:34:04 INFO - Running main action method: create_virtualenv 21:34:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:34:04 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 21:34:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:34:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:34:04 INFO - Using real prefix '/usr' 21:34:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:34:05 INFO - Installing distribute.............................................................................................................................................................................................done. 21:34:07 INFO - Installing pip.................done. 21:34:07 INFO - Return code: 0 21:34:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb645ee6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a90>, '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 0x2443f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24442e0>, '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': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', '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 21:34:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:34:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:34:07 INFO - Using env: {'DISPLAY': ':0', 21:34:07 INFO - 'HOME': '/home/cltbld', 21:34:07 INFO - 'LANG': 'en_US.UTF-8', 21:34:07 INFO - 'LANGUAGE': 'en_US:en', 21:34:07 INFO - 'LOGNAME': 'cltbld', 21:34:07 INFO - 'MAIL': '/var/mail/cltbld', 21:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:07 INFO - 'MOZ_NO_REMOTE': '1', 21:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:07 INFO - 'NO_EM_RESTART': '1', 21:34:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:07 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:07 INFO - 'SHELL': '/bin/bash', 21:34:07 INFO - 'SHLVL': '1', 21:34:07 INFO - 'TERM': 'linux', 21:34:07 INFO - 'TMOUT': '86400', 21:34:07 INFO - 'USER': 'cltbld', 21:34:07 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', 21:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:07 INFO - '_': '/tools/buildbot/bin/python'} 21:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:07 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 21:34:07 INFO - Cleaning up... 21:34:07 INFO - Return code: 0 21:34:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb645ee6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a90>, '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 0x2443f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24442e0>, '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': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', '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 21:34:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:34:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:34:07 INFO - Using env: {'DISPLAY': ':0', 21:34:07 INFO - 'HOME': '/home/cltbld', 21:34:07 INFO - 'LANG': 'en_US.UTF-8', 21:34:07 INFO - 'LANGUAGE': 'en_US:en', 21:34:07 INFO - 'LOGNAME': 'cltbld', 21:34:07 INFO - 'MAIL': '/var/mail/cltbld', 21:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:07 INFO - 'MOZ_NO_REMOTE': '1', 21:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:07 INFO - 'NO_EM_RESTART': '1', 21:34:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:07 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:07 INFO - 'SHELL': '/bin/bash', 21:34:07 INFO - 'SHLVL': '1', 21:34:07 INFO - 'TERM': 'linux', 21:34:07 INFO - 'TMOUT': '86400', 21:34:07 INFO - 'USER': 'cltbld', 21:34:07 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', 21:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:07 INFO - '_': '/tools/buildbot/bin/python'} 21:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:07 INFO - Downloading/unpacking psutil>=0.7.1 21:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:34:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:34:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:34:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:09 INFO - Installing collected packages: psutil 21:34:09 INFO - Running setup.py install for psutil 21:34:09 INFO - building 'psutil._psutil_linux' extension 21:34:09 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 21:34:09 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 21:34:09 INFO - building 'psutil._psutil_posix' extension 21:34:09 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 21:34:10 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 21:34:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:10 INFO - Successfully installed psutil 21:34:10 INFO - Cleaning up... 21:34:10 INFO - Return code: 0 21:34:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:10 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 0x7fb645ee6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a90>, '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 0x2443f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24442e0>, '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': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', '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 21:34:10 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 21:34:10 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 21:34:10 INFO - Using env: {'DISPLAY': ':0', 21:34:10 INFO - 'HOME': '/home/cltbld', 21:34:10 INFO - 'LANG': 'en_US.UTF-8', 21:34:10 INFO - 'LANGUAGE': 'en_US:en', 21:34:10 INFO - 'LOGNAME': 'cltbld', 21:34:10 INFO - 'MAIL': '/var/mail/cltbld', 21:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:10 INFO - 'MOZ_NO_REMOTE': '1', 21:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:10 INFO - 'NO_EM_RESTART': '1', 21:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:10 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:10 INFO - 'SHELL': '/bin/bash', 21:34:10 INFO - 'SHLVL': '1', 21:34:10 INFO - 'TERM': 'linux', 21:34:10 INFO - 'TMOUT': '86400', 21:34:10 INFO - 'USER': 'cltbld', 21:34:10 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', 21:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:10 INFO - '_': '/tools/buildbot/bin/python'} 21:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:34:10 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 21:34:10 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 21:34:10 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 21:34:10 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 21:34:10 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 21:34:10 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 21:34:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:34:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:34:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:34:12 INFO - Installing collected packages: mozsystemmonitor 21:34:12 INFO - Running setup.py install for mozsystemmonitor 21:34:12 INFO - Successfully installed mozsystemmonitor 21:34:12 INFO - Cleaning up... 21:34:12 INFO - Return code: 0 21:34:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:34:12 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')]} 21:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:12 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')]} 21:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:12 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 0x7fb645ee6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a90>, '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 0x2443f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24442e0>, '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': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', '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 21:34:12 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 21:34:12 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 21:34:12 INFO - Using env: {'DISPLAY': ':0', 21:34:12 INFO - 'HOME': '/home/cltbld', 21:34:12 INFO - 'LANG': 'en_US.UTF-8', 21:34:12 INFO - 'LANGUAGE': 'en_US:en', 21:34:12 INFO - 'LOGNAME': 'cltbld', 21:34:12 INFO - 'MAIL': '/var/mail/cltbld', 21:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:12 INFO - 'MOZ_NO_REMOTE': '1', 21:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:12 INFO - 'NO_EM_RESTART': '1', 21:34:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:12 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:12 INFO - 'SHELL': '/bin/bash', 21:34:12 INFO - 'SHLVL': '1', 21:34:12 INFO - 'TERM': 'linux', 21:34:12 INFO - 'TMOUT': '86400', 21:34:12 INFO - 'USER': 'cltbld', 21:34:12 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', 21:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:12 INFO - '_': '/tools/buildbot/bin/python'} 21:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:12 INFO - Downloading/unpacking blobuploader==1.2.4 21:34:12 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 21:34:12 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 21:34:12 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 21:34:12 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 21:34:12 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 21:34:12 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 21:34:14 INFO - Downloading blobuploader-1.2.4.tar.gz 21:34:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:34:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:34:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:34:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:34:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 INFO - Downloading docopt-0.6.1.tar.gz 21:34:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:34:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:34:14 INFO - Installing collected packages: blobuploader, requests, docopt 21:34:14 INFO - Running setup.py install for blobuploader 21:34:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:34:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:34:14 INFO - Running setup.py install for requests 21:34:15 INFO - Running setup.py install for docopt 21:34:15 INFO - Successfully installed blobuploader requests docopt 21:34:15 INFO - Cleaning up... 21:34:15 INFO - Return code: 0 21:34:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:34:15 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')]} 21:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:15 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')]} 21:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:15 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 0x7fb645ee6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a90>, '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 0x2443f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24442e0>, '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': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', '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 21:34:15 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 21:34:15 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 21:34:15 INFO - Using env: {'DISPLAY': ':0', 21:34:15 INFO - 'HOME': '/home/cltbld', 21:34:15 INFO - 'LANG': 'en_US.UTF-8', 21:34:15 INFO - 'LANGUAGE': 'en_US:en', 21:34:15 INFO - 'LOGNAME': 'cltbld', 21:34:15 INFO - 'MAIL': '/var/mail/cltbld', 21:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:15 INFO - 'MOZ_NO_REMOTE': '1', 21:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:15 INFO - 'NO_EM_RESTART': '1', 21:34:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:15 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:15 INFO - 'SHELL': '/bin/bash', 21:34:15 INFO - 'SHLVL': '1', 21:34:15 INFO - 'TERM': 'linux', 21:34:15 INFO - 'TMOUT': '86400', 21:34:15 INFO - 'USER': 'cltbld', 21:34:15 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', 21:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:15 INFO - '_': '/tools/buildbot/bin/python'} 21:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:34:15 INFO - Running setup.py (path:/tmp/pip-j9ZsWi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:34:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:34:15 INFO - Running setup.py (path:/tmp/pip-O5FQQI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:34:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:34:15 INFO - Running setup.py (path:/tmp/pip-P5aGwI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:34:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:34:15 INFO - Running setup.py (path:/tmp/pip-hcmDe_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:34:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:34:15 INFO - Running setup.py (path:/tmp/pip-0S7DXZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:34:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:34:16 INFO - Running setup.py (path:/tmp/pip-9HT3hy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:34:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:34:16 INFO - Running setup.py (path:/tmp/pip-2_73Co-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:34:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:34:16 INFO - Running setup.py (path:/tmp/pip-7SFhmp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:34:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:34:16 INFO - Running setup.py (path:/tmp/pip-G9DsgD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:34:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:34:16 INFO - Running setup.py (path:/tmp/pip-zdJ9gK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:34:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:34:16 INFO - Running setup.py (path:/tmp/pip-g8__eF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:34:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:34:16 INFO - Running setup.py (path:/tmp/pip-SwLNZs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:34:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:34:16 INFO - Running setup.py (path:/tmp/pip-dhJoyo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:34:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:34:16 INFO - Running setup.py (path:/tmp/pip-VFtBvH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:34:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:34:16 INFO - Running setup.py (path:/tmp/pip-feuP5n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:34:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:34:16 INFO - Running setup.py (path:/tmp/pip-R3RZyw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:34:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:34:16 INFO - Running setup.py (path:/tmp/pip-jrUzmp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:34:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:34:16 INFO - Running setup.py install for manifestparser 21:34:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:34:16 INFO - Running setup.py install for mozcrash 21:34:17 INFO - Running setup.py install for mozdebug 21:34:17 INFO - Running setup.py install for mozdevice 21:34:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:34:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:34:17 INFO - Running setup.py install for mozfile 21:34:17 INFO - Running setup.py install for mozhttpd 21:34:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:34:17 INFO - Running setup.py install for mozinfo 21:34:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:34:17 INFO - Running setup.py install for mozInstall 21:34:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:34:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:34:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:34:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:34:17 INFO - Running setup.py install for mozleak 21:34:17 INFO - Running setup.py install for mozlog 21:34:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:34:17 INFO - Running setup.py install for moznetwork 21:34:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:34:18 INFO - Running setup.py install for mozprocess 21:34:18 INFO - Running setup.py install for mozprofile 21:34:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:34:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:34:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:34:18 INFO - Running setup.py install for mozrunner 21:34:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:34:18 INFO - Running setup.py install for mozscreenshot 21:34:18 INFO - Running setup.py install for moztest 21:34:18 INFO - Running setup.py install for mozversion 21:34:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:34:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:34:18 INFO - Cleaning up... 21:34:18 INFO - Return code: 0 21:34:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:34:18 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')]} 21:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:18 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')]} 21:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:18 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 0x7fb645ee6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a90>, '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 0x2443f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24442e0>, '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': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', '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 21:34:18 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 21:34:18 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 21:34:18 INFO - Using env: {'DISPLAY': ':0', 21:34:18 INFO - 'HOME': '/home/cltbld', 21:34:18 INFO - 'LANG': 'en_US.UTF-8', 21:34:18 INFO - 'LANGUAGE': 'en_US:en', 21:34:18 INFO - 'LOGNAME': 'cltbld', 21:34:18 INFO - 'MAIL': '/var/mail/cltbld', 21:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:18 INFO - 'MOZ_NO_REMOTE': '1', 21:34:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:18 INFO - 'NO_EM_RESTART': '1', 21:34:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:18 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:18 INFO - 'SHELL': '/bin/bash', 21:34:18 INFO - 'SHLVL': '1', 21:34:18 INFO - 'TERM': 'linux', 21:34:18 INFO - 'TMOUT': '86400', 21:34:18 INFO - 'USER': 'cltbld', 21:34:18 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', 21:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:18 INFO - '_': '/tools/buildbot/bin/python'} 21:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:34:18 INFO - Running setup.py (path:/tmp/pip-sIglCI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:34:18 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)) 21:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:34:18 INFO - Running setup.py (path:/tmp/pip-hLRLYi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:34:19 INFO - Running setup.py (path:/tmp/pip-2e2ycU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:34:19 INFO - Running setup.py (path:/tmp/pip-vkxp7J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:34:19 INFO - Running setup.py (path:/tmp/pip-kKZGeh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:34:19 INFO - Running setup.py (path:/tmp/pip-Rm9ZS5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:34:19 INFO - Running setup.py (path:/tmp/pip-LqxBDu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:34:19 INFO - Running setup.py (path:/tmp/pip-e1fmHD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:34:19 INFO - Running setup.py (path:/tmp/pip-kHYCrz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:34:19 INFO - Running setup.py (path:/tmp/pip-dLinSY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:34:19 INFO - Running setup.py (path:/tmp/pip-qZBd6B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:34:19 INFO - Running setup.py (path:/tmp/pip-J2jssq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:34:19 INFO - Running setup.py (path:/tmp/pip-DqdYUe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:34:19 INFO - Running setup.py (path:/tmp/pip-THluYm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:34:19 INFO - Running setup.py (path:/tmp/pip-pcfdaW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:34:19 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)) 21:34:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:34:19 INFO - Running setup.py (path:/tmp/pip-WD7Sbq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:34:20 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)) 21:34:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:34:20 INFO - Running setup.py (path:/tmp/pip-aOQnhY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:34:20 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)) 21:34:20 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)) 21:34:20 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)) 21:34:20 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)) 21:34:20 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)) 21:34:20 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)) 21:34:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:34:20 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 21:34:20 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 21:34:20 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 21:34:20 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 21:34:20 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 21:34:20 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 21:34:21 INFO - Downloading blessings-1.5.1.tar.gz 21:34:21 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 21:34:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:34:21 INFO - Installing collected packages: blessings 21:34:21 INFO - Running setup.py install for blessings 21:34:21 INFO - Successfully installed blessings 21:34:21 INFO - Cleaning up... 21:34:22 INFO - Return code: 0 21:34:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:34:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:34:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:34:22 INFO - Reading from file tmpfile_stdout 21:34:22 INFO - Current package versions: 21:34:22 INFO - argparse == 1.2.1 21:34:22 INFO - blessings == 1.5.1 21:34:22 INFO - blobuploader == 1.2.4 21:34:22 INFO - docopt == 0.6.1 21:34:22 INFO - manifestparser == 1.1 21:34:22 INFO - mozInstall == 1.12 21:34:22 INFO - mozcrash == 0.16 21:34:22 INFO - mozdebug == 0.1 21:34:22 INFO - mozdevice == 0.47 21:34:22 INFO - mozfile == 1.2 21:34:22 INFO - mozhttpd == 0.7 21:34:22 INFO - mozinfo == 0.9 21:34:22 INFO - mozleak == 0.1 21:34:22 INFO - mozlog == 3.0 21:34:22 INFO - moznetwork == 0.27 21:34:22 INFO - mozprocess == 0.22 21:34:22 INFO - mozprofile == 0.27 21:34:22 INFO - mozrunner == 6.11 21:34:22 INFO - mozscreenshot == 0.1 21:34:22 INFO - mozsystemmonitor == 0.0 21:34:22 INFO - moztest == 0.7 21:34:22 INFO - mozversion == 1.4 21:34:22 INFO - psutil == 3.1.1 21:34:22 INFO - requests == 1.2.3 21:34:22 INFO - wsgiref == 0.1.2 21:34:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:34:22 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')]} 21:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:22 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')]} 21:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:22 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 0x7fb645ee6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a90>, '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 0x2443f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24442e0>, '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': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', '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 21:34:22 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 21:34:22 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 21:34:22 INFO - Using env: {'DISPLAY': ':0', 21:34:22 INFO - 'HOME': '/home/cltbld', 21:34:22 INFO - 'LANG': 'en_US.UTF-8', 21:34:22 INFO - 'LANGUAGE': 'en_US:en', 21:34:22 INFO - 'LOGNAME': 'cltbld', 21:34:22 INFO - 'MAIL': '/var/mail/cltbld', 21:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:22 INFO - 'MOZ_NO_REMOTE': '1', 21:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:22 INFO - 'NO_EM_RESTART': '1', 21:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:22 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:22 INFO - 'SHELL': '/bin/bash', 21:34:22 INFO - 'SHLVL': '1', 21:34:22 INFO - 'TERM': 'linux', 21:34:22 INFO - 'TMOUT': '86400', 21:34:22 INFO - 'USER': 'cltbld', 21:34:22 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', 21:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:22 INFO - '_': '/tools/buildbot/bin/python'} 21:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:22 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)) 21:34:22 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)) 21:34:22 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)) 21:34:22 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)) 21:34:22 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)) 21:34:22 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)) 21:34:22 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)) 21:34:22 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)) 21:34:22 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)) 21:34:22 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)) 21:34:22 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)) 21:34:22 INFO - Cleaning up... 21:34:22 INFO - Return code: 0 21:34:22 INFO - Running post-action listener: _resource_record_post_action 21:34:22 INFO - Running post-action listener: _start_resource_monitoring 21:34:22 INFO - Starting resource monitoring. 21:34:22 INFO - ##### 21:34:22 INFO - ##### Running install step. 21:34:22 INFO - ##### 21:34:22 INFO - Running pre-action listener: _resource_record_pre_action 21:34:22 INFO - Running main action method: install 21:34:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:34:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:34:22 INFO - Reading from file tmpfile_stdout 21:34:22 INFO - Detecting whether we're running mozinstall >=1.0... 21:34:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:34:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:34:22 INFO - Reading from file tmpfile_stdout 21:34:22 INFO - Output received: 21:34:22 INFO - Usage: mozinstall [options] installer 21:34:22 INFO - Options: 21:34:22 INFO - -h, --help show this help message and exit 21:34:22 INFO - -d DEST, --destination=DEST 21:34:22 INFO - Directory to install application into. [default: 21:34:22 INFO - "/builds/slave/test-pgo"] 21:34:22 INFO - --app=APP Application being installed. [default: firefox] 21:34:22 INFO - mkdir: /builds/slave/test-pgo/build/application 21:34:22 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'] 21:34:22 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 21:34:37 INFO - Reading from file tmpfile_stdout 21:34:37 INFO - Output received: 21:34:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:34:37 INFO - Running post-action listener: _resource_record_post_action 21:34:37 INFO - ##### 21:34:37 INFO - ##### Running run-tests step. 21:34:37 INFO - ##### 21:34:37 INFO - Running pre-action listener: _resource_record_pre_action 21:34:37 INFO - Running main action method: run_tests 21:34:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:34:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:34:37 INFO - Python 2.7.3 21:34:37 INFO - Return code: 0 21:34:37 INFO - grabbing minidump binary from tooltool 21:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:37 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 0x23f1a90>, '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 0x2443f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24442e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:34:37 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 21:34:37 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 21:34:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:34:37 INFO - Return code: 0 21:34:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:34:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:34:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:34:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:34:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:34:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 21:34:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost 21:34:37 INFO - Using env: {'DISPLAY': ':0', 21:34:37 INFO - 'HOME': '/home/cltbld', 21:34:37 INFO - 'LANG': 'en_US.UTF-8', 21:34:37 INFO - 'LANGUAGE': 'en_US:en', 21:34:37 INFO - 'LOGNAME': 'cltbld', 21:34:37 INFO - 'MAIL': '/var/mail/cltbld', 21:34:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:34:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:37 INFO - 'MOZ_NO_REMOTE': '1', 21:34:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:34:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:37 INFO - 'NO_EM_RESTART': '1', 21:34:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:37 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:34:37 INFO - 'SHELL': '/bin/bash', 21:34:37 INFO - 'SHLVL': '1', 21:34:37 INFO - 'TERM': 'linux', 21:34:37 INFO - 'TMOUT': '86400', 21:34:37 INFO - 'USER': 'cltbld', 21:34:37 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972', 21:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:37 INFO - '_': '/tools/buildbot/bin/python'} 21:34:37 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] with output_timeout 3600 21:34:37 INFO - mozversion INFO | application_buildid: 20151112193228 21:34:37 INFO - mozversion INFO | application_changeset: fcab41a159596b77bd65b4d62ffc9a42aacb5cac 21:34:37 INFO - mozversion INFO | application_display_name: Nightly 21:34:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:34:37 INFO - mozversion INFO | application_name: Firefox 21:34:37 INFO - mozversion INFO | application_remotingname: firefox 21:34:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:34:37 INFO - mozversion INFO | application_vendor: Mozilla 21:34:37 INFO - mozversion INFO | application_version: 45.0a1 21:34:37 INFO - mozversion INFO | platform_buildid: 20151112193228 21:34:37 INFO - mozversion INFO | platform_changeset: fcab41a159596b77bd65b4d62ffc9a42aacb5cac 21:34:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:34:37 INFO - mozversion INFO | platform_version: 45.0a1 21:34:37 INFO - 2015-11-12 21:34:37,393 DEBUG : using testdate: 1447392877 21:34:37 INFO - 2015-11-12 21:34:37,393 DEBUG : actual date: 1447392877 21:34:37 INFO - 2015-11-12 21:34:37,402 INFO : starting webserver on 'localhost:59972' 21:34:37 INFO - 2015-11-12 21:34:37,403 INFO : Starting test suite talos-linux64-ix-045 21:34:37 INFO - 2015-11-12 21:34:37,403 INFO : Starting test dromaeo_css 21:34:37 INFO - 2015-11-12 21:34:37,404 DEBUG : operating with platform_type : linux_ 21:34:37 INFO - 2015-11-12 21:34:37,404 INFO : Initialising browser for dromaeo_css test... 21:34:37 INFO - 2015-11-12 21:34:37,413 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv1Ypds/profile http://localhost:59972/getInfo.html 21:34:41 INFO - 2015-11-12 21:34:41,611 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:34:41 INFO - 2015-11-12 21:34:41,611 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:34:41 INFO - 2015-11-12 21:34:41,611 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:34:41 INFO - 2015-11-12 21:34:41,611 DEBUG : BROWSER_OUTPUT: __metrics 21:34:41 INFO - 2015-11-12 21:34:41,776 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:34:43 INFO - 2015-11-12 21:34:43,084 INFO : Browser initialized. 21:34:43 INFO - 2015-11-12 21:34:43,084 INFO : Running cycle 1/1 for dromaeo_css test... 21:34:43 INFO - 2015-11-12 21:34:43,085 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv1Ypds/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:34:54 INFO - 2015-11-12 21:34:54,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 140611584 21:34:54 INFO - 2015-11-12 21:34:54,826 DEBUG : BROWSER_OUTPUT: 21:35:46 INFO - 2015-11-12 21:35:46,276 DEBUG : BROWSER_OUTPUT: 1447392946275 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] 21:37:54 INFO - 2015-11-12 21:37:54,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59972/tests/dromaeo/cssquery-ext.html) 21:37:55 INFO - 2015-11-12 21:37:55,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 240549888 21:37:55 INFO - 2015-11-12 21:37:55,752 DEBUG : BROWSER_OUTPUT: 21:40:58 INFO - 2015-11-12 21:40:58,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/dromaeo/cssquery-ext.html (next: http://localhost:59972/tests/dromaeo/cssquery-jquery.html) 21:40:58 INFO - 2015-11-12 21:40:58,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 215797760 21:40:58 INFO - 2015-11-12 21:40:58,713 DEBUG : BROWSER_OUTPUT: 21:44:00 INFO - 2015-11-12 21:44:00,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59972/tests/dromaeo/cssquery-mootools.html) 21:44:01 INFO - 2015-11-12 21:44:01,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 214806528 21:44:01 INFO - 2015-11-12 21:44:01,151 DEBUG : BROWSER_OUTPUT: 21:47:02 INFO - 2015-11-12 21:47:02,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59972/tests/dromaeo/cssquery-prototype.html) 21:47:03 INFO - 2015-11-12 21:47:03,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 200626176 21:47:03 INFO - 2015-11-12 21:47:03,567 DEBUG : BROWSER_OUTPUT: 21:50:05 INFO - 2015-11-12 21:50:05,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59972/tests/dromaeo/cssquery-yui.html) 21:50:06 INFO - 2015-11-12 21:50:06,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 204095488 21:50:06 INFO - 2015-11-12 21:50:06,468 DEBUG : BROWSER_OUTPUT: 21:53:09 INFO - 2015-11-12 21:53:09,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/dromaeo/cssquery-yui.html (next: http://localhost:59972/tests/dromaeo/cssquery-dojo.html) 21:53:09 INFO - 2015-11-12 21:53:09,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 241233920 21:53:09 INFO - 2015-11-12 21:53:09,261 DEBUG : BROWSER_OUTPUT: 21:53:09 INFO - 2015-11-12 21:53:09,261 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:53:09 INFO - 2015-11-12 21:53:09,261 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:53:09 INFO - 2015-11-12 21:53:09,261 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:53:09 INFO - 2015-11-12 21:53:09,261 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:53:09 INFO - 2015-11-12 21:53:09,262 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3197.8401079946;3246.529253258279;3292.868285268588;3302.537644729738;3316.3864685033273;5240.397354304256;5347.973260133694;5448.37343705474;5452.591055670826;5468.835934921954;5414.8917021659545;5448.37343705474;5452.6183167178315;5495.313085864267;5567.109262517998;4884.731339776311;4891.657583969123;4905.730184839832;4957.405111386621;5013.498650134994;4827.227643577028;5046.21783623539;5056.924146137792;5109.770060347293;5132.6407151499225;4864.489228630996;4911.680740751875;4937.284093806414;4945.35710357653;4964.925526117111;4920.286558449041;4946.530079642428;4986.177280748709;4998.6750861193905;5018.2974383586325;4815.374001379833;4944.851654450372;4949.950500494985;4967.40391153064;5008.974955125237;5161.5354618084175;5250.474952504757;5265.052290587692;5285.709285989269;5289.68261904287;5909.556783241274;5912.76348946046;5920.585559010871;5925.081612350093;5931.851703707399;5716.056850619642;5768.97115514424;5837.3287071986415;5958.314793798725;5962.075878238837;5541.362743284493;5550.72246387679;5558.722063896829;5561.694106824123;5607.046802043662;6006.5495087868585;6017.308009578867;6041.124037014608;6052.425019623129;6090;5695.430456954271;5759.366469688331;5832.300123985149;5844.035734103825;5909.527237820964;5919.348871624118;5922.555808314393;5938.49522790559;5941.970290148522;5947.821565353046;5878.882422351529;5906.379830117776;5907.261592300963;5909.970450147808;5919.141724449931;5545.140503222007;5672.688002159921;5742.885142297131;5853.385394533598;5888.646681199141;4509.458864936229;4531.660125490535;4533.818647254073;4535.591796738244;4569.702969306984;3917;4032.334664780337;4034.65705415043;4040.1313717550865;4064.6748260139116;5473.397926228112;5493.478119578634;5509.3664228613425;5515.696636684941;5562.916556251659;5877.941220587825;5894.646321220741;5899.823005309848;5902.409759024149;5906;5368.141097424394;5450.618456708072;5555.444455554493;5560.054790685593;5563.805266815642;4922.237053256751;5029.874253143701;5034.0686972910125;5034.295198672189;5062.392512898476;6188.566800324024;6191.00943848991;6196.752129914843;6202.596831206048;6205.317415084337;5721.342045664802;5811.157382179645;5837.416258374129;5929.347771745191;5932.733027013881;6073.453389194994;6111.144439778345;6119.510439164767;6132.5707200495535;6143.016005401305;5844.298684157929;5852.5317974561085;5853.268341457318;5865.794697185578;5902.468777810018;5698.373178950395;5701.429857014431;5825.563082768894;5883.529317654663;5925.348211696796;5744.569157313134;5790.449907258803;5791.478766910998;5791.623544469596;5803.82588522345;5768.625039372428;5771.7114144293455;5773.566982476247;5774.94225057744;5776.19133321327;5457;5514.420985796433;5564.33228012641;5627.971860140673;5632.9436705632415;5803.82588522345;5809.302883653989;5835.67903765297;5841.211436456024;5887.146363777314;5479.205515200194;5708.628939118944;5713.485786279255;5715.31416230055;5729.799457018984 21:53:09 INFO - 2015-11-12 21:53:09,263 DEBUG : BROWSER_OUTPUT: |1;ext.html;587.6709042935956;590.8050343386683;596.3082823924246;596.4095545410046;621.6239175298944;30911.227219319528;38796.806015969916;39098.8045059775;39100.21799564007;39172.21655566891;42392;42850.142997140036;42907.57092429075;42949.57050429495;42963.57036429635;7591.089069311691;7704.537727736326;8656.653733850639;8818.603162857687;10142.746431339201;10379.636712715057;10515.579376824919;10516.21128415368;10519.368837869752;10520.842187367196;10454.790904181911;10527.105196058345;10556.947215263952;10562.947185264102;10571.471426428649;7696.230376962315;7877.212278772135;10522.736931576695;10769.83845242322;10786.406747628876;10338.224633152544;10421.114205292559;10422;10476.3190392625;10477.528511216937;39427.60572394268;39780.20439591221;39812;39920.20159596792;39921.60078399237;3146.858391372371;3157.447446696842;3329.3840639481773;3637.381645120336;3667.743257971916;29209.561856572167;29369.706302937124;29767.404651907058;29839.25401864949;29910.700892991226;3190.8564114614896;3214.9839250803598;3251.170951407376;3253.9511907321407;3340.3294788531784;285257;286895;286902;287902;288321.9999999979;52509.737451312496;53409.465905341225;54164.72917635387;54713;55202;58037.41962580405;58050.419495804505;58305.708471458216;58327.708361457924;58365;13612.31938403076;13727.176369417866;13777.380017899219;13780.379882905294;13781.655458613413;10235.078842904175;10274.537645805807;10315.226358023177;10331.845022324671;10346;19153;19167;19176.424707258804;19270.80729192718;19369.806301936802;7893.526388416713;8040.195980401913;8123.634436450374;8148.470349427268;8214.671413143527;983.9163671088038;994.472929347447;1014.1835822163082;1025.3642741500319;1115.682030621269;25691.48617027649;26261.606075908876;26634.46731065368;28050;29244.7075529242;967.4437198610827;1010.6715317521835;1012.5038731021747;1015.761296095417;1020.6223697232072;13569.457221711218;15058.774118388234;15287.923560382127;15386.538403847902;15439.845601544066;324107;329507;330020;330347;330531;52805;52879.471205288224;53122.73438632859;53137.46862531325;53174.734126329124;1327.9136856104321;1349.2646507653549;1353.0325817040864;1354.9051566390456;1453;23922.40193995164;26695.733042669326;27699.723002769715;28108.578371324038;28980.565291521067;47080;47388.52611473979;47403;47417.52582474269;47493.76253118712;260841;261215;262172;262273;262613;27061;27529.174124776287;32413.675863241067;32763;32815;39068.6093139065;39658.40512392374;40053.39919901145;40148.598514015655;40329.79835100806;34023.65976340304;34369.65630343665;34459.4831077529;34568;34803.477947830295;32265.677343226267;34254.82872585621;35518.822405887804;36312.63687363092;36420.45369319515;34220.65779342175;34829.825850870584;34907.65092349044;35231.82384088063;35233.471497927036;30848;31661.683383165873;32217.194570135933;32229;32556.674433255364;24445.51108977846;24469.51060978806;24939.875300623382;24959.376015599755;24990.500189995735 21:53:09 INFO - 2015-11-12 21:53:09,264 DEBUG : BROWSER_OUTPUT: |2;jquery.html;348.8796365253987;349.19336333070606;350.08976660682214;351.4780550881941;353.126013117534;13877.236751978637;14132.152070875729;16749.497515074552;17414.477565673034;18596.349127780515;15236.314365853535;15799.28903199356;15886.36454541817;16890.15549222537;16933;5172.250023746564;5306.655067420625;5311.840644780663;5313.149896016638;5313.707746073965;3978.0452691354158;4075.042365044212;5334.626576139672;5360.973195134019;5711.114777209539;5769.16347129666;5777.104548794943;5791.160281759142;5795.15970184323;5806.622569532988;5582.553395728332;5639.8590035249445;5699.857503562403;5708.628939118965;5767.653940763546;4926.507349265081;4938.456769755324;4938.678985865943;4950.4801995790285;4962.528559786814;15201.239938003055;15272.847271527366;16333.59166020847;17032.148392580322;20211.494712632302;1965.8722183058198;2040.8775473471492;2050.159434631809;2079.688046792993;2258.4692597239637;12492.312922789242;12596.370181490889;13003.154794938393;13045.347732613427;13378.866211337956;1754.7192449208064;1767.938122165718;1849.7317888906168;1858.2288350334595;1895.0051223107841;58006.41993580052;59406;59450.10824837631;59519;60735.08897366543;8934.73195804127;8997.460152390877;9273.72178834636;9288.164065234027;9300.20948219409;12743.936280318725;12760.425780839885;12767.93616031914;12788.552400665933;12790.29653369055;7127.073480447612;7148.249433809479;7166.175889772639;7175.96412017947;7217.061781968416;6880.2431732509385;6882.174139103339;6892.551984121016;6904.102466679299;6924.861502769916;5814.244148260784;5821.38875418075;5853.180554722342;5876.676782776988;5924.081767326072;1528.4497580870877;1583.8812089093365;1598.4165779490402;1640.4012535424483;1710.7091794394983;822.983540329202;915.3089417489753;983.3165949664914;1016.7407311135613;1019.6635110413546;17311;17925.7311140333;18158.364457243933;18209.544761380806;18345.54136146607;786.6578038553248;888.3293113699116;922.9953850230706;942.1567696911363;1008.9949550252202;5768.74040668171;6271.592346497463;6303.590266632654;6324.588901721373;6331.366863313632;530917;534314;550452;551423;551822;75142;76629;77052;78500.60749696215;79816;480.6731422632574;487.04782150894914;487.12074705157534;487.2277440257161;488.3919520197306;9876.654317098866;10186.185105191715;10274.075333220046;10787.838182427113;11041.558337666404;33125.17187070342;33479.33041339208;33641.495377569845;35363.646363536034;36234.818825906754;42771.35842962296;45423.318650220936;47087;47355.052898942515;47392.28911566398;6359.236891573041;6427.292997770335;6469.5794773339585;6472.385123413268;6481.222253329631;12020.75958480843;12112.152149349813;12235.327057011593;12316.953058990086;12374.690632734253;9007.954960225157;9226.815463690555;10141.746456338355;10491.94754026225;10830.458477075957;10198;10289.74275643115;10296.227782916461;10592.987332406818;10908.509117089592;10582.312149710244;10595.311304765166;10665.57337706514;10698.518566664363;10926.890731092588;6337.493000560036;6665.933340666531;6669.599824010575;6681.1314529110905;6705.865882682417;10307.845382319421;10347.689569312932;10434;10561;10661.147108231478 21:53:09 INFO - 2015-11-12 21:53:09,268 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1545.2428310128041;1690.5351028467173;1725.3961113610237;1731.290171029878;1767.7260024696168;6425.421712045915;7594.848103037936;7717.382609391249;7731.188225236354;7734.806629834257;7531.4351423643175;7615.124260710006;7621.58081305528;7622.123455802571;7628.694852205919;1938.176275083084;1976.0811222781404;2198.7251593550805;2213.601551720694;2236.6756820261053;2268.3648578398074;2283.817294616427;2285.2801367569245;2293.747687754346;2294.736105347881;2184.0936011555186;2211.1487077475126;2212.811910987568;2214.070090561968;2217.756046834847;1949.171602069122;1963.6465436221474;2185.7704940981125;2237.4853783629856;2242.85421447607;2209.304069218191;2251.3696165073807;2275.2036787124375;2278.6695929090356;2279.3162051384684;7481.513701609378;7538.208488108725;7563;7565.735199268054;7567.281108294703;4396.934045989313;4474.731516109044;4478.664100192466;4488.349189367524;4491.4161159049445;2926.75122614578;2929.4287613915294;2970.7029297070335;2971.9405611887855;3057.143999680093;903.1781079217881;915.8031023330016;918.0865039285886;921.0559176843722;932.2309094996588;10067.29528932975;10211.744706382326;10264.076233138978;10266.230032747499;10278.280520363578;3999.120193557471;4065.6747460203114;4093.7748423836974;4175.874723758292;4180.28935081037;8823.911760882438;8829.911700883038;8835.469871807712;8855.247303979233;8862.246709029676;4470.038941627566;4514.774261286922;4540.88647783808;4542.591166795004;4544.318352247189;4082.530508991504;4092.9795351023054;4095.0990782027907;4110.609492098306;4116.69124815634;3317.3033662931057;3402.8808991685173;3429;3434.055634700477;3436;1118.8713297970676;1131.2590253383883;1137.806572882612;1140.1391949078559;1144.9141314401286;958.2956526952685;1280.3406245783428;1309.9869001309864;1317.4861803896488;1318.1102755639904;7152.249013853574;7177.354038136593;7180.958760979629;7184.245654206337;7204.351608355273;437.18683249156544;438.3381094547193;442.09370789880614;443.0872402850139;444.22926223003066;5432.674039557639;5494.587905907073;5509.421510741315;5513.979913715975;5515.145152501369;9055;9058.682946096855;9245.352825302165;9297.953510232406;9305.348625596143;8964.775880602907;9015.81968360629;9051.909480905106;9074.500902450296;9114.680986165453;6948.6178260195165;7042.119735033121;7086.681099350541;7183.245759195313;7227.3134052263895;7195.964020179866;7252.129744430491;7260.927390726025;7261.3101755333155;7268.0914885639295;8157.3881958852135;8199.79500512468;8258.29804466603;8263.462874913112;8378.49729016261;8303.169683031649;8529.14708529142;8621.8706719398;8649.870251946351;8655.95672021661;6931.653417329214;6980;7039.9296007039275;7182.8563428730085;7243.20324764286;7125.964370178116;7310.744123955636;7320.377767889576;7347.632618369167;7365;6691.631960242234;6995.405390541861;7004.194517630538;7006.824829379307;7203.747868824566;6232.345603711545;6402.135711678864;6788.389044985975;6817.7272909083085;7014.754483593049;6701.497387695845;6726.730930762715;6739.629320387229;6742.190937087385;6751.122354093936;6345.904811427925;6377.93622063792;6378.234611846423;6389.393007664265;6411.4229719325485;6503.057056726842;6522.412982831568;6542.44389226902;6558;6561.573497722633 21:53:09 INFO - 2015-11-12 21:53:09,269 DEBUG : BROWSER_OUTPUT: |4;prototype.html;308.52025100967995;312.481281073418;316.81624657698535;317.52054397859223;319.5717738230773;5870.5597080218995;5957.344692083872;5962.522998160153;6005.939940600592;6041.516678665707;5951.196588460556;5951.226340575719;5952.196453478779;5954.315253745821;5990.161377407167;4506.504284528699;4510.030343476152;4511.142882852264;4513.932291015637;4514.345419914111;4376.868693939171;4400.669949753766;4498.482674492426;4522.819087236507;4526.592606665416;4402.031553058322;4404.075144219718;4405.779711014453;4410.889727756816;4415.22733521634;4372.715773474714;4374.934375984363;4385.561443855605;4391.780410979438;4401.955980440187;3770.9622903770887;3773.8867833965023;3780.6408391203067;3786.659200671925;3794.5067141271456;5497.065498865202;5586.748596313176;5589.329280486327;5591.496765291103;5596.104623260299;5139.049275883974;5147.897042059138;5149.845504634867;5150.381954165487;5155.896882062375;6297.748090076391;6304.810855674337;6308.2430108386825;6309;6310.368963103699;4203.894902627429;4223.113146239262;4228.513720922103;4234.17433600448;4237.364395340693;6168.84577885552;6375.139356186948;6418.486521078303;6610.338966103399;6623.933760662379;4304.354346847936;4339.609435150852;4344.47866256045;4348.347747837786;4349.456317960255;4391.297392417198;4394.099209662011;4395.1868904252815;4396.758178300161;4398;4976.402831660152;5048.520390562964;5082.161443361804;5169.017886601534;5171.069207542603;6419.711112999927;6422.4862011039;6422.550421470546;6436.8390790230615;6437.324080971524;1556.7353549896545;1577.8501042400953;1589.7297459431925;1593.0362130910864;1594.2905407093963;1039.1219419590434;1039.6776999130293;1054.6835949215206;1065.3341661461586;1066.0299127793671;6213.751449942042;6231.3145553989025;6233.719482623293;6235.064740288993;6237.656928868865;6603.075569420285;6615.76844810439;6621.139251897319;6622.867542649216;6623.4038936495945;6065.090236464565;6211.0372892201785;6214.353196402957;6215.564910456315;6225.128482012522;3563.3585954527916;3584.408572585546;3593.317269718745;3593.9640603594153;3603.747737658391;6799.932000680029;6852.965735171292;6863.622500762406;6864.725410983505;6871.896921546181;6580.40776330123;6691.0967019451755;6708.1950165979415;6715.664216789141;6716.429103526255;6872.62200578963;6872.656367181621;6875.140607424072;6875.724971001204;6877.3810357067105;6607.240167380813;6612.537122401386;6612.669366531751;6615.636140012345;6620.966895165493;6389.584676995981;6486.708098135501;6534.575252608565;6539.149910511603;6551.344865513411;6845.726170953305;6848;6853.451723861979;6856.108705868404;6861.451083913175;4370.104128653555;4387.23223435891;4411.558844115562;4412.691111622155;4416.227160247008;6339.366063393623;6473.158489396348;6569.605823650596;6576.112224849775;6576.704048317742;6264.686765661608;6389.9041514376395;6426;6447.6453795041725;6459.806205813833;6373.426391624776;6409.775657851953;6413.422791948747;6418.1656384669695;6423.03654451836;6175.876482470415;6292.590981586182;6302.495800336053;6321.11504389395;6337.35228840514;6476.967615161894;6484.740610375532;6489.123968264413;6490.643014634241;6491.123698300669;6289.40250676185;6324.968375158095;6339.714712838026;6350.110984462087;6353.078803573363 21:53:09 INFO - 2015-11-12 21:53:09,270 DEBUG : BROWSER_OUTPUT: |5;yui.html;757.1822431773685;841.0874201491382;854.9487030778158;859.9871001934972;865.333693056347;12781.616551503446;13191.2744799036;13200.141990770606;13246.139000964955;13305.800412993813;11425.485853136608;11427.657170284883;11447.59933402331;11487.540498380076;11502.712432189179;655.020743987739;791.639803889229;805.0741647105846;805.9516429014278;806.7136166660839;662.1259936883316;788.1527358090076;804.9718259860906;806.2018601584418;806.701520437439;824;837.2004735477605;837.6314421654453;838.325148255654;838.8993320801482;691.6230654293397;697.616311028932;821.9054808697017;830.5058490198322;832.8084540555676;617.4844005255617;617.6325086573481;618.298231507238;619.2321521313584;619.5074915442234;13284.402201900937;13546.119502232323;13559.728805423836;13604.86395136046;13611.047226694136;11122.221444498888;12272.386380681019;12273.938630306791;12290.938545307215;12398.19411738243;8815.725401731173;8908.554572271361;8939.955300223522;8967.910320896774;9019.368644194908;3515.191505953645;3572.356975744365;3608.819559022065;3610.891673249807;3614.8915532534065;44930.550694492966;45109.54890451086;45519.772401138114;46592.53407465916;46782.29826552571;7410.851782964418;7446.813829654194;7462.253774622494;7524.322810947041;7714.845703085907;11802.937735603837;11822.290662560274;11831.053515718722;11864;11870.28778273289;6116.113163591254;6285.214348206474;6290.559660823698;6382.617042977344;6396.328385519547;3979.403089536535;4041.818118184689;4083.71414001023;4096.774677392712;4127.504699436087;2649.668791401075;2677.6251324814543;2678;2678.450917561895;2685.7985651076247;409.69068353393;410.36803322883026;414.241937254823;418.53751604476616;419.1512187819629;615.7321565119188;618.7370367593754;663.3300366629738;667.6695035957232;686.9622170780555;8010.679572817138;8054.798630034179;8166.918330816735;8181.6318265677;8299.6680132794;482.32715362070417;511.1770050219144;529.6292595183387;531.4127888683026;624.073251221935;3645.434957581579;3663.560372755233;3727.2172843703124;3734.925301494009;4027.154297597537;57304.713476433186;58552.707236463546;58963.41036589579;59156.40843591595;59221.40778592245;50818.491815081376;51576.22635660468;51940.22089668658;52613.210801838;52966.205506917424;46247.76876115598;46630;47001.294980575316;47664.5233547667;47949;7683.864981092307;7692.92307076922;7846;7875.527468351688;7889.723859664884;33269.50095748517;34145;34307.485387718705;34330;35562.82218588891;42795;43782.781086094365;44256.557434425245;45089.77455112703;45216;6818.454523637998;7135.108111486064;7198.172210195895;7232.891506627299;7233.421326293989;10200.642977495752;10340.689779306633;10496.790064198825;10735.570577176826;10822.67531974042;9900.405975641484;9924.1068303853;9939.950300248453;10058.647947321808;10293.639722609672;9667.854982175133;9772.12050915421;9873.605055797687;10163.7459063524;10318.43248621303;8678.696245631372;9654.27592930519;9761.219102471643;9812.411255324703;10403.479826008517;8481.06708262103;8805.383623146317;8980.730578082668;9047.638094476148;9050.321225907952;9009.324300677345;9104.180623743894;9152.405093668891;9153.954230228806;9299.558816239582 21:53:09 INFO - 2015-11-12 21:53:09,270 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:53:09 INFO - 2015-11-12 21:53:09,270 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:53:09 INFO - 2015-11-12 21:53:09,271 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,864 21:53:09 INFO - 2015-11-12 21:53:09,271 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:53:09 INFO - 2015-11-12 21:53:09,271 DEBUG : BROWSER_OUTPUT: __startTimestamp1447393989257__endTimestamp 21:53:09 INFO - 2015-11-12 21:53:09,271 DEBUG : BROWSER_OUTPUT: 21:53:09 INFO - 2015-11-12 21:53:09,271 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:53:09 INFO - 2015-11-12 21:53:09,271 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:53:09 INFO - 2015-11-12 21:53:09,271 DEBUG : BROWSER_OUTPUT: 21:53:09 INFO - 2015-11-12 21:53:09,271 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5450.89 Median:5672.69 stddev:621.44 (11.0%) stddev-sans-first:597.68 21:53:09 INFO - 2015-11-12 21:53:09,271 DEBUG : BROWSER_OUTPUT: Values: 3197.8 3246.5 3292.9 3302.5 3316.4 5240.4 5348.0 5448.4 5452.6 5468.8 5414.9 5448.4 5452.6 5495.3 5567.1 4884.7 4891.7 4905.7 4957.4 5013.5 4827.2 5046.2 5056.9 5109.8 5132.6 4864.5 4911.7 4937.3 4945.4 4964.9 4920.3 4946.5 4986.2 4998.7 5018.3 4815.4 4944.9 4950.0 4967.4 5009.0 5161.5 5250.5 5265.1 5285.7 5289.7 5909.6 5912.8 5920.6 5925.1 5931.9 5716.1 5769.0 5837.3 5958.3 5962.1 5541.4 5550.7 5558.7 5561.7 5607.0 6006.5 6017.3 6041.1 6052.4 6090.0 5695.4 5759.4 5832.3 5844.0 5909.5 5919.3 5922.6 5938.5 5942.0 5947.8 5878.9 5906.4 5907.3 5910.0 5919.1 5545.1 5672.7 5742.9 5853.4 5888.6 4509.5 4531.7 4533.8 4535.6 4569.7 3917.0 4032.3 4034.7 4040.1 4064.7 5473.4 5493.5 5509.4 5515.7 5562.9 5877.9 5894.6 5899.8 5902.4 5906.0 5368.1 5450.6 5555.4 5560.1 5563.8 4922.2 5029.9 5034.1 5034.3 5062.4 6188.6 6191.0 6196.8 6202.6 6205.3 5721.3 5811.2 5837.4 5929.3 5932.7 6073.5 6111.1 6119.5 6132.6 6143.0 5844.3 5852.5 5853.3 5865.8 5902.5 5698.4 5701.4 5825.6 5883.5 5925.3 5744.6 5790.4 5791.5 5791.6 5803.8 5768.6 5771.7 5773.6 5774.9 5776.2 5457.0 5514.4 5564.3 5628.0 5632.9 5803.8 5809.3 5835.7 5841.2 5887.1 5479.2 5708.6 5713.5 5715.3 5729.8 21:53:09 INFO - 2015-11-12 21:53:09,271 DEBUG : BROWSER_OUTPUT: 21:53:09 INFO - 2015-11-12 21:53:09,272 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45890.83 Median:32223.10 stddev:76794.05 (238.3%) stddev-sans-first:76934.15 21:53:09 INFO - 2015-11-12 21:53:09,273 DEBUG : BROWSER_OUTPUT: Values: 587.7 590.8 596.3 596.4 621.6 30911.2 38796.8 39098.8 39100.2 39172.2 42392.0 42850.1 42907.6 42949.6 42963.6 7591.1 7704.5 8656.7 8818.6 10142.7 10379.6 10515.6 10516.2 10519.4 10520.8 10454.8 10527.1 10556.9 10562.9 10571.5 7696.2 7877.2 10522.7 10769.8 10786.4 10338.2 10421.1 10422.0 10476.3 10477.5 39427.6 39780.2 39812.0 39920.2 39921.6 3146.9 3157.4 3329.4 3637.4 3667.7 29209.6 29369.7 29767.4 29839.3 29910.7 3190.9 3215.0 3251.2 3254.0 3340.3 285257.0 286895.0 286902.0 287902.0 288322.0 52509.7 53409.5 54164.7 54713.0 55202.0 58037.4 58050.4 58305.7 58327.7 58365.0 13612.3 13727.2 13777.4 13780.4 13781.7 10235.1 10274.5 10315.2 10331.8 10346.0 19153.0 19167.0 19176.4 19270.8 19369.8 7893.5 8040.2 8123.6 8148.5 8214.7 983.9 994.5 1014.2 1025.4 1115.7 25691.5 26261.6 26634.5 28050.0 29244.7 967.4 1010.7 1012.5 1015.8 1020.6 13569.5 15058.8 15287.9 15386.5 15439.8 324107.0 329507.0 330020.0 330347.0 330531.0 52805.0 52879.5 53122.7 53137.5 53174.7 1327.9 1349.3 1353.0 1354.9 1453.0 23922.4 26695.7 27699.7 28108.6 28980.6 47080.0 47388.5 47403.0 47417.5 47493.8 260841.0 261215.0 262172.0 262273.0 262613.0 27061.0 27529.2 32413.7 32763.0 32815.0 39068.6 39658.4 40053.4 40148.6 40329.8 34023.7 34369.7 34459.5 34568.0 34803.5 32265.7 34254.8 35518.8 36312.6 36420.5 34220.7 34829.8 34907.7 35231.8 35233.5 30848.0 31661.7 32217.2 32229.0 32556.7 24445.5 24469.5 24939.9 24959.4 24990.5 21:53:09 INFO - 2015-11-12 21:53:09,273 DEBUG : BROWSER_OUTPUT: 21:53:09 INFO - 2015-11-12 21:53:09,273 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27808.94 Median:47373.67 stddev:88977.85 (187.8%) stddev-sans-first:89203.56 21:53:09 INFO - 2015-11-12 21:53:09,273 DEBUG : BROWSER_OUTPUT: Values: 348.9 349.2 350.1 351.5 353.1 13877.2 14132.2 16749.5 17414.5 18596.3 15236.3 15799.3 15886.4 16890.2 16933.0 5172.3 5306.7 5311.8 5313.1 5313.7 3978.0 4075.0 5334.6 5361.0 5711.1 5769.2 5777.1 5791.2 5795.2 5806.6 5582.6 5639.9 5699.9 5708.6 5767.7 4926.5 4938.5 4938.7 4950.5 4962.5 15201.2 15272.8 16333.6 17032.1 20211.5 1965.9 2040.9 2050.2 2079.7 2258.5 12492.3 12596.4 13003.2 13045.3 13378.9 1754.7 1767.9 1849.7 1858.2 1895.0 58006.4 59406.0 59450.1 59519.0 60735.1 8934.7 8997.5 9273.7 9288.2 9300.2 12743.9 12760.4 12767.9 12788.6 12790.3 7127.1 7148.2 7166.2 7176.0 7217.1 6880.2 6882.2 6892.6 6904.1 6924.9 5814.2 5821.4 5853.2 5876.7 5924.1 1528.4 1583.9 1598.4 1640.4 1710.7 823.0 915.3 983.3 1016.7 1019.7 17311.0 17925.7 18158.4 18209.5 18345.5 786.7 888.3 923.0 942.2 1009.0 5768.7 6271.6 6303.6 6324.6 6331.4 530917.0 534314.0 550452.0 551423.0 551822.0 75142.0 76629.0 77052.0 78500.6 79816.0 480.7 487.0 487.1 487.2 488.4 9876.7 10186.2 10274.1 10787.8 11041.6 33125.2 33479.3 33641.5 35363.6 36234.8 42771.4 45423.3 47087.0 47355.1 47392.3 6359.2 6427.3 6469.6 6472.4 6481.2 12020.8 12112.2 12235.3 12317.0 12374.7 9008.0 9226.8 10141.7 10491.9 10830.5 10198.0 10289.7 10296.2 10593.0 10908.5 10582.3 10595.3 10665.6 10698.5 10926.9 6337.5 6665.9 6669.6 6681.1 6705.9 10307.8 10347.7 10434.0 10561.0 10661.1 21:53:09 INFO - 2015-11-12 21:53:09,273 DEBUG : BROWSER_OUTPUT: 21:53:09 INFO - 2015-11-12 21:53:09,273 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5314.59 Median:6418.42 stddev:2790.75 (43.5%) stddev-sans-first:2784.21 21:53:09 INFO - 2015-11-12 21:53:09,274 DEBUG : BROWSER_OUTPUT: Values: 1545.2 1690.5 1725.4 1731.3 1767.7 6425.4 7594.8 7717.4 7731.2 7734.8 7531.4 7615.1 7621.6 7622.1 7628.7 1938.2 1976.1 2198.7 2213.6 2236.7 2268.4 2283.8 2285.3 2293.7 2294.7 2184.1 2211.1 2212.8 2214.1 2217.8 1949.2 1963.6 2185.8 2237.5 2242.9 2209.3 2251.4 2275.2 2278.7 2279.3 7481.5 7538.2 7563.0 7565.7 7567.3 4396.9 4474.7 4478.7 4488.3 4491.4 2926.8 2929.4 2970.7 2971.9 3057.1 903.2 915.8 918.1 921.1 932.2 10067.3 10211.7 10264.1 10266.2 10278.3 3999.1 4065.7 4093.8 4175.9 4180.3 8823.9 8829.9 8835.5 8855.2 8862.2 4470.0 4514.8 4540.9 4542.6 4544.3 4082.5 4093.0 4095.1 4110.6 4116.7 3317.3 3402.9 3429.0 3434.1 3436.0 1118.9 1131.3 1137.8 1140.1 1144.9 958.3 1280.3 1310.0 1317.5 1318.1 7152.2 7177.4 7181.0 7184.2 7204.4 437.2 438.3 442.1 443.1 444.2 5432.7 5494.6 5509.4 5514.0 5515.1 9055.0 9058.7 9245.4 9298.0 9305.3 8964.8 9015.8 9051.9 9074.5 9114.7 6948.6 7042.1 7086.7 7183.2 7227.3 7196.0 7252.1 7260.9 7261.3 7268.1 8157.4 8199.8 8258.3 8263.5 8378.5 8303.2 8529.1 8621.9 8649.9 8656.0 6931.7 6980.0 7039.9 7182.9 7243.2 7126.0 7310.7 7320.4 7347.6 7365.0 6691.6 6995.4 7004.2 7006.8 7203.7 6232.3 6402.1 6788.4 6817.7 7014.8 6701.5 6726.7 6739.6 6742.2 6751.1 6345.9 6377.9 6378.2 6389.4 6411.4 6503.1 6522.4 6542.4 6558.0 6561.6 21:53:09 INFO - 2015-11-12 21:53:09,275 DEBUG : BROWSER_OUTPUT: 21:53:09 INFO - 2015-11-12 21:53:09,275 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5282.81 Median:6116.97 stddev:1640.69 (26.8%) stddev-sans-first:1602.25 21:53:09 INFO - 2015-11-12 21:53:09,275 DEBUG : BROWSER_OUTPUT: Values: 308.5 312.5 316.8 317.5 319.6 5870.6 5957.3 5962.5 6005.9 6041.5 5951.2 5951.2 5952.2 5954.3 5990.2 4506.5 4510.0 4511.1 4513.9 4514.3 4376.9 4400.7 4498.5 4522.8 4526.6 4402.0 4404.1 4405.8 4410.9 4415.2 4372.7 4374.9 4385.6 4391.8 4402.0 3771.0 3773.9 3780.6 3786.7 3794.5 5497.1 5586.7 5589.3 5591.5 5596.1 5139.0 5147.9 5149.8 5150.4 5155.9 6297.7 6304.8 6308.2 6309.0 6310.4 4203.9 4223.1 4228.5 4234.2 4237.4 6168.8 6375.1 6418.5 6610.3 6623.9 4304.4 4339.6 4344.5 4348.3 4349.5 4391.3 4394.1 4395.2 4396.8 4398.0 4976.4 5048.5 5082.2 5169.0 5171.1 6419.7 6422.5 6422.6 6436.8 6437.3 1556.7 1577.9 1589.7 1593.0 1594.3 1039.1 1039.7 1054.7 1065.3 1066.0 6213.8 6231.3 6233.7 6235.1 6237.7 6603.1 6615.8 6621.1 6622.9 6623.4 6065.1 6211.0 6214.4 6215.6 6225.1 3563.4 3584.4 3593.3 3594.0 3603.7 6799.9 6853.0 6863.6 6864.7 6871.9 6580.4 6691.1 6708.2 6715.7 6716.4 6872.6 6872.7 6875.1 6875.7 6877.4 6607.2 6612.5 6612.7 6615.6 6621.0 6389.6 6486.7 6534.6 6539.1 6551.3 6845.7 6848.0 6853.5 6856.1 6861.5 4370.1 4387.2 4411.6 4412.7 4416.2 6339.4 6473.2 6569.6 6576.1 6576.7 6264.7 6389.9 6426.0 6447.6 6459.8 6373.4 6409.8 6413.4 6418.2 6423.0 6175.9 6292.6 6302.5 6321.1 6337.4 6477.0 6484.7 6489.1 6490.6 6491.1 6289.4 6325.0 6339.7 6350.1 6353.1 21:53:09 INFO - 2015-11-12 21:53:09,275 DEBUG : BROWSER_OUTPUT: 21:53:09 INFO - 2015-11-12 21:53:09,275 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13010.26 Median:58758.06 stddev:16072.41 (27.4%) stddev-sans-first:16091.16 21:53:09 INFO - 2015-11-12 21:53:09,275 DEBUG : BROWSER_OUTPUT: Values: 757.2 841.1 854.9 860.0 865.3 12781.6 13191.3 13200.1 13246.1 13305.8 11425.5 11427.7 11447.6 11487.5 11502.7 655.0 791.6 805.1 806.0 806.7 662.1 788.2 805.0 806.2 806.7 824.0 837.2 837.6 838.3 838.9 691.6 697.6 821.9 830.5 832.8 617.5 617.6 618.3 619.2 619.5 13284.4 13546.1 13559.7 13604.9 13611.0 11122.2 12272.4 12273.9 12290.9 12398.2 8815.7 8908.6 8940.0 8967.9 9019.4 3515.2 3572.4 3608.8 3610.9 3614.9 44930.6 45109.5 45519.8 46592.5 46782.3 7410.9 7446.8 7462.3 7524.3 7714.8 11802.9 11822.3 11831.1 11864.0 11870.3 6116.1 6285.2 6290.6 6382.6 6396.3 3979.4 4041.8 4083.7 4096.8 4127.5 2649.7 2677.6 2678.0 2678.5 2685.8 409.7 410.4 414.2 418.5 419.2 615.7 618.7 663.3 667.7 687.0 8010.7 8054.8 8166.9 8181.6 8299.7 482.3 511.2 529.6 531.4 624.1 3645.4 3663.6 3727.2 3734.9 4027.2 57304.7 58552.7 58963.4 59156.4 59221.4 50818.5 51576.2 51940.2 52613.2 52966.2 46247.8 46630.0 47001.3 47664.5 47949.0 7683.9 7692.9 7846.0 7875.5 7889.7 33269.5 34145.0 34307.5 34330.0 35562.8 42795.0 43782.8 44256.6 45089.8 45216.0 6818.5 7135.1 7198.2 7232.9 7233.4 10200.6 10340.7 10496.8 10735.6 10822.7 9900.4 9924.1 9940.0 10058.6 10293.6 9667.9 9772.1 9873.6 10163.7 10318.4 8678.7 9654.3 9761.2 9812.4 10403.5 8481.1 8805.4 8980.7 9047.6 9050.3 9009.3 9104.2 9152.4 9154.0 9299.6 21:53:09 INFO - 2015-11-12 21:53:09,275 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:53:09 INFO - 2015-11-12 21:53:09,275 DEBUG : BROWSER_OUTPUT: 21:53:09 INFO - 2015-11-12 21:53:09,953 INFO : Browser exited with error code: 0 21:53:09 INFO - 2015-11-12 21:53:09,974 INFO : Completed test dromaeo_css (00:18:32) 21:53:09 INFO - 2015-11-12 21:53:09,974 INFO : Starting test kraken 21:53:09 INFO - 2015-11-12 21:53:09,974 DEBUG : operating with platform_type : linux_ 21:53:09 INFO - 2015-11-12 21:53:09,975 INFO : Initialising browser for kraken test... 21:53:09 INFO - 2015-11-12 21:53:09,980 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCa1Zuy/profile http://localhost:59972/getInfo.html 21:53:13 INFO - 2015-11-12 21:53:13,779 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:53:13 INFO - 2015-11-12 21:53:13,780 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:53:13 INFO - 2015-11-12 21:53:13,780 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:53:13 INFO - 2015-11-12 21:53:13,780 DEBUG : BROWSER_OUTPUT: __metrics 21:53:13 INFO - 2015-11-12 21:53:13,944 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:53:15 INFO - 2015-11-12 21:53:15,149 INFO : Browser initialized. 21:53:15 INFO - 2015-11-12 21:53:15,150 INFO : Running cycle 1/1 for kraken test... 21:53:15 INFO - 2015-11-12 21:53:15,150 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCa1Zuy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:53:26 INFO - 2015-11-12 21:53:26,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 141492224 21:53:26 INFO - 2015-11-12 21:53:26,914 DEBUG : BROWSER_OUTPUT: 21:53:29 INFO - 2015-11-12 21:53:29,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59972/tests/kraken/driver.html?testName=audio-beat-detection) 21:53:29 INFO - 2015-11-12 21:53:29,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 179400704 21:53:29 INFO - 2015-11-12 21:53:29,943 DEBUG : BROWSER_OUTPUT: 21:53:32 INFO - 2015-11-12 21:53:32,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59972/tests/kraken/driver.html?testName=audio-dft) 21:53:33 INFO - 2015-11-12 21:53:33,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 170139648 21:53:33 INFO - 2015-11-12 21:53:33,111 DEBUG : BROWSER_OUTPUT: 21:53:35 INFO - 2015-11-12 21:53:35,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59972/tests/kraken/driver.html?testName=audio-fft) 21:53:36 INFO - 2015-11-12 21:53:36,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 151248896 21:53:36 INFO - 2015-11-12 21:53:36,536 DEBUG : BROWSER_OUTPUT: 21:53:38 INFO - 2015-11-12 21:53:38,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59972/tests/kraken/driver.html?testName=audio-oscillator) 21:53:39 INFO - 2015-11-12 21:53:39,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 153481216 21:53:39 INFO - 2015-11-12 21:53:39,107 DEBUG : BROWSER_OUTPUT: 21:53:41 INFO - 2015-11-12 21:53:41,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59972/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:53:41 INFO - 2015-11-12 21:53:41,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 155586560 21:53:41 INFO - 2015-11-12 21:53:41,830 DEBUG : BROWSER_OUTPUT: 21:53:44 INFO - 2015-11-12 21:53:44,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59972/tests/kraken/driver.html?testName=imaging-darkroom) 21:53:45 INFO - 2015-11-12 21:53:45,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 156020736 21:53:45 INFO - 2015-11-12 21:53:45,362 DEBUG : BROWSER_OUTPUT: 21:53:48 INFO - 2015-11-12 21:53:48,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59972/tests/kraken/driver.html?testName=imaging-desaturate) 21:53:49 INFO - 2015-11-12 21:53:49,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 155975680 21:53:49 INFO - 2015-11-12 21:53:49,349 DEBUG : BROWSER_OUTPUT: 21:53:52 INFO - 2015-11-12 21:53:52,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59972/tests/kraken/driver.html?testName=json-parse-financial) 21:53:52 INFO - 2015-11-12 21:53:52,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 156504064 21:53:52 INFO - 2015-11-12 21:53:52,685 DEBUG : BROWSER_OUTPUT: 21:53:54 INFO - 2015-11-12 21:53:54,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59972/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:53:54 INFO - 2015-11-12 21:53:54,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 163872768 21:53:54 INFO - 2015-11-12 21:53:54,815 DEBUG : BROWSER_OUTPUT: 21:53:56 INFO - 2015-11-12 21:53:56,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59972/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:53:57 INFO - 2015-11-12 21:53:57,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 163147776 21:53:57 INFO - 2015-11-12 21:53:57,192 DEBUG : BROWSER_OUTPUT: 21:53:59 INFO - 2015-11-12 21:53:59,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59972/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:53:59 INFO - 2015-11-12 21:53:59,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 178716672 21:53:59 INFO - 2015-11-12 21:53:59,831 DEBUG : BROWSER_OUTPUT: 21:54:02 INFO - 2015-11-12 21:54:02,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:54:02 INFO - 2015-11-12 21:54:02,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 180609024 21:54:02 INFO - 2015-11-12 21:54:02,823 DEBUG : BROWSER_OUTPUT: 21:54:05 INFO - 2015-11-12 21:54:05,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:54:05 INFO - 2015-11-12 21:54:05,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 180584448 21:54:05 INFO - 2015-11-12 21:54:05,917 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59972/tests/kraken/driver.html?testName=ai-astar) 21:54:07 INFO - 2015-11-12 21:54:07,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 240623616 21:54:07 INFO - 2015-11-12 21:54:07,825 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,827 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:54:07 INFO - 2015-11-12 21:54:07,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:54:07 INFO - 2015-11-12 21:54:07,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:54:07 INFO - 2015-11-12 21:54:07,827 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:54:07 INFO - 2015-11-12 21:54:07,828 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;104;111;110;112;101;110;113;111 21:54:07 INFO - 2015-11-12 21:54:07,828 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;128;149;163;127;149;147;125;169;126 21:54:07 INFO - 2015-11-12 21:54:07,828 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;161;160;160;161;162;160;160 21:54:07 INFO - 2015-11-12 21:54:07,828 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;80;91;72;71;71;96;92;72 21:54:07 INFO - 2015-11-12 21:54:07,828 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;133;90;91;91;137;91;91;138 21:54:07 INFO - 2015-11-12 21:54:07,828 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;110;110;109;109;109 21:54:07 INFO - 2015-11-12 21:54:07,829 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;145;146;146;145;145;146;146;146;146 21:54:07 INFO - 2015-11-12 21:54:07,829 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;96;96;95;95;95;95 21:54:07 INFO - 2015-11-12 21:54:07,829 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;59;59;57;57;57;58;66;55;59 21:54:07 INFO - 2015-11-12 21:54:07,829 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;67;67;67;67;68;66;67;67 21:54:07 INFO - 2015-11-12 21:54:07,829 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;88;90;86;84;84;84;93;88;84 21:54:07 INFO - 2015-11-12 21:54:07,829 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;122;125;115;120;125;122;123;115;114 21:54:07 INFO - 2015-11-12 21:54:07,829 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;155;148;149;147;142;139;147;145;138 21:54:07 INFO - 2015-11-12 21:54:07,829 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;68;69;67;65;66;66;65;68 21:54:07 INFO - 2015-11-12 21:54:07,829 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:54:07 INFO - 2015-11-12 21:54:07,829 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:54:07 INFO - 2015-11-12 21:54:07,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,910 21:54:07 INFO - 2015-11-12 21:54:07,830 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:54:07 INFO - 2015-11-12 21:54:07,830 DEBUG : BROWSER_OUTPUT: __startTimestamp1447394047826__endTimestamp 21:54:07 INFO - 2015-11-12 21:54:07,830 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,831 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:54:07 INFO - 2015-11-12 21:54:07,831 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:54:07 INFO - 2015-11-12 21:54:07,831 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,831 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.84 (3.5%) stddev-sans-first:4.06 21:54:07 INFO - 2015-11-12 21:54:07,831 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 104.0 111.0 110.0 112.0 101.0 110.0 113.0 111.0 21:54:07 INFO - 2015-11-12 21:54:07,831 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,831 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.20 Median:149.00 stddev:16.67 (11.2%) stddev-sans-first:16.79 21:54:07 INFO - 2015-11-12 21:54:07,831 DEBUG : BROWSER_OUTPUT: Values: 159.0 128.0 149.0 163.0 127.0 149.0 147.0 125.0 169.0 126.0 21:54:07 INFO - 2015-11-12 21:54:07,832 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,832 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 21:54:07 INFO - 2015-11-12 21:54:07,832 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 161.0 160.0 160.0 161.0 162.0 160.0 160.0 21:54:07 INFO - 2015-11-12 21:54:07,832 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,832 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.80 Median:76.00 stddev:10.23 (13.5%) stddev-sans-first:10.45 21:54:07 INFO - 2015-11-12 21:54:07,833 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 80.0 91.0 72.0 71.0 71.0 96.0 92.0 72.0 21:54:07 INFO - 2015-11-12 21:54:07,833 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,833 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.20 Median:90.50 stddev:21.98 (24.3%) stddev-sans-first:22.71 21:54:07 INFO - 2015-11-12 21:54:07,833 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 133.0 90.0 91.0 91.0 137.0 91.0 91.0 138.0 21:54:07 INFO - 2015-11-12 21:54:07,833 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,833 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 21:54:07 INFO - 2015-11-12 21:54:07,833 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 21:54:07 INFO - 2015-11-12 21:54:07,833 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,834 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 21:54:07 INFO - 2015-11-12 21:54:07,834 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 21:54:07 INFO - 2015-11-12 21:54:07,834 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,834 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 21:54:07 INFO - 2015-11-12 21:54:07,834 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 21:54:07 INFO - 2015-11-12 21:54:07,834 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,834 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.50 stddev:2.95 (5.0%) stddev-sans-first:3.09 21:54:07 INFO - 2015-11-12 21:54:07,834 DEBUG : BROWSER_OUTPUT: Values: 57.0 59.0 59.0 57.0 57.0 57.0 58.0 66.0 55.0 59.0 21:54:07 INFO - 2015-11-12 21:54:07,834 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 67.0 67.0 67.0 68.0 66.0 67.0 67.0 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:3.10 (3.6%) stddev-sans-first:3.23 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: Values: 85.0 88.0 90.0 86.0 84.0 84.0 84.0 93.0 88.0 84.0 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:122.50 stddev:5.37 (4.4%) stddev-sans-first:4.37 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: Values: 131.0 122.0 125.0 115.0 120.0 125.0 122.0 123.0 115.0 114.0 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:147.00 stddev:5.40 (3.7%) stddev-sans-first:5.29 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: Values: 139.0 155.0 148.0 149.0 147.0 142.0 139.0 147.0 145.0 138.0 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.34 (2.0%) stddev-sans-first:1.41 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 68.0 69.0 67.0 65.0 66.0 66.0 65.0 68.0 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:54:07 INFO - 2015-11-12 21:54:07,835 DEBUG : BROWSER_OUTPUT: 21:54:08 INFO - 2015-11-12 21:54:08,673 INFO : Browser exited with error code: 0 21:54:08 INFO - 2015-11-12 21:54:08,722 INFO : Completed test kraken (00:00:58) 21:54:08 INFO - 2015-11-12 21:54:08,722 INFO : Starting test v8_7 21:54:08 INFO - 2015-11-12 21:54:08,722 DEBUG : operating with platform_type : linux_ 21:54:08 INFO - 2015-11-12 21:54:08,723 INFO : Initialising browser for v8_7 test... 21:54:08 INFO - 2015-11-12 21:54:08,729 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLBXyzU/profile http://localhost:59972/getInfo.html 21:54:12 INFO - 2015-11-12 21:54:12,646 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:54:12 INFO - 2015-11-12 21:54:12,646 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:54:12 INFO - 2015-11-12 21:54:12,646 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:54:12 INFO - 2015-11-12 21:54:12,646 DEBUG : BROWSER_OUTPUT: __metrics 21:54:12 INFO - 2015-11-12 21:54:12,791 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:54:13 INFO - 2015-11-12 21:54:13,947 INFO : Browser initialized. 21:54:13 INFO - 2015-11-12 21:54:13,948 INFO : Running cycle 1/1 for v8_7 test... 21:54:13 INFO - 2015-11-12 21:54:13,948 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLBXyzU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:54:25 INFO - 2015-11-12 21:54:25,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 140898304 21:54:25 INFO - 2015-11-12 21:54:25,662 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59972/tests/v8_7/run.html (next: http://localhost:59972/tests/v8_7/run.html) 21:54:47 INFO - 2015-11-12 21:54:47,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 544563200 21:54:47 INFO - 2015-11-12 21:54:47,288 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,288 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:54:47 INFO - 2015-11-12 21:54:47,288 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:54:47 INFO - 2015-11-12 21:54:47,288 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:54:47 INFO - 2015-11-12 21:54:47,289 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:54:47 INFO - 2015-11-12 21:54:47,289 DEBUG : BROWSER_OUTPUT: |0;Richards;163.47882949158085 21:54:47 INFO - 2015-11-12 21:54:47,289 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.1370607649 21:54:47 INFO - 2015-11-12 21:54:47,289 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.143997718848 21:54:47 INFO - 2015-11-12 21:54:47,289 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 21:54:47 INFO - 2015-11-12 21:54:47,289 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1098.901098901099 21:54:47 INFO - 2015-11-12 21:54:47,290 DEBUG : BROWSER_OUTPUT: |5;Earley;790.5138339920949 21:54:47 INFO - 2015-11-12 21:54:47,290 DEBUG : BROWSER_OUTPUT: |6;Boyer;11709.302325581395 21:54:47 INFO - 2015-11-12 21:54:47,290 DEBUG : BROWSER_OUTPUT: |7;RegExp;25846.153846153848 21:54:47 INFO - 2015-11-12 21:54:47,290 DEBUG : BROWSER_OUTPUT: |8;Splay;602.0469596628537 21:54:47 INFO - 2015-11-12 21:54:47,290 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 21:54:47 INFO - 2015-11-12 21:54:47,290 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:54:47 INFO - 2015-11-12 21:54:47,290 DEBUG : BROWSER_OUTPUT: __startTimestamp1447394087287__endTimestamp 21:54:47 INFO - 2015-11-12 21:54:47,290 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,290 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:54:47 INFO - 2015-11-12 21:54:47,290 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:54:47 INFO - 2015-11-12 21:54:47,290 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,291 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.48 Median:163.48 stddev:0.00 (0.0%) 21:54:47 INFO - 2015-11-12 21:54:47,291 DEBUG : BROWSER_OUTPUT: Values: 163.5 21:54:47 INFO - 2015-11-12 21:54:47,291 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,291 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.14 Median:194.14 stddev:0.00 (0.0%) 21:54:47 INFO - 2015-11-12 21:54:47,291 DEBUG : BROWSER_OUTPUT: Values: 194.1 21:54:47 INFO - 2015-11-12 21:54:47,291 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,291 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.14 Median:285.14 stddev:0.00 (0.0%) 21:54:47 INFO - 2015-11-12 21:54:47,291 DEBUG : BROWSER_OUTPUT: Values: 285.1 21:54:47 INFO - 2015-11-12 21:54:47,291 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,291 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 21:54:47 INFO - 2015-11-12 21:54:47,291 DEBUG : BROWSER_OUTPUT: Values: 5050.5 21:54:47 INFO - 2015-11-12 21:54:47,291 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,292 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1098.90 Median:1098.90 stddev:0.00 (0.0%) 21:54:47 INFO - 2015-11-12 21:54:47,292 DEBUG : BROWSER_OUTPUT: Values: 1098.9 21:54:47 INFO - 2015-11-12 21:54:47,292 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,292 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 21:54:47 INFO - 2015-11-12 21:54:47,292 DEBUG : BROWSER_OUTPUT: Values: 790.5 21:54:47 INFO - 2015-11-12 21:54:47,292 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,292 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11709.30 Median:11709.30 stddev:0.00 (0.0%) 21:54:47 INFO - 2015-11-12 21:54:47,292 DEBUG : BROWSER_OUTPUT: Values: 11709.3 21:54:47 INFO - 2015-11-12 21:54:47,292 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,292 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25846.15 Median:25846.15 stddev:0.00 (0.0%) 21:54:47 INFO - 2015-11-12 21:54:47,292 DEBUG : BROWSER_OUTPUT: Values: 25846.2 21:54:47 INFO - 2015-11-12 21:54:47,293 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,293 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:602.05 Median:602.05 stddev:0.00 (0.0%) 21:54:47 INFO - 2015-11-12 21:54:47,293 DEBUG : BROWSER_OUTPUT: Values: 602.0 21:54:47 INFO - 2015-11-12 21:54:47,293 DEBUG : BROWSER_OUTPUT: 21:54:47 INFO - 2015-11-12 21:54:47,293 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 21:54:47 INFO - 2015-11-12 21:54:47,293 DEBUG : BROWSER_OUTPUT: Values: 4817.3 21:54:47 INFO - 2015-11-12 21:54:47,294 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:54:47 INFO - 2015-11-12 21:54:47,295 DEBUG : BROWSER_OUTPUT: 21:54:48 INFO - 2015-11-12 21:54:48,133 INFO : Browser exited with error code: 0 21:54:48 INFO - 2015-11-12 21:54:48,150 INFO : Completed test v8_7 (00:00:39) 21:54:48 INFO - 2015-11-12 21:54:48,312 INFO : Completed test suite (00:20:10) 21:54:48 INFO - 2015-11-12 21:54:48,312 DEBUG : Working with test: dromaeo_css 21:54:48 INFO - 2015-11-12 21:54:48,312 DEBUG : Generating results file: dromaeo_css 21:54:48 INFO - 2015-11-12 21:54:48,313 DEBUG : Working with test: kraken 21:54:48 INFO - 2015-11-12 21:54:48,314 DEBUG : Generating results file: kraken 21:54:48 INFO - 2015-11-12 21:54:48,314 INFO : javascript benchmark 21:54:48 INFO - 2015-11-12 21:54:48,314 DEBUG : Working with test: v8_7 21:54:48 INFO - 2015-11-12 21:54:48,314 DEBUG : Generating results file: v8_7 21:54:48 INFO - 2015-11-12 21:54:48,314 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:54:48 INFO - 2015-11-12 21:54:48,452 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 21:54:48 INFO - 2015-11-12 21:54:48,452 DEBUG : process_Request line: dromaeo_css 6708.50 graph.html#tests=[[72,63,35]] 21:54:48 INFO - 2015-11-12 21:54:48,452 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:54:48 INFO - 2015-11-12 21:54:48,481 DEBUG : process_Request line: kraken 1492.40 graph.html#tests=[[232,63,35]] 21:54:48 INFO - 2015-11-12 21:54:48,481 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:54:48 INFO - 2015-11-12 21:54:48,509 DEBUG : process_Request line: v8_7 21144.63 graph.html#tests=[[230,63,35]] 21:54:48 INFO - 2015-11-12 21:54:48,511 INFO : javascript benchmark 21:54:48 INFO - 2015-11-12 21:54:48,514 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [348.8796365253987, 349.19336333070606, 350.08976660682214, 351.4780550881941, 353.126013117534, 13877.236751978637, 14132.152070875729, 16749.497515074552, 17414.477565673034, 18596.349127780515, 15236.314365853535, 15799.28903199356, 15886.36454541817, 16890.15549222537, 16933.0, 5172.250023746564, 5306.655067420625, 5311.840644780663, 5313.149896016638, 5313.707746073965, 3978.0452691354158, 4075.042365044212, 5334.626576139672, 5360.973195134019, 5711.114777209539, 5769.16347129666, 5777.104548794943, 5791.160281759142, 5795.15970184323, 5806.622569532988, 5582.553395728332, 5639.8590035249445, 5699.857503562403, 5708.628939118965, 5767.653940763546, 4926.507349265081, 4938.456769755324, 4938.678985865943, 4950.4801995790285, 4962.528559786814, 15201.239938003055, 15272.847271527366, 16333.59166020847, 17032.148392580322, 20211.494712632302, 1965.8722183058198, 2040.8775473471492, 2050.159434631809, 2079.688046792993, 2258.4692597239637, 12492.312922789242, 12596.370181490889, 13003.154794938393, 13045.347732613427, 13378.866211337956, 1754.7192449208064, 1767.938122165718, 1849.7317888906168, 1858.2288350334595, 1895.0051223107841, 58006.41993580052, 59406.0, 59450.10824837631, 59519.0, 60735.08897366543, 8934.73195804127, 8997.460152390877, 9273.72178834636, 9288.164065234027, 9300.20948219409, 12743.936280318725, 12760.425780839885, 12767.93616031914, 12788.552400665933, 12790.29653369055, 7127.073480447612, 7148.249433809479, 7166.175889772639, 7175.96412017947, 7217.061781968416, 6880.2431732509385, 6882.174139103339, 6892.551984121016, 6904.102466679299, 6924.861502769916, 5814.244148260784, 5821.38875418075, 5853.180554722342, 5876.676782776988, 5924.081767326072, 1528.4497580870877, 1583.8812089093365, 1598.4165779490402, 1640.4012535424483, 1710.7091794394983, 822.983540329202, 915.3089417489753, 983.3165949664914, 1016.7407311135613, 1019.6635110413546, 17311.0, 17925.7311140333, 18158.364457243933, 18209.544761380806, 18345.54136146607, 786.6578038553248, 888.3293113699116, 922.9953850230706, 942.1567696911363, 1008.9949550252202, 5768.74040668171, 6271.592346497463, 6303.590266632654, 6324.588901721373, 6331.366863313632, 530917.0, 534314.0, 550452.0, 551423.0, 551822.0, 75142.0, 76629.0, 77052.0, 78500.60749696215, 79816.0, 480.6731422632574, 487.04782150894914, 487.12074705157534, 487.2277440257161, 488.3919520197306, 9876.654317098866, 10186.185105191715, 10274.075333220046, 10787.838182427113, 11041.558337666404, 33125.17187070342, 33479.33041339208, 33641.495377569845, 35363.646363536034, 36234.818825906754, 42771.35842962296, 45423.318650220936, 47087.0, 47355.052898942515, 47392.28911566398, 6359.236891573041, 6427.292997770335, 6469.5794773339585, 6472.385123413268, 6481.222253329631, 12020.75958480843, 12112.152149349813, 12235.327057011593, 12316.953058990086, 12374.690632734253, 9007.954960225157, 9226.815463690555, 10141.746456338355, 10491.94754026225, 10830.458477075957, 10198.0, 10289.74275643115, 10296.227782916461, 10592.987332406818, 10908.509117089592, 10582.312149710244, 10595.311304765166, 10665.57337706514, 10698.518566664363, 10926.890731092588, 6337.493000560036, 6665.933340666531, 6669.599824010575, 6681.1314529110905, 6705.865882682417, 10307.845382319421, 10347.689569312932, 10434.0, 10561.0, 10661.147108231478], "dojo.html": [3197.8401079946, 3246.529253258279, 3292.868285268588, 3302.537644729738, 3316.3864685033273, 5240.397354304256, 5347.973260133694, 5448.37343705474, 5452.591055670826, 5468.835934921954, 5414.8917021659545, 5448.37343705474, 5452.6183167178315, 5495.313085864267, 5567.109262517998, 4884.731339776311, 4891.657583969123, 4905.730184839832, 4957.405111386621, 5013.498650134994, 4827.227643577028, 5046.21783623539, 5056.924146137792, 5109.770060347293, 5132.6407151499225, 4864.489228630996, 4911.680740751875, 4937.284093806414, 4945.35710357653, 4964.925526117111, 4920.286558449041, 4946.530079642428, 4986.177280748709, 4998.6750861193905, 5018.2974383586325, 4815.374001379833, 4944.851654450372, 4949.950500494985, 4967.40391153064, 5008.974955125237, 5161.5354618084175, 5250.474952504757, 5265.052290587692, 5285.709285989269, 5289.68261904287, 5909.556783241274, 5912.76348946046, 5920.585559010871, 5925.081612350093, 5931.851703707399, 5716.056850619642, 5768.97115514424, 5837.3287071986415, 5958.314793798725, 5962.075878238837, 5541.362743284493, 5550.72246387679, 5558.722063896829, 5561.694106824123, 5607.046802043662, 6006.5495087868585, 6017.308009578867, 6041.124037014608, 6052.425019623129, 6090.0, 5695.430456954271, 5759.366469688331, 5832.300123985149, 5844.035734103825, 5909.527237820964, 5919.348871624118, 5922.555808314393, 5938.49522790559, 5941.970290148522, 5947.821565353046, 5878.882422351529, 5906.379830117776, 5907.261592300963, 5909.970450147808, 5919.141724449931, 5545.140503222007, 5672.688002159921, 5742.885142297131, 5853.385394533598, 5888.646681199141, 4509.458864936229, 4531.660125490535, 4533.818647254073, 4535.591796738244, 4569.702969306984, 3917.0, 4032.334664780337, 4034.65705415043, 4040.1313717550865, 4064.6748260139116, 5473.397926228112, 5493.478119578634, 5509.3664228613425, 5515.696636684941, 5562.916556251659, 5877.941220587825, 5894.646321220741, 5899.823005309848, 5902.409759024149, 5906.0, 5368.141097424394, 5450.618456708072, 5555.444455554493, 5560.054790685593, 5563.805266815642, 4922.237053256751, 5029.874253143701, 5034.0686972910125, 5034.295198672189, 5062.392512898476, 6188.566800324024, 6191.00943848991, 6196.752129914843, 6202.596831206048, 6205.317415084337, 5721.342045664802, 5811.157382179645, 5837.416258374129, 5929.347771745191, 5932.733027013881, 6073.453389194994, 6111.144439778345, 6119.510439164767, 6132.5707200495535, 6143.016005401305, 5844.298684157929, 5852.5317974561085, 5853.268341457318, 5865.794697185578, 5902.468777810018, 5698.373178950395, 5701.429857014431, 5825.563082768894, 5883.529317654663, 5925.348211696796, 5744.569157313134, 5790.449907258803, 5791.478766910998, 5791.623544469596, 5803.82588522345, 5768.625039372428, 5771.7114144293455, 5773.566982476247, 5774.94225057744, 5776.19133321327, 5457.0, 5514.420985796433, 5564.33228012641, 5627.971860140673, 5632.9436705632415, 5803.82588522345, 5809.302883653989, 5835.67903765297, 5841.211436456024, 5887.146363777314, 5479.205515200194, 5708.628939118944, 5713.485786279255, 5715.31416230055, 5729.799457018984], "mootools.html": [1545.2428310128041, 1690.5351028467173, 1725.3961113610237, 1731.290171029878, 1767.7260024696168, 6425.421712045915, 7594.848103037936, 7717.382609391249, 7731.188225236354, 7734.806629834257, 7531.4351423643175, 7615.124260710006, 7621.58081305528, 7622.123455802571, 7628.694852205919, 1938.176275083084, 1976.0811222781404, 2198.7251593550805, 2213.601551720694, 2236.6756820261053, 2268.3648578398074, 2283.817294616427, 2285.2801367569245, 2293.747687754346, 2294.736105347881, 2184.0936011555186, 2211.1487077475126, 2212.811910987568, 2214.070090561968, 2217.756046834847, 1949.171602069122, 1963.6465436221474, 2185.7704940981125, 2237.4853783629856, 2242.85421447607, 2209.304069218191, 2251.3696165073807, 2275.2036787124375, 2278.6695929090356, 2279.3162051384684, 7481.513701609378, 7538.208488108725, 7563.0, 7565.735199268054, 7567.281108294703, 4396.934045989313, 4474.731516109044, 4478.664100192466, 4488.349189367524, 4491.4161159049445, 2926.75122614578, 2929.4287613915294, 2970.7029297070335, 2971.9405611887855, 3057.143999680093, 903.1781079217881, 915.8031023330016, 918.0865039285886, 921.0559176843722, 932.2309094996588, 10067.29528932975, 10211.744706382326, 10264.076233138978, 10266.230032747499, 10278.280520363578, 3999.120193557471, 4065.6747460203114, 4093.7748423836974, 4175.874723758292, 4180.28935081037, 8823.911760882438, 8829.911700883038, 8835.469871807712, 8855.247303979233, 8862.246709029676, 4470.038941627566, 4514.774261286922, 4540.88647783808, 4542.591166795004, 4544.318352247189, 4082.530508991504, 4092.9795351023054, 4095.0990782027907, 4110.609492098306, 4116.69124815634, 3317.3033662931057, 3402.8808991685173, 3429.0, 3434.055634700477, 3436.0, 1118.8713297970676, 1131.2590253383883, 1137.806572882612, 1140.1391949078559, 1144.9141314401286, 958.2956526952685, 1280.3406245783428, 1309.9869001309864, 1317.4861803896488, 1318.1102755639904, 7152.249013853574, 7177.354038136593, 7180.958760979629, 7184.245654206337, 7204.351608355273, 437.18683249156544, 438.3381094547193, 442.09370789880614, 443.0872402850139, 444.22926223003066, 5432.674039557639, 5494.587905907073, 5509.421510741315, 5513.979913715975, 5515.145152501369, 9055.0, 9058.682946096855, 9245.352825302165, 9297.953510232406, 9305.348625596143, 8964.775880602907, 9015.81968360629, 9051.909480905106, 9074.500902450296, 9114.680986165453, 6948.6178260195165, 7042.119735033121, 7086.681099350541, 7183.245759195313, 7227.3134052263895, 7195.964020179866, 7252.129744430491, 7260.927390726025, 7261.3101755333155, 7268.0914885639295, 8157.3881958852135, 8199.79500512468, 8258.29804466603, 8263.462874913112, 8378.49729016261, 8303.169683031649, 8529.14708529142, 8621.8706719398, 8649.870251946351, 8655.95672021661, 6931.653417329214, 6980.0, 7039.9296007039275, 7182.8563428730085, 7243.20324764286, 7125.964370178116, 7310.744123955636, 7320.377767889576, 7347.632618369167, 7365.0, 6691.631960242234, 6995.405390541861, 7004.194517630538, 7006.824829379307, 7203.747868824566, 6232.345603711545, 6402.135711678864, 6788.389044985975, 6817.7272909083085, 7014.754483593049, 6701.497387695845, 6726.730930762715, 6739.629320387229, 6742.190937087385, 6751.122354093936, 6345.904811427925, 6377.93622063792, 6378.234611846423, 6389.393007664265, 6411.4229719325485, 6503.057056726842, 6522.412982831568, 6542.44389226902, 6558.0, 6561.573497722633], "ext.html": [587.6709042935956, 590.8050343386683, 596.3082823924246, 596.4095545410046, 621.6239175298944, 30911.227219319528, 38796.806015969916, 39098.8045059775, 39100.21799564007, 39172.21655566891, 42392.0, 42850.142997140036, 42907.57092429075, 42949.57050429495, 42963.57036429635, 7591.089069311691, 7704.537727736326, 8656.653733850639, 8818.603162857687, 10142.746431339201, 10379.636712715057, 10515.579376824919, 10516.21128415368, 10519.368837869752, 10520.842187367196, 10454.790904181911, 10527.105196058345, 10556.947215263952, 10562.947185264102, 10571.471426428649, 7696.230376962315, 7877.212278772135, 10522.736931576695, 10769.83845242322, 10786.406747628876, 10338.224633152544, 10421.114205292559, 10422.0, 10476.3190392625, 10477.528511216937, 39427.60572394268, 39780.20439591221, 39812.0, 39920.20159596792, 39921.60078399237, 3146.858391372371, 3157.447446696842, 3329.3840639481773, 3637.381645120336, 3667.743257971916, 29209.561856572167, 29369.706302937124, 29767.404651907058, 29839.25401864949, 29910.700892991226, 3190.8564114614896, 3214.9839250803598, 3251.170951407376, 3253.9511907321407, 3340.3294788531784, 285257.0, 286895.0, 286902.0, 287902.0, 288321.9999999979, 52509.737451312496, 53409.465905341225, 54164.72917635387, 54713.0, 55202.0, 58037.41962580405, 58050.419495804505, 58305.708471458216, 58327.708361457924, 58365.0, 13612.31938403076, 13727.176369417866, 13777.380017899219, 13780.379882905294, 13781.655458613413, 10235.078842904175, 10274.537645805807, 10315.226358023177, 10331.845022324671, 10346.0, 19153.0, 19167.0, 19176.424707258804, 19270.80729192718, 19369.806301936802, 7893.526388416713, 8040.195980401913, 8123.634436450374, 8148.470349427268, 8214.671413143527, 983.9163671088038, 994.472929347447, 1014.1835822163082, 1025.3642741500319, 1115.682030621269, 25691.48617027649, 26261.606075908876, 26634.46731065368, 28050.0, 29244.7075529242, 967.4437198610827, 1010.6715317521835, 1012.5038731021747, 1015.761296095417, 1020.6223697232072, 13569.457221711218, 15058.774118388234, 15287.923560382127, 15386.538403847902, 15439.845601544066, 324107.0, 329507.0, 330020.0, 330347.0, 330531.0, 52805.0, 52879.471205288224, 53122.73438632859, 53137.46862531325, 53174.734126329124, 1327.9136856104321, 1349.2646507653549, 1353.0325817040864, 1354.9051566390456, 1453.0, 23922.40193995164, 26695.733042669326, 27699.723002769715, 28108.578371324038, 28980.565291521067, 47080.0, 47388.52611473979, 47403.0, 47417.52582474269, 47493.76253118712, 260841.0, 261215.0, 262172.0, 262273.0, 262613.0, 27061.0, 27529.174124776287, 32413.675863241067, 32763.0, 32815.0, 39068.6093139065, 39658.40512392374, 40053.39919901145, 40148.598514015655, 40329.79835100806, 34023.65976340304, 34369.65630343665, 34459.4831077529, 34568.0, 34803.477947830295, 32265.677343226267, 34254.82872585621, 35518.822405887804, 36312.63687363092, 36420.45369319515, 34220.65779342175, 34829.825850870584, 34907.65092349044, 35231.82384088063, 35233.471497927036, 30848.0, 31661.683383165873, 32217.194570135933, 32229.0, 32556.674433255364, 24445.51108977846, 24469.51060978806, 24939.875300623382, 24959.376015599755, 24990.500189995735], "prototype.html": [308.52025100967995, 312.481281073418, 316.81624657698535, 317.52054397859223, 319.5717738230773, 5870.5597080218995, 5957.344692083872, 5962.522998160153, 6005.939940600592, 6041.516678665707, 5951.196588460556, 5951.226340575719, 5952.196453478779, 5954.315253745821, 5990.161377407167, 4506.504284528699, 4510.030343476152, 4511.142882852264, 4513.932291015637, 4514.345419914111, 4376.868693939171, 4400.669949753766, 4498.482674492426, 4522.819087236507, 4526.592606665416, 4402.031553058322, 4404.075144219718, 4405.779711014453, 4410.889727756816, 4415.22733521634, 4372.715773474714, 4374.934375984363, 4385.561443855605, 4391.780410979438, 4401.955980440187, 3770.9622903770887, 3773.8867833965023, 3780.6408391203067, 3786.659200671925, 3794.5067141271456, 5497.065498865202, 5586.748596313176, 5589.329280486327, 5591.496765291103, 5596.104623260299, 5139.049275883974, 5147.897042059138, 5149.845504634867, 5150.381954165487, 5155.896882062375, 6297.748090076391, 6304.810855674337, 6308.2430108386825, 6309.0, 6310.368963103699, 4203.894902627429, 4223.113146239262, 4228.513720922103, 4234.17433600448, 4237.364395340693, 6168.84577885552, 6375.139356186948, 6418.486521078303, 6610.338966103399, 6623.933760662379, 4304.354346847936, 4339.609435150852, 4344.47866256045, 4348.347747837786, 4349.456317960255, 4391.297392417198, 4394.099209662011, 4395.1868904252815, 4396.758178300161, 4398.0, 4976.402831660152, 5048.520390562964, 5082.161443361804, 5169.017886601534, 5171.069207542603, 6419.711112999927, 6422.4862011039, 6422.550421470546, 6436.8390790230615, 6437.324080971524, 1556.7353549896545, 1577.8501042400953, 1589.7297459431925, 1593.0362130910864, 1594.2905407093963, 1039.1219419590434, 1039.6776999130293, 1054.6835949215206, 1065.3341661461586, 1066.0299127793671, 6213.751449942042, 6231.3145553989025, 6233.719482623293, 6235.064740288993, 6237.656928868865, 6603.075569420285, 6615.76844810439, 6621.139251897319, 6622.867542649216, 6623.4038936495945, 6065.090236464565, 6211.0372892201785, 6214.353196402957, 6215.564910456315, 6225.128482012522, 3563.3585954527916, 3584.408572585546, 3593.317269718745, 3593.9640603594153, 3603.747737658391, 6799.932000680029, 6852.965735171292, 6863.622500762406, 6864.725410983505, 6871.896921546181, 6580.40776330123, 6691.0967019451755, 6708.1950165979415, 6715.664216789141, 6716.429103526255, 6872.62200578963, 6872.656367181621, 6875.140607424072, 6875.724971001204, 6877.3810357067105, 6607.240167380813, 6612.537122401386, 6612.669366531751, 6615.636140012345, 6620.966895165493, 6389.584676995981, 6486.708098135501, 6534.575252608565, 6539.149910511603, 6551.344865513411, 6845.726170953305, 6848.0, 6853.451723861979, 6856.108705868404, 6861.451083913175, 4370.104128653555, 4387.23223435891, 4411.558844115562, 4412.691111622155, 4416.227160247008, 6339.366063393623, 6473.158489396348, 6569.605823650596, 6576.112224849775, 6576.704048317742, 6264.686765661608, 6389.9041514376395, 6426.0, 6447.6453795041725, 6459.806205813833, 6373.426391624776, 6409.775657851953, 6413.422791948747, 6418.1656384669695, 6423.03654451836, 6175.876482470415, 6292.590981586182, 6302.495800336053, 6321.11504389395, 6337.35228840514, 6476.967615161894, 6484.740610375532, 6489.123968264413, 6490.643014634241, 6491.123698300669, 6289.40250676185, 6324.968375158095, 6339.714712838026, 6350.110984462087, 6353.078803573363], "yui.html": [757.1822431773685, 841.0874201491382, 854.9487030778158, 859.9871001934972, 865.333693056347, 12781.616551503446, 13191.2744799036, 13200.141990770606, 13246.139000964955, 13305.800412993813, 11425.485853136608, 11427.657170284883, 11447.59933402331, 11487.540498380076, 11502.712432189179, 655.020743987739, 791.639803889229, 805.0741647105846, 805.9516429014278, 806.7136166660839, 662.1259936883316, 788.1527358090076, 804.9718259860906, 806.2018601584418, 806.701520437439, 824.0, 837.2004735477605, 837.6314421654453, 838.325148255654, 838.8993320801482, 691.6230654293397, 697.616311028932, 821.9054808697017, 830.5058490198322, 832.8084540555676, 617.4844005255617, 617.6325086573481, 618.298231507238, 619.2321521313584, 619.5074915442234, 13284.402201900937, 13546.119502232323, 13559.728805423836, 13604.86395136046, 13611.047226694136, 11122.221444498888, 12272.386380681019, 12273.938630306791, 12290.938545307215, 12398.19411738243, 8815.725401731173, 8908.554572271361, 8939.955300223522, 8967.910320896774, 9019.368644194908, 3515.191505953645, 3572.356975744365, 3608.819559022065, 3610.891673249807, 3614.8915532534065, 44930.550694492966, 45109.54890451086, 45519.772401138114, 46592.53407465916, 46782.29826552571, 7410.851782964418, 7446.813829654194, 7462.253774622494, 7524.322810947041, 7714.845703085907, 11802.937735603837, 11822.290662560274, 11831.053515718722, 11864.0, 11870.28778273289, 6116.113163591254, 6285.214348206474, 6290.559660823698, 6382.617042977344, 6396.328385519547, 3979.403089536535, 4041.818118184689, 4083.71414001023, 4096.774677392712, 4127.504699436087, 2649.668791401075, 2677.6251324814543, 2678.0, 2678.450917561895, 2685.7985651076247, 409.69068353393, 410.36803322883026, 414.241937254823, 418.53751604476616, 419.1512187819629, 615.7321565119188, 618.7370367593754, 663.3300366629738, 667.6695035957232, 686.9622170780555, 8010.679572817138, 8054.798630034179, 8166.918330816735, 8181.6318265677, 8299.6680132794, 482.32715362070417, 511.1770050219144, 529.6292595183387, 531.4127888683026, 624.073251221935, 3645.434957581579, 3663.560372755233, 3727.2172843703124, 3734.925301494009, 4027.154297597537, 57304.713476433186, 58552.707236463546, 58963.41036589579, 59156.40843591595, 59221.40778592245, 50818.491815081376, 51576.22635660468, 51940.22089668658, 52613.210801838, 52966.205506917424, 46247.76876115598, 46630.0, 47001.294980575316, 47664.5233547667, 47949.0, 7683.864981092307, 7692.92307076922, 7846.0, 7875.527468351688, 7889.723859664884, 33269.50095748517, 34145.0, 34307.485387718705, 34330.0, 35562.82218588891, 42795.0, 43782.781086094365, 44256.557434425245, 45089.77455112703, 45216.0, 6818.454523637998, 7135.108111486064, 7198.172210195895, 7232.891506627299, 7233.421326293989, 10200.642977495752, 10340.689779306633, 10496.790064198825, 10735.570577176826, 10822.67531974042, 9900.405975641484, 9924.1068303853, 9939.950300248453, 10058.647947321808, 10293.639722609672, 9667.854982175133, 9772.12050915421, 9873.605055797687, 10163.7459063524, 10318.43248621303, 8678.696245631372, 9654.27592930519, 9761.219102471643, 9812.411255324703, 10403.479826008517, 8481.06708262103, 8805.383623146317, 8980.730578082668, 9047.638094476148, 9050.321225907952, 9009.324300677345, 9104.180623743894, 9152.405093668891, 9153.954230228806, 9299.558816239582]}, "summary": {"lowerIsBetter": false, "suite": 6708.497581240236, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7897.245614959872, "unit": "ms", "value": 7897.245614959872}, "dojo.html": {"lowerIsBetter": false, "filtered": 5409.82654400585, "unit": "ms", "value": 5409.82654400585}, "mootools.html": {"lowerIsBetter": false, "filtered": 4275.975288002498, "unit": "ms", "value": 4275.975288002498}, "ext.html": {"lowerIsBetter": false, "filtered": 18361.4009323714, "unit": "ms", "value": 18361.4009323714}, "prototype.html": {"lowerIsBetter": false, "filtered": 4742.869247801046, "unit": "ms", "value": 4742.869247801046}, "yui.html": {"lowerIsBetter": false, "filtered": 5728.897327740082, "unit": "ms", "value": 5728.897327740082}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-045"}, "testrun": {"date": 1447392877, "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": "20151112193228", "branch": "Mozilla-Inbound", "revision": "fcab41a159596b77bd65b4d62ffc9a42aacb5cac"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 162.0, 160.0, 160.0], "ai-astar": [110.0, 112.0, 104.0, 111.0, 110.0, 112.0, 101.0, 110.0, 113.0, 111.0], "imaging-gaussian-blur": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0], "audio-beat-detection": [159.0, 128.0, 149.0, 163.0, 127.0, 149.0, 147.0, 125.0, 169.0, 126.0], "json-stringify-tinderbox": [66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 66.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [139.0, 155.0, 148.0, 149.0, 147.0, 142.0, 139.0, 147.0, 145.0, 138.0], "json-parse-financial": [57.0, 59.0, 59.0, 57.0, 57.0, 57.0, 58.0, 66.0, 55.0, 59.0], "stanford-crypto-sha256-iterative": [67.0, 66.0, 68.0, 69.0, 67.0, 65.0, 66.0, 66.0, 65.0, 68.0], "audio-fft": [71.0, 72.0, 80.0, 91.0, 72.0, 71.0, 71.0, 96.0, 92.0, 72.0], "imaging-darkroom": [147.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0], "stanford-crypto-ccm": [131.0, 122.0, 125.0, 115.0, 120.0, 125.0, 122.0, 123.0, 115.0, 114.0], "audio-oscillator": [90.0, 90.0, 133.0, 90.0, 91.0, 91.0, 137.0, 91.0, 91.0, 138.0], "stanford-crypto-aes": [85.0, 88.0, 90.0, 86.0, 84.0, 84.0, 84.0, 93.0, 88.0, 84.0], "imaging-desaturate": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1492.3999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.8, "unit": "ms", "value": 78.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 144.9, "unit": "ms", "value": 144.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.2, "unit": "ms", "value": 144.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.2, "unit": "ms", "value": 121.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.8, "unit": "ms", "value": 145.8}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.4, "unit": "ms", "value": 58.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.2, "unit": "ms", "value": 104.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.4, "unit": "ms", "value": 109.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.7, "unit": "ms", "value": 160.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.7, "unit": "ms", "value": 66.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.9, "unit": "ms", "value": 66.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.6, "unit": "ms", "value": 86.6}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.3, "unit": "ms", "value": 95.3}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-045"}, "testrun": {"date": 1447392877, "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": "20151112193228", "branch": "Mozilla-Inbound", "revision": "fcab41a159596b77bd65b4d62ffc9a42aacb5cac"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.1370607649], "Encrypt": [285.143997718848], "NavierStokes": [4817.307692307692], "Decrypt": [5050.50505050505], "Splay": [602.0469596628537], "Richards": [163.47882949158085], "RegExp": [25846.153846153848], "Earley": [790.5138339920949], "Boyer": [11709.302325581395], "RayTrace": [1098.901098901099]}, "summary": {"lowerIsBetter": false, "suite": 21144.63127842084, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.5738179999999, "unit": "score", "value": 340.5738179999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 933.4967669999996, "unit": "score", "value": 933.4967669999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 308.055888223553, "unit": "score", "value": 308.055888223553}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.70383799999996, "unit": "score", "value": 52.70383799999996}, "Splay": {"lowerIsBetter": false, "filtered": 135.35655099999997, "unit": "score", "value": 135.35655099999997}, "RegExp": {"lowerIsBetter": false, "filtered": 35.24644345238097, "unit": "score", "value": 35.24644345238097}, "Richards": {"lowerIsBetter": false, "filtered": 215.94233399999993, "unit": "score", "value": 215.94233399999993}, "Earley": {"lowerIsBetter": false, "filtered": 843.0756950000003, "unit": "score", "value": 843.0756950000003}, "Boyer": {"lowerIsBetter": false, "filtered": 56.91739622641514, "unit": "score", "value": 56.91739622641514}, "RayTrace": {"lowerIsBetter": false, "filtered": 673.3899900000001, "unit": "score", "value": 673.3899900000001}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-045"}, "testrun": {"date": 1447392877, "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": "20151112193228", "branch": "Mozilla-Inbound", "revision": "fcab41a159596b77bd65b4d62ffc9a42aacb5cac"}}] 21:54:48 INFO - RETURN: dromaeo_css: 6708.50 21:54:48 INFO - RETURN: kraken: 1492.40 21:54:48 INFO - RETURN: v8_7: 21144.63 21:54:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "21144.63"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1492.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6708.50"}}} 21:54:48 INFO - Return code: 0 21:54:48 INFO - # TBPL SUCCESS # 21:54:48 INFO - Running post-action listener: _resource_record_post_action 21:54:48 INFO - Running post-run listener: _resource_record_post_run 21:54:49 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 496058368; Read time: 0; Write time: 501280 21:54:49 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 163913728; Read time: 0; Write time: 227676 21:54:49 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 304881664; Read time: 0; Write time: 265252 21:54:49 INFO - Running post-run listener: _upload_blobber_files 21:54:49 INFO - Blob upload gear active. 21:54:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:54:49 INFO - Copying logs to upload dir... 21:54:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.365209 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-12 21:54:49.045641) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 21:54:49.049359) ========= 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=61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009882 build_url: 'https://queue.taskcluster.net/v1/task/bD0VolE1S1S7EfD3vfQP4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 21:54:49.101283) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:54:49.101646) ========= 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=61fa6ed41387771909ec0f71000001b3-1447389890.428765-1665920972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:54:49.152167) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 21:54:49.152529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 21:54:49.152879) ========= ========= Total master_lag: 0.27 =========