builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1448275113.62 results: success (0) buildid: 20151123011114 builduid: a467d0821592459483505b7396d748b1 revision: e722799fa71f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.617427) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.617856) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.618205) ========= 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=820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006378 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.687462) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.687778) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.726652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.726927) ========= 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=820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.778080) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.778402) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.778805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.779138) ========= 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=820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 02:38:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 14.2M=0.001s 2015-11-23 02:38:35 (14.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184621 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.978490) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:33.978835) ========= 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=820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018662 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:34.028858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:34.029263) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e722799fa71f --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 e722799fa71f --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=820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 02:38:35,565 Setting DEBUG logging. 2015-11-23 02:38:35,565 attempt 1/10 2015-11-23 02:38:35,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e722799fa71f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 02:38:35,810 unpacking tar archive at: mozilla-inbound-e722799fa71f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.507309 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:34.550837) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:34.551190) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:34.558677) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:34.558991) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 02:38:34.559420) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-23 02:38:34.559758) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:38:36 INFO - MultiFileLogger online at 20151123 02:38:36 in /builds/slave/test-pgo 02:38:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 02:38:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:38:36 INFO - {'append_to_log': False, 02:38:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:38:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:38:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:38:36 INFO - 'branch': 'Mozilla-Inbound', 02:38:36 INFO - 'buildbot_json_path': 'buildprops.json', 02:38:36 INFO - 'config_files': ('talos/linux_config.py',), 02:38:36 INFO - 'default_actions': ('clobber', 02:38:36 INFO - 'read-buildbot-config', 02:38:36 INFO - 'download-and-extract', 02:38:36 INFO - 'populate-webroot', 02:38:36 INFO - 'create-virtualenv', 02:38:36 INFO - 'install', 02:38:36 INFO - 'run-tests'), 02:38:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:38:36 INFO - 'download_minidump_stackwalk': True, 02:38:36 INFO - 'download_symbols': 'ondemand', 02:38:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:38:36 INFO - 'tooltool.py': '/tools/tooltool.py', 02:38:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:38:36 INFO - '/tools/misc-python/virtualenv.py')}, 02:38:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:38:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:38:36 INFO - 'installer_path': 'installer.exe', 02:38:36 INFO - 'log_level': 'info', 02:38:36 INFO - 'log_name': 'talos', 02:38:36 INFO - 'log_to_console': True, 02:38:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:38:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:38:36 INFO - 'opt_config_files': (), 02:38:36 INFO - 'pip_index': False, 02:38:36 INFO - 'sps_profile': False, 02:38:36 INFO - 'sps_profile_interval': 0, 02:38:36 INFO - 'suite': 'dromaeojs-e10s', 02:38:36 INFO - 'system_bits': '64', 02:38:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:38:36 INFO - 'title': 'talos-linux64-ix-055', 02:38:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:38:36 INFO - 'use_talos_json': True, 02:38:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:38:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:38:36 INFO - 'work_dir': 'build'} 02:38:36 INFO - ##### 02:38:36 INFO - ##### Running clobber step. 02:38:36 INFO - ##### 02:38:36 INFO - Running pre-action listener: _resource_record_pre_action 02:38:36 INFO - Running main action method: clobber 02:38:36 INFO - rmtree: /builds/slave/test-pgo/build 02:38:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:38:37 INFO - Running post-action listener: _resource_record_post_action 02:38:37 INFO - ##### 02:38:37 INFO - ##### Running read-buildbot-config step. 02:38:37 INFO - ##### 02:38:37 INFO - Running pre-action listener: _resource_record_pre_action 02:38:37 INFO - Running main action method: read_buildbot_config 02:38:37 INFO - Using buildbot properties: 02:38:37 INFO - { 02:38:37 INFO - "properties": { 02:38:37 INFO - "buildnumber": 167, 02:38:37 INFO - "product": "firefox", 02:38:37 INFO - "script_repo_revision": "production", 02:38:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 02:38:37 INFO - "repository": "", 02:38:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 02:38:37 INFO - "buildid": "20151123011114", 02:38:37 INFO - "slavename": "talos-linux64-ix-055", 02:38:37 INFO - "pgo_build": "True", 02:38:37 INFO - "basedir": "/builds/slave/test-pgo", 02:38:37 INFO - "project": "", 02:38:37 INFO - "platform": "ubuntu64_hw", 02:38:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:38:37 INFO - "slavebuilddir": "test", 02:38:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 02:38:37 INFO - "branch": "mozilla-inbound", 02:38:37 INFO - "repo_path": "integration/mozilla-inbound", 02:38:37 INFO - "stage_platform": "linux64-pgo", 02:38:37 INFO - "builduid": "a467d0821592459483505b7396d748b1", 02:38:37 INFO - "revision": "e722799fa71f " 02:38:37 INFO - }, 02:38:37 INFO - "sourcestamp": { 02:38:37 INFO - "repository": "", 02:38:37 INFO - "hasPatch": false, 02:38:37 INFO - "project": "", 02:38:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 02:38:37 INFO - "changes": [ 02:38:37 INFO - { 02:38:37 INFO - "category": null, 02:38:37 INFO - "files": [ 02:38:37 INFO - { 02:38:37 INFO - "url": null, 02:38:37 INFO - "name": "https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 02:38:37 INFO - } 02:38:37 INFO - ], 02:38:37 INFO - "repository": "", 02:38:37 INFO - "rev": "e722799fa71f ", 02:38:37 INFO - "who": "sendchange", 02:38:37 INFO - "when": 1448275106, 02:38:37 INFO - "number": 6694473, 02:38:37 INFO - "comments": "", 02:38:37 INFO - "project": "", 02:38:37 INFO - "at": "Mon 23 Nov 2015 02:38:26", 02:38:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 02:38:37 INFO - "revlink": "", 02:38:37 INFO - "properties": [ 02:38:37 INFO - [ 02:38:37 INFO - "buildid", 02:38:37 INFO - "20151123011114", 02:38:37 INFO - "Change" 02:38:37 INFO - ], 02:38:37 INFO - [ 02:38:37 INFO - "builduid", 02:38:37 INFO - "a467d0821592459483505b7396d748b1", 02:38:37 INFO - "Change" 02:38:37 INFO - ], 02:38:37 INFO - [ 02:38:37 INFO - "pgo_build", 02:38:37 INFO - "True", 02:38:37 INFO - "Change" 02:38:37 INFO - ] 02:38:37 INFO - ], 02:38:37 INFO - "revision": "e722799fa71f " 02:38:37 INFO - } 02:38:37 INFO - ], 02:38:37 INFO - "revision": "e722799fa71f " 02:38:37 INFO - } 02:38:37 INFO - } 02:38:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 02:38:37 INFO - Running post-action listener: _resource_record_post_action 02:38:37 INFO - ##### 02:38:37 INFO - ##### Running download-and-extract step. 02:38:37 INFO - ##### 02:38:37 INFO - Running pre-action listener: _resource_record_pre_action 02:38:37 INFO - Running main action method: download_and_extract 02:38:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:38: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')]} 02:38:37 INFO - https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:38:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/test_packages.json 02:38:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/test_packages.json 02:38:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:38:37 INFO - Downloaded 1302 bytes. 02:38:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:38:37 INFO - Using the following test package requirements: 02:38:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:38:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:38:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:37 INFO - u'jsshell-linux-x86_64.zip'], 02:38:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:38:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:38:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:38:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:38:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:38:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:38:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:38:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:38: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')]} 02:38:37 INFO - https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:38:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:38:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:38:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/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 02:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/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 02:38:40 INFO - Downloaded 22525522 bytes. 02:38:40 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 02:38:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:38:40 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 02:38:41 INFO - Return code: 0 02:38:41 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 02:38:41 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')]} 02:38:41 INFO - https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:38:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:38:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:38:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/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 02:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/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 02:38:43 INFO - Downloaded 22525522 bytes. 02:38:43 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 02:38:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:38:43 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 02:38:44 INFO - Return code: 0 02:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:44 INFO - https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:38:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:38:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:38:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/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 02:38:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/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 02:38:45 INFO - Downloaded 11130997 bytes. 02:38:45 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 02:38:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:38:45 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 02:38:46 INFO - Return code: 0 02:38:46 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')]} 02:38:46 INFO - https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:38:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:38:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:38:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/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 02:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RhMFtPq_SuWQLCQ87_jbdw/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 02:38:47 INFO - Downloaded 57550985 bytes. 02:38:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:38:47 INFO - mkdir: /builds/slave/test-pgo/properties 02:38:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:38:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:38:47 INFO - Contents: 02:38:47 INFO - build_url:https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:38:47 INFO - Running post-action listener: _resource_record_post_action 02:38:47 INFO - Running post-action listener: set_extra_try_arguments 02:38:47 INFO - ##### 02:38:47 INFO - ##### Running populate-webroot step. 02:38:47 INFO - ##### 02:38:47 INFO - Running pre-action listener: _resource_record_pre_action 02:38:47 INFO - Running main action method: populate_webroot 02:38:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:38:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:38:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:38:47 INFO - '../fennec_ids.txt'], 02:38:47 INFO - 'tests': ['tcheck2']}, 02:38:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:38:47 INFO - '--tppagecycles', 02:38:47 INFO - '7'], 02:38:47 INFO - 'tests': ['tsvgm']}}, 02:38:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:38:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:38:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:38:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:38:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:38:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:38:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:47 INFO - 'talos_options': ['--e10s'], 02:38:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:47 INFO - 'tests': ['damp', 'tps']}, 02:38:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:47 INFO - 'talos_options': ['--e10s'], 02:38:47 INFO - 'tests': ['damp', 'tps']}, 02:38:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:38:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:38:47 INFO - 'other': {'tests': ['a11yr', 02:38:47 INFO - 'ts_paint', 02:38:47 INFO - 'tpaint', 02:38:47 INFO - 'sessionrestore', 02:38:47 INFO - 'sessionrestore_no_auto_restore']}, 02:38:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:38:47 INFO - 'tests': ['a11yr', 02:38:47 INFO - 'ts_paint', 02:38:47 INFO - 'tpaint', 02:38:47 INFO - 'sessionrestore', 02:38:47 INFO - 'sessionrestore_no_auto_restore']}, 02:38:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:38:47 INFO - 'tests': ['a11yr', 02:38:47 INFO - 'ts_paint', 02:38:47 INFO - 'tpaint', 02:38:47 INFO - 'sessionrestore', 02:38:47 INFO - 'sessionrestore_no_auto_restore']}, 02:38:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:38:47 INFO - 'tests': ['a11yr', 02:38:47 INFO - 'ts_paint', 02:38:47 INFO - 'tpaint', 02:38:47 INFO - 'sessionrestore', 02:38:47 INFO - 'sessionrestore_no_auto_restore']}, 02:38:47 INFO - 'other_l64': {'tests': ['a11yr', 02:38:47 INFO - 'ts_paint', 02:38:47 INFO - 'tpaint', 02:38:47 INFO - 'sessionrestore', 02:38:47 INFO - 'sessionrestore_no_auto_restore']}, 02:38:47 INFO - 'other_nol64': {'tests': ['a11yr', 02:38:47 INFO - 'ts_paint', 02:38:47 INFO - 'tpaint', 02:38:47 INFO - 'sessionrestore', 02:38:47 INFO - 'sessionrestore_no_auto_restore']}, 02:38:47 INFO - 'svgr': {'tests': ['tsvgx', 02:38:47 INFO - 'tsvgr_opacity', 02:38:47 INFO - 'tart', 02:38:47 INFO - 'tscrollx', 02:38:47 INFO - 'cart']}, 02:38:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:38:47 INFO - 'tests': ['tsvgx', 02:38:47 INFO - 'tsvgr_opacity', 02:38:47 INFO - 'tart', 02:38:47 INFO - 'tscrollx', 02:38:47 INFO - 'cart']}, 02:38:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:47 INFO - 'tests': ['tp5o']}, 02:38:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:47 INFO - 'talos_options': ['--e10s'], 02:38:47 INFO - 'tests': ['tp5o']}, 02:38:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:47 INFO - 'talos_options': ['--xperf_path', 02:38:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:47 INFO - 'tests': ['tp5n']}, 02:38:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:47 INFO - 'talos_options': ['--e10s', 02:38:47 INFO - '--xperf_path', 02:38:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:47 INFO - 'tests': ['tp5n']}}, 02:38:47 INFO - 'talos.zip': {'path': '', 02:38:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:38:47 INFO - Running post-action listener: _resource_record_post_action 02:38:47 INFO - ##### 02:38:47 INFO - ##### Running create-virtualenv step. 02:38:47 INFO - ##### 02:38:47 INFO - Running pre-action listener: _resource_record_pre_action 02:38:47 INFO - Running main action method: create_virtualenv 02:38:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:38:47 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 02:38:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:38:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:38:48 INFO - Using real prefix '/usr' 02:38:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:38:48 INFO - Installing distribute.............................................................................................................................................................................................done. 02:38:50 INFO - Installing pip.................done. 02:38:50 INFO - Return code: 0 02:38:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:50 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 0x7f5c9d57dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0d70>, '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 0x26c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1fb0>, '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': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', '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 02:38:50 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 02:38:50 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 02:38:50 INFO - Using env: {'DISPLAY': ':0', 02:38:50 INFO - 'HOME': '/home/cltbld', 02:38:50 INFO - 'LANG': 'en_US.UTF-8', 02:38:50 INFO - 'LANGUAGE': 'en_US:en', 02:38:50 INFO - 'LOGNAME': 'cltbld', 02:38:50 INFO - 'MAIL': '/var/mail/cltbld', 02:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:50 INFO - 'MOZ_NO_REMOTE': '1', 02:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:50 INFO - 'NO_EM_RESTART': '1', 02:38:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:38:50 INFO - 'PWD': '/builds/slave/test-pgo', 02:38:50 INFO - 'SHELL': '/bin/bash', 02:38:50 INFO - 'SHLVL': '1', 02:38:50 INFO - 'TERM': 'linux', 02:38:50 INFO - 'TMOUT': '86400', 02:38:50 INFO - 'USER': 'cltbld', 02:38:50 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', 02:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:50 INFO - '_': '/tools/buildbot/bin/python'} 02:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:50 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 02:38:50 INFO - Cleaning up... 02:38:50 INFO - Return code: 0 02:38:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:50 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 0x7f5c9d57dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0d70>, '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 0x26c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1fb0>, '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': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', '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 02:38:50 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 02:38:50 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 02:38:50 INFO - Using env: {'DISPLAY': ':0', 02:38:50 INFO - 'HOME': '/home/cltbld', 02:38:50 INFO - 'LANG': 'en_US.UTF-8', 02:38:50 INFO - 'LANGUAGE': 'en_US:en', 02:38:50 INFO - 'LOGNAME': 'cltbld', 02:38:50 INFO - 'MAIL': '/var/mail/cltbld', 02:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:50 INFO - 'MOZ_NO_REMOTE': '1', 02:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:50 INFO - 'NO_EM_RESTART': '1', 02:38:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:38:50 INFO - 'PWD': '/builds/slave/test-pgo', 02:38:50 INFO - 'SHELL': '/bin/bash', 02:38:50 INFO - 'SHLVL': '1', 02:38:50 INFO - 'TERM': 'linux', 02:38:50 INFO - 'TMOUT': '86400', 02:38:50 INFO - 'USER': 'cltbld', 02:38:50 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', 02:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:50 INFO - '_': '/tools/buildbot/bin/python'} 02:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:50 INFO - Downloading/unpacking psutil>=0.7.1 02:38:50 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 02:38:50 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 02:38:50 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 02:38:50 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 02:38:50 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 02:38:50 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 02:38:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 02:38:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:38:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:38:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:52 INFO - Installing collected packages: psutil 02:38:52 INFO - Running setup.py install for psutil 02:38:52 INFO - building 'psutil._psutil_linux' extension 02:38:52 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 02:38:53 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 02:38:53 INFO - building 'psutil._psutil_posix' extension 02:38:53 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 02:38:53 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 02:38:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:53 INFO - Successfully installed psutil 02:38:53 INFO - Cleaning up... 02:38:53 INFO - Return code: 0 02:38:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5c9d57dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0d70>, '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 0x26c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1fb0>, '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': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', '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 02:38:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 02:38:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:38:53 INFO - Using env: {'DISPLAY': ':0', 02:38:53 INFO - 'HOME': '/home/cltbld', 02:38:53 INFO - 'LANG': 'en_US.UTF-8', 02:38:53 INFO - 'LANGUAGE': 'en_US:en', 02:38:53 INFO - 'LOGNAME': 'cltbld', 02:38:53 INFO - 'MAIL': '/var/mail/cltbld', 02:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:53 INFO - 'MOZ_NO_REMOTE': '1', 02:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:53 INFO - 'NO_EM_RESTART': '1', 02:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:38:53 INFO - 'PWD': '/builds/slave/test-pgo', 02:38:53 INFO - 'SHELL': '/bin/bash', 02:38:53 INFO - 'SHLVL': '1', 02:38:53 INFO - 'TERM': 'linux', 02:38:53 INFO - 'TMOUT': '86400', 02:38:53 INFO - 'USER': 'cltbld', 02:38:53 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', 02:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:53 INFO - '_': '/tools/buildbot/bin/python'} 02:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:38:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:38:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:38:55 INFO - Installing collected packages: mozsystemmonitor 02:38:55 INFO - Running setup.py install for mozsystemmonitor 02:38:55 INFO - Successfully installed mozsystemmonitor 02:38:55 INFO - Cleaning up... 02:38:55 INFO - Return code: 0 02:38:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:38:55 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')]} 02:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:55 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')]} 02:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:55 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 0x7f5c9d57dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0d70>, '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 0x26c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1fb0>, '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': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', '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 02:38:55 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 02:38:55 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 02:38:55 INFO - Using env: {'DISPLAY': ':0', 02:38:55 INFO - 'HOME': '/home/cltbld', 02:38:55 INFO - 'LANG': 'en_US.UTF-8', 02:38:55 INFO - 'LANGUAGE': 'en_US:en', 02:38:55 INFO - 'LOGNAME': 'cltbld', 02:38:55 INFO - 'MAIL': '/var/mail/cltbld', 02:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:55 INFO - 'MOZ_NO_REMOTE': '1', 02:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:55 INFO - 'NO_EM_RESTART': '1', 02:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:38:55 INFO - 'PWD': '/builds/slave/test-pgo', 02:38:55 INFO - 'SHELL': '/bin/bash', 02:38:55 INFO - 'SHLVL': '1', 02:38:55 INFO - 'TERM': 'linux', 02:38:55 INFO - 'TMOUT': '86400', 02:38:55 INFO - 'USER': 'cltbld', 02:38:55 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', 02:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:55 INFO - '_': '/tools/buildbot/bin/python'} 02:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:55 INFO - Downloading/unpacking blobuploader==1.2.4 02:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:57 INFO - Downloading blobuploader-1.2.4.tar.gz 02:38:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:38:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:38:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:38:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:38:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:57 INFO - Downloading docopt-0.6.1.tar.gz 02:38:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:38:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:38:57 INFO - Installing collected packages: blobuploader, requests, docopt 02:38:57 INFO - Running setup.py install for blobuploader 02:38:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:38:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:38:58 INFO - Running setup.py install for requests 02:38:58 INFO - Running setup.py install for docopt 02:38:58 INFO - Successfully installed blobuploader requests docopt 02:38:58 INFO - Cleaning up... 02:38:58 INFO - Return code: 0 02:38:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:38:58 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')]} 02:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:58 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')]} 02:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:58 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 0x7f5c9d57dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0d70>, '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 0x26c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1fb0>, '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': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', '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 02:38:58 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 02:38:58 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 02:38:58 INFO - Using env: {'DISPLAY': ':0', 02:38:58 INFO - 'HOME': '/home/cltbld', 02:38:58 INFO - 'LANG': 'en_US.UTF-8', 02:38:58 INFO - 'LANGUAGE': 'en_US:en', 02:38:58 INFO - 'LOGNAME': 'cltbld', 02:38:58 INFO - 'MAIL': '/var/mail/cltbld', 02:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:58 INFO - 'MOZ_NO_REMOTE': '1', 02:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:58 INFO - 'NO_EM_RESTART': '1', 02:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:38:58 INFO - 'PWD': '/builds/slave/test-pgo', 02:38:58 INFO - 'SHELL': '/bin/bash', 02:38:58 INFO - 'SHLVL': '1', 02:38:58 INFO - 'TERM': 'linux', 02:38:58 INFO - 'TMOUT': '86400', 02:38:58 INFO - 'USER': 'cltbld', 02:38:58 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', 02:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:58 INFO - '_': '/tools/buildbot/bin/python'} 02:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:38:58 INFO - Running setup.py (path:/tmp/pip-n8PWk7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:38:58 INFO - Running setup.py (path:/tmp/pip-ch5tvj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:38:58 INFO - Running setup.py (path:/tmp/pip-4mMm6V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:38:58 INFO - Running setup.py (path:/tmp/pip-1STW0M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:38:59 INFO - Running setup.py (path:/tmp/pip-fXfM2D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:38:59 INFO - Running setup.py (path:/tmp/pip-VcNNoP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:38:59 INFO - Running setup.py (path:/tmp/pip-aZPdB9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:38:59 INFO - Running setup.py (path:/tmp/pip-kpsU6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:38:59 INFO - Running setup.py (path:/tmp/pip-nJu7HC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:38:59 INFO - Running setup.py (path:/tmp/pip-sPvAxB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:38:59 INFO - Running setup.py (path:/tmp/pip-bvzteB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:38:59 INFO - Running setup.py (path:/tmp/pip-eQN7Hk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:38:59 INFO - Running setup.py (path:/tmp/pip-MDT4UO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:38:59 INFO - Running setup.py (path:/tmp/pip-RJUL2Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:38:59 INFO - Running setup.py (path:/tmp/pip-zm5odB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:38:59 INFO - Running setup.py (path:/tmp/pip-Xk1e4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:38:59 INFO - Running setup.py (path:/tmp/pip-cPpu9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:38:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:38:59 INFO - Running setup.py install for manifestparser 02:39:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:39:00 INFO - Running setup.py install for mozcrash 02:39:00 INFO - Running setup.py install for mozdebug 02:39:00 INFO - Running setup.py install for mozdevice 02:39:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:39:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:39:00 INFO - Running setup.py install for mozfile 02:39:00 INFO - Running setup.py install for mozhttpd 02:39:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:39:00 INFO - Running setup.py install for mozinfo 02:39:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:39:00 INFO - Running setup.py install for mozInstall 02:39:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:39:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:39:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:39:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:39:00 INFO - Running setup.py install for mozleak 02:39:00 INFO - Running setup.py install for mozlog 02:39:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:39:01 INFO - Running setup.py install for moznetwork 02:39:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:39:01 INFO - Running setup.py install for mozprocess 02:39:01 INFO - Running setup.py install for mozprofile 02:39:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:39:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:39:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:39:01 INFO - Running setup.py install for mozrunner 02:39:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:39:01 INFO - Running setup.py install for mozscreenshot 02:39:01 INFO - Running setup.py install for moztest 02:39:01 INFO - Running setup.py install for mozversion 02:39:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:39:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:39:01 INFO - Cleaning up... 02:39:01 INFO - Return code: 0 02:39:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:39: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')]} 02:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f5c9d57dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0d70>, '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 0x26c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1fb0>, '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': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', '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 02:39:01 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 02:39:01 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 02:39:01 INFO - Using env: {'DISPLAY': ':0', 02:39:01 INFO - 'HOME': '/home/cltbld', 02:39:01 INFO - 'LANG': 'en_US.UTF-8', 02:39:01 INFO - 'LANGUAGE': 'en_US:en', 02:39:01 INFO - 'LOGNAME': 'cltbld', 02:39:01 INFO - 'MAIL': '/var/mail/cltbld', 02:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:01 INFO - 'MOZ_NO_REMOTE': '1', 02:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:01 INFO - 'NO_EM_RESTART': '1', 02:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:39:01 INFO - 'PWD': '/builds/slave/test-pgo', 02:39:01 INFO - 'SHELL': '/bin/bash', 02:39:01 INFO - 'SHLVL': '1', 02:39:01 INFO - 'TERM': 'linux', 02:39:01 INFO - 'TMOUT': '86400', 02:39:01 INFO - 'USER': 'cltbld', 02:39:01 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', 02:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:01 INFO - '_': '/tools/buildbot/bin/python'} 02:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:39:01 INFO - Running setup.py (path:/tmp/pip-0GytOh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:39:02 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:39:02 INFO - Running setup.py (path:/tmp/pip-6amuGP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:39:02 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:39:02 INFO - Running setup.py (path:/tmp/pip-_ht1zd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:39:02 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:39:02 INFO - Running setup.py (path:/tmp/pip-lojHQY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:39:02 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:39:02 INFO - Running setup.py (path:/tmp/pip-J3vTdp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:39:02 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:39:02 INFO - Running setup.py (path:/tmp/pip-j8UDBd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:39:02 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:39:02 INFO - Running setup.py (path:/tmp/pip-gFEH7e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:39:02 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:39:02 INFO - Running setup.py (path:/tmp/pip-hEfVbQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:39:02 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:39:02 INFO - Running setup.py (path:/tmp/pip-H7iiKw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:39:02 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:39:02 INFO - Running setup.py (path:/tmp/pip-m2WbdS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:39:02 INFO - Running setup.py (path:/tmp/pip-9nQDjC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:39:02 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:39:02 INFO - Running setup.py (path:/tmp/pip-LCQge8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:39:02 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:39:02 INFO - Running setup.py (path:/tmp/pip-2JbTyq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:39:02 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)) 02:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:39:02 INFO - Running setup.py (path:/tmp/pip-K7udgv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:39:03 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)) 02:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:39:03 INFO - Running setup.py (path:/tmp/pip-SHGMTv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:39:03 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)) 02:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:39:03 INFO - Running setup.py (path:/tmp/pip-VuBrmr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:39:03 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)) 02:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:39:03 INFO - Running setup.py (path:/tmp/pip-Bgf9_U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:39:03 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)) 02:39:03 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)) 02:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:39:03 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)) 02:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:39:03 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)) 02:39:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:04 INFO - Downloading blessings-1.5.1.tar.gz 02:39:04 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 02:39:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:39:05 INFO - Installing collected packages: blessings 02:39:05 INFO - Running setup.py install for blessings 02:39:05 INFO - Successfully installed blessings 02:39:05 INFO - Cleaning up... 02:39:05 INFO - Return code: 0 02:39:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:39:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:39:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:39:05 INFO - Reading from file tmpfile_stdout 02:39:05 INFO - Current package versions: 02:39:05 INFO - argparse == 1.2.1 02:39:05 INFO - blessings == 1.5.1 02:39:05 INFO - blobuploader == 1.2.4 02:39:05 INFO - docopt == 0.6.1 02:39:05 INFO - manifestparser == 1.1 02:39:05 INFO - mozInstall == 1.12 02:39:05 INFO - mozcrash == 0.16 02:39:05 INFO - mozdebug == 0.1 02:39:05 INFO - mozdevice == 0.47 02:39:05 INFO - mozfile == 1.2 02:39:05 INFO - mozhttpd == 0.7 02:39:05 INFO - mozinfo == 0.9 02:39:05 INFO - mozleak == 0.1 02:39:05 INFO - mozlog == 3.1 02:39:05 INFO - moznetwork == 0.27 02:39:05 INFO - mozprocess == 0.22 02:39:05 INFO - mozprofile == 0.27 02:39:05 INFO - mozrunner == 6.11 02:39:05 INFO - mozscreenshot == 0.1 02:39:05 INFO - mozsystemmonitor == 0.0 02:39:05 INFO - moztest == 0.7 02:39:05 INFO - mozversion == 1.4 02:39:05 INFO - psutil == 3.1.1 02:39:05 INFO - requests == 1.2.3 02:39:05 INFO - wsgiref == 0.1.2 02:39:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f5c9d57dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0d70>, '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 0x26c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1fb0>, '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': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', '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 02:39:05 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 02:39:05 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 02:39:05 INFO - Using env: {'DISPLAY': ':0', 02:39:05 INFO - 'HOME': '/home/cltbld', 02:39:05 INFO - 'LANG': 'en_US.UTF-8', 02:39:05 INFO - 'LANGUAGE': 'en_US:en', 02:39:05 INFO - 'LOGNAME': 'cltbld', 02:39:05 INFO - 'MAIL': '/var/mail/cltbld', 02:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:05 INFO - 'MOZ_NO_REMOTE': '1', 02:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:05 INFO - 'NO_EM_RESTART': '1', 02:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:39:05 INFO - 'PWD': '/builds/slave/test-pgo', 02:39:05 INFO - 'SHELL': '/bin/bash', 02:39:05 INFO - 'SHLVL': '1', 02:39:05 INFO - 'TERM': 'linux', 02:39:05 INFO - 'TMOUT': '86400', 02:39:05 INFO - 'USER': 'cltbld', 02:39:05 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', 02:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:05 INFO - '_': '/tools/buildbot/bin/python'} 02:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 INFO - Cleaning up... 02:39:05 INFO - Return code: 0 02:39:05 INFO - Running post-action listener: _resource_record_post_action 02:39:05 INFO - Running post-action listener: _start_resource_monitoring 02:39:05 INFO - Starting resource monitoring. 02:39:05 INFO - ##### 02:39:05 INFO - ##### Running install step. 02:39:05 INFO - ##### 02:39:05 INFO - Running pre-action listener: _resource_record_pre_action 02:39:05 INFO - Running main action method: install 02:39:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:39:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:39:05 INFO - Reading from file tmpfile_stdout 02:39:05 INFO - Detecting whether we're running mozinstall >=1.0... 02:39:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:39:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:39:05 INFO - Reading from file tmpfile_stdout 02:39:05 INFO - Output received: 02:39:05 INFO - Usage: mozinstall [options] installer 02:39:05 INFO - Options: 02:39:05 INFO - -h, --help show this help message and exit 02:39:05 INFO - -d DEST, --destination=DEST 02:39:05 INFO - Directory to install application into. [default: 02:39:05 INFO - "/builds/slave/test-pgo"] 02:39:05 INFO - --app=APP Application being installed. [default: firefox] 02:39:05 INFO - mkdir: /builds/slave/test-pgo/build/application 02:39:05 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'] 02:39:05 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 02:39:20 INFO - Reading from file tmpfile_stdout 02:39:20 INFO - Output received: 02:39:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:39:20 INFO - Running post-action listener: _resource_record_post_action 02:39:20 INFO - ##### 02:39:20 INFO - ##### Running run-tests step. 02:39:20 INFO - ##### 02:39:20 INFO - Running pre-action listener: _resource_record_pre_action 02:39:20 INFO - Running main action method: run_tests 02:39:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:39:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:39:20 INFO - Python 2.7.3 02:39:20 INFO - Return code: 0 02:39:20 INFO - grabbing minidump binary from tooltool 02:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:20 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 0x26c0d70>, '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 0x26c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:39:20 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 02:39:20 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 02:39:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:39:20 INFO - Return code: 0 02:39:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:39:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:39:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:39:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:39:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:39:20 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 02:39:20 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 02:39:20 INFO - Using env: {'DISPLAY': ':0', 02:39:20 INFO - 'HOME': '/home/cltbld', 02:39:20 INFO - 'LANG': 'en_US.UTF-8', 02:39:20 INFO - 'LANGUAGE': 'en_US:en', 02:39:20 INFO - 'LOGNAME': 'cltbld', 02:39:20 INFO - 'MAIL': '/var/mail/cltbld', 02:39:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:39:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:20 INFO - 'MOZ_NO_REMOTE': '1', 02:39:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:20 INFO - 'NO_EM_RESTART': '1', 02:39:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:39:20 INFO - 'PWD': '/builds/slave/test-pgo', 02:39:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:39:20 INFO - 'SHELL': '/bin/bash', 02:39:20 INFO - 'SHLVL': '1', 02:39:20 INFO - 'TERM': 'linux', 02:39:20 INFO - 'TMOUT': '86400', 02:39:20 INFO - 'USER': 'cltbld', 02:39:20 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729', 02:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:20 INFO - '_': '/tools/buildbot/bin/python'} 02:39:20 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] with output_timeout 3600 02:39:20 INFO - mozversion INFO | application_buildid: 20151123011114 02:39:20 INFO - mozversion INFO | application_changeset: e722799fa71f653c31454612564c213d09566219 02:39:20 INFO - mozversion INFO | application_display_name: Nightly 02:39:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:39:20 INFO - mozversion INFO | application_name: Firefox 02:39:20 INFO - mozversion INFO | application_remotingname: firefox 02:39:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:39:20 INFO - mozversion INFO | application_vendor: Mozilla 02:39:20 INFO - mozversion INFO | application_version: 45.0a1 02:39:20 INFO - mozversion INFO | platform_buildid: 20151123011114 02:39:20 INFO - mozversion INFO | platform_changeset: e722799fa71f653c31454612564c213d09566219 02:39:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:39:20 INFO - mozversion INFO | platform_version: 45.0a1 02:39:20 INFO - 2015-11-23 02:39:20,627 DEBUG : using testdate: 1448275160 02:39:20 INFO - 2015-11-23 02:39:20,627 DEBUG : actual date: 1448275160 02:39:20 INFO - 2015-11-23 02:39:20,749 INFO : starting webserver on 'localhost:33104' 02:39:20 INFO - 2015-11-23 02:39:20,750 INFO : Starting test suite talos-linux64-ix-055.e 02:39:20 INFO - 2015-11-23 02:39:20,750 INFO : Starting test dromaeo_css 02:39:20 INFO - 2015-11-23 02:39:20,750 DEBUG : operating with platform_type : linux_ 02:39:20 INFO - 2015-11-23 02:39:20,751 INFO : Initialising browser for dromaeo_css test... 02:39:20 INFO - 2015-11-23 02:39:20,761 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVadIOu/profile http://localhost:33104/getInfo.html 02:39:25 INFO - 2015-11-23 02:39:25,425 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:39:25 INFO - 2015-11-23 02:39:25,426 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:39:25 INFO - 2015-11-23 02:39:25,426 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:39:25 INFO - 2015-11-23 02:39:25,426 DEBUG : BROWSER_OUTPUT: __metrics 02:39:26 INFO - 2015-11-23 02:39:26,428 INFO : Browser initialized. 02:39:26 INFO - 2015-11-23 02:39:26,429 INFO : Running cycle 1/1 for dromaeo_css test... 02:39:26 INFO - 2015-11-23 02:39:26,429 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVadIOu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:39:38 INFO - 2015-11-23 02:39:38,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 141074432 02:39:38 INFO - 2015-11-23 02:39:38,215 DEBUG : BROWSER_OUTPUT: 02:40:27 INFO - 2015-11-23 02:40:27,846 DEBUG : BROWSER_OUTPUT: 1448275227838 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] 02:42:36 INFO - 2015-11-23 02:42:36,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33104/tests/dromaeo/cssquery-ext.html) 02:42:38 INFO - 2015-11-23 02:42:38,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 147554304 02:42:38 INFO - 2015-11-23 02:42:38,136 DEBUG : BROWSER_OUTPUT: 02:45:40 INFO - 2015-11-23 02:45:40,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/dromaeo/cssquery-ext.html (next: http://localhost:33104/tests/dromaeo/cssquery-jquery.html) 02:45:40 INFO - 2015-11-23 02:45:40,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 141967360 02:45:40 INFO - 2015-11-23 02:45:40,695 DEBUG : BROWSER_OUTPUT: 02:48:42 INFO - 2015-11-23 02:48:42,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33104/tests/dromaeo/cssquery-mootools.html) 02:48:43 INFO - 2015-11-23 02:48:43,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 142516224 02:48:43 INFO - 2015-11-23 02:48:43,014 DEBUG : BROWSER_OUTPUT: 02:51:44 INFO - 2015-11-23 02:51:44,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33104/tests/dromaeo/cssquery-prototype.html) 02:51:45 INFO - 2015-11-23 02:51:45,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 140410880 02:51:45 INFO - 2015-11-23 02:51:45,280 DEBUG : BROWSER_OUTPUT: 02:54:47 INFO - 2015-11-23 02:54:47,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33104/tests/dromaeo/cssquery-yui.html) 02:54:48 INFO - 2015-11-23 02:54:48,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 141922304 02:54:48 INFO - 2015-11-23 02:54:48,173 DEBUG : BROWSER_OUTPUT: 02:57:50 INFO - 2015-11-23 02:57:50,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/dromaeo/cssquery-yui.html (next: http://localhost:33104/tests/dromaeo/cssquery-dojo.html) 02:57:50 INFO - 2015-11-23 02:57:50,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 144330752 02:57:50 INFO - 2015-11-23 02:57:50,676 DEBUG : BROWSER_OUTPUT: 02:57:50 INFO - 2015-11-23 02:57:50,676 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:57:50 INFO - 2015-11-23 02:57:50,676 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:57:50 INFO - 2015-11-23 02:57:50,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:57:50 INFO - 2015-11-23 02:57:50,677 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:57:50 INFO - 2015-11-23 02:57:50,677 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3233.240188555689;3249.3988612106778;3286.86852525899;3305.272839975206;3322.252493189033;5293.391260005101;5485.286912701353;5546.112621980479;5550.916736248954;5556.222128901952;5434.701091439969;5443.428440013801;5516.558675305976;5522.392536820947;5547.583931205156;4949.133901567229;5005.0990821652085;5116.667416617908;5153.768080436389;5158.045761534128;4919.508049195088;5069.695818250917;5091.79632814687;5094.1085310070775;5173.379194496666;4941.901161976758;4969.006198760262;5079.466656001141;5089.211172268304;5108.208227724708;5015.974920125376;5029.647924645276;5034.3455350804525;5074.441811400743;5086.287919691209;4934.6052315815;4995.625328100371;5014.799408023711;5024.447310795809;5058.3929928408825;5252.947470525322;5286.418493965661;5292.20616907467;5297.231901374279;5373.086575282211;5836.503897168745;5863.355030946635;5863.736131874076;5870.501007414375;5936.881262374772;5781.710914454303;5803.100519419497;5898.64608123514;5911.172435858984;5938.406159384071;5595.888082238333;5603.411641777596;5617.691026993554;5631.2960879890015;5651.2370829937845;6090.33006369299;6106.297775755845;6149.0776383542825;6151.784687535915;6158.137860699506;5727.31272247333;5784.797532086441;5853.560982926212;5930.140129681172;5939.70301484924;5940.287165540163;5956.702164891738;5961.731722072431;5973.790917317873;5993.130996005642;5938.406159384113;5950.67271300074;5991.610545314627;5992.280926288873;5997.1304160896425;5778.797742079007;5896.1450589664255;5907.2911250650195;5911.083782013795;5912.17229587858;4499.707519011254;4533.297338912474;4560.840370587013;4566.794494247767;4570.6800523963;4025.5974402560096;4056.8377264909072;4058.188362327546;4064.5732198119363;4086.203190377848;5532.972335138298;5648.63283886546;5664.773409063674;5677.716114194273;5705.2012718219485;5823.708814559255;5891.793787217427;5970.552208584373;6005.939940600538;6018.067199584071;5652.830415087554;5681.147827825859;5751.1085781703905;5764.798232061858;5765.221695071195;4988.850334489971;5136.1525348317855;5210.609204309692;5233.502817232356;5263.894722105537;6114.510272098727;6153.692315384213;6238.656873871981;6319.8104056878365;6326.557141000178;5915.58590898633;5958.672273025025;5972.402759723993;5980.0431930890845;6027.487663548647;5890.823275301748;5999.670018149044;6175.62946223228;6175.96912015437;6184.938150618436;5804.419558044331;5876.294844618673;5878.2064421304285;5881.735321910439;5919.171316015675;5936.970315148396;5974.044152935509;5981.043033114681;5983.880322393615;5993;5660.122680984454;5706.629069110494;5725.055365864586;5821.970890145522;5836.358000619844;5856.443637854397;5864.44287792659;5867.119932010232;5872.677002764889;5880.235569375954;5755.884882302246;5763.423657634371;5768.740406681625;5772.971135144466;5778.8266352009505;5585.1901474286815;5762.279715035621;5776.046952252831;5860.560457965585;5872.442117998783;5583.162525621189;5703.287089113861;5730.541556675373;5731.369549349485;5735.168400581809 02:57:50 INFO - 2015-11-23 02:57:50,678 DEBUG : BROWSER_OUTPUT: |1;ext.html;539.4309004000779;543.2611648158506;547.7370861986248;579.8637320229743;580.5674772294641;38492.23015539691;38990.22019559607;39014.414783778266;39150.21699566007;39161.60838391615;42060.36909446361;42271.57728422715;42283.36574951371;42396.152076958446;42496;8564.057953625112;8666;8697.869531957025;8699.565021748918;8705.129487051276;8579.442336248156;8646.135386461336;8687.695930642429;8697.260732837685;8726.86909696355;8611.095834937336;8655.437396569203;8692.043875173726;8712.259457946082;8714.956425217864;8616.526091064989;8636.39545231834;8672.219500245008;8698.434601750865;8700.564971751419;8581.914180858173;8672.696455624086;8744.737657870273;8746.781330466725;8754.343424243143;39314.80342598269;39547.8022609888;39662.20675586472;39891.40162897559;39959.8002009991;3246.853891574885;3443.707284880788;3448.5516882805327;3890.0469385000574;3948.486696729407;29527;29814.053903475033;29972.70027299721;30041.248968775737;30257.697423025707;3843.34881862232;3869.303525365433;3901.2782635212575;3948.545917219528;4035.959640403617;249708;250685;251123;251129;251953;41659.1668166635;55200.72399637976;55222;55392;55718.72140639271;40844.591554084676;40989.950502474756;41036.38445423321;41044.43289073794;41207;13050.151740137051;13150.07949443549;13162.736745265232;13193.802092968614;13197.340132993504;9786.314957952874;9879.901200987899;9901.75245618851;9947;9957.352772069793;14003.439862405594;14305.78541321881;14399.496017639332;14404.351804168837;14411.495597654242;5765.221695071112;5800.100984347433;5856.941430585724;5896.616719913192;5918.171455996164;905.8686490458847;939.5771902643837;1029.7425643589104;1036.1555332404066;1042.6142327338782;27502.449951000868;32042.35915281728;32676;32764.344713105605;33036;986.284943416032;1029.984550231747;1063.4682658670665;1065.2969040433431;1098.0995583621514;16274;16904.830951690572;16938.322467101425;17166;17324.220410081576;371318;372394.414083789;376544;377977;379567;53296;53761.46238537564;53846;53989.46010539923;53994.46005539973;1303.478608556566;1315.967100822468;1321.0554453565746;1323.503686117706;1325.032726109945;28351.71648283491;29411;29778.851105744332;29811.55282670805;30038.849805751706;45466;45878.31182532198;45879.77060114678;45965;46231.53768462272;287152;292768;293144;293268;293617;32020.35959280755;45116;45412.09175816399;45844;45978;43141.352879707454;43368;43383.566164339216;43683.344749828146;43751.78124109359;37012.81493592515;37165.62834371622;37368.81315593405;37583.62416375911;38823.611763882;36611.901642950754;36946.261074777816;37216.25567488581;37465.4380184292;37645.81177094097;36467.45298820467;36606;36737.26525469422;36845.81577092098;38095.23809523849;30959;31904;34067.82966085154;34091.82954085214;40227.59772402239;27312.317192070357;27834.30414239579;27898.581521276792;28047.859760701067;28193.57709634316 02:57:50 INFO - 2015-11-23 02:57:50,682 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.1281808297337;355.4880971401182;359.6439524870379;360.5241081772062;362.9038304849214;16474.83525164748;16818.579535511602;17369.739453908187;17430;18081.7287740684;15627.453039143633;15760.527184184493;16030.35878564856;16064;16130.354785808582;4754.096721622889;4840.201366774478;4846.781894814724;4868.440129385113;4876.73177975213;4823.276508523714;4834.057358815033;4864.318995340655;4870.707757534559;4894.192458244385;4160.500739911215;4294.506131794837;6201.720922558473;6405.039244113374;6538.346165383471;6632.071509988606;6638.269790323061;6654.600723956578;6674.16572928384;6712.664366781666;6297.086922396227;6363.300036995926;6376.9681151594405;6439.549231553793;6444.838879028015;22398.55202895933;22560;22787;23221.7677823223;23822.404439888967;2048.2523878784286;2134.274346722106;2161.6757486377014;2171.8588291760984;2317.5364927014666;14286.499972501017;14363.928180359031;14586.197759123244;14630;14810.703785924328;1909.6849019911697;1996.0119740728433;2000.4598758335314;2009.25657506722;2018.495376155961;63778;64753;70385.64807175931;70419.64790176017;71670.2832971674;15358.308876100602;15493.845061549466;15495;15495.922520387552;15584.376624934876;23990.88004559966;24108.276751697478;24246.15138470145;24247.7575224249;24397.878010609835;8459.450135741157;8644.178803013703;8669.826603467895;8696.695615653422;8732.126787321216;7252.5648461092505;7261.782146535613;7304.671289791972;7357.153927298322;7368.15266244378;7656.349210317074;7748.6125693715085;7758.844823103506;7763.456558040883;7778.105517865405;3029.727324540802;3083.429565530384;3092.3969825884187;3118.5892476553163;3221.4684577044527;388.3281922274481;392.45644781977165;417.1573421688173;423.1621389648513;426.1689705075116;14966.17686027279;15581.376744930076;17332.480025599252;17412.825871741374;17777.46667599974;881.6980408370565;887.3211992825494;917.3211823250747;924.4037595750704;1012.9088382045651;9332.90667093334;9386.577604007836;9769.218462522982;9890.357126786736;9966.35218710796;372849;374601;376468;377107;557452;61503;64809.519048094815;67978.66010670013;73488.63255683688;74526.6273668639;1058.6771034834296;1085.2999815119204;1093.4969913839723;1096.9780604387868;1097.4841824342545;14753.557393278219;15176;15313.693726125637;15443.459478918634;15602.921985390001;33345.33309333751;33427.33145337031;33585;34240.143996400286;34569.48145777866;43583.34624980565;43897;44086.55913440824;44522.55477445184;46958.530414695415;9082.636694532144;9215.76960575991;9221.769455763659;9314.44113353201;9343.252539796937;12544.372781361079;17026;17642.206100725754;17766.644667106844;17886.105694715472;13614.50240473567;13641.454341826216;13910.791338129733;14246.430142794172;14315.141091534124;13711.382987765774;13919.23444210578;13980.720385592434;14173.36219870129;14239.857601424268;13653.180809151483;14055.789163162357;14138;14401.567952961428;14515.274236287933;8603.225709685908;8615.569221539023;8782.209601135928;8822.602982865657;8916.598753056258;9245.86131208019;11906.702332441759;13771.931140344233;13929.58211253664;13986.370613322628 02:57:50 INFO - 2015-11-23 02:57:50,683 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1525.725369433503;1645.3336398758502;1706.9743953840696;1729.135432283858;1745.6334169824336;6900.5514641548325;6938.514303998722;6974.721011159554;7212.567245965232;7394.186639469667;7535.2464753524755;7553.811154721135;7572.053493313336;7626.389888808896;7643.197464266242;2214.6124428225035;2245.1805091141696;2248.325502349297;2251.8198544116512;2256.458449972003;2227.6992605998144;2270.182734215681;2280.110756804839;2294.208498068172;2295.4146692593367;2203.680466332381;2213.8228941684706;2239.6528538076623;2247.438140464884;2248.955020899581;2200.9889950550223;2270.8523945943625;2271.171022576756;2274.8180145588312;2275.0217406515276;2237.7985981261763;2267.399139228106;2275.1354485295483;2287.0623044551653;2296.781805728453;7578.204288549678;7653.196414376466;7658;7668.041494813148;7679;4480.350349199348;4497.572730590588;4529.320601909707;4543.273076307808;4551.590356867865;2941.0882626385887;3013.8342391168476;3058.250728571514;3063.9540406893916;3075.369549242422;962.8507581324906;966.3235734985539;972.9178122229001;980.54404701814;1009.6365308488938;10362.222833287533;10398.428086455242;10403.011713887094;10416.42709650969;10446.164306855433;3949.269385163754;3960.7821569813937;3971.821268042945;4001.7198796083994;4004.3392840181627;8427.873581896276;8440.620172092147;8443;8457.619407126695;8458.365622578209;4488.528704486047;4491.191585514639;4511.684182107221;4515.9774201128785;4525.456945166601;4115.97942010294;4125.752454852718;4130.318497447947;4144.254034273859;4147.149834283965;3306.702396784301;3319.55186049885;3325.0856014595697;3350.0284917373688;3351.7151042161204;1024.3137098144261;1034.250168627754;1036.5076588620345;1041.3647674918293;1042.1506472225112;973.4597298499401;987.3779518903045;1016.903394177552;1051.4164638625637;1282.7819270723999;6987.965060174666;7127.322904324081;7143.464240182007;7147.463940204506;7149.7497587584185;1070.1171533484905;1088.357868857378;1107.8504401905639;1111.7887601355717;1118.5246270335076;5636.210930469655;5654.886902261932;5657.038303488417;5685.715714214272;5687.630304030307;8717.607707653171;8725.258353039935;8930.374873758774;8935.463872167691;9050.140236677506;8876.556172191365;8882.86675699865;8886.73339799807;8922.68770593026;8941.284697224206;6936.895946560806;6979;6999.335063168991;7000.964995174992;7027.543209691456;6775.1531058617675;6811.863762724619;6817.079694241214;6817.93182068173;6832.59004459734;7349.595772232365;7677.462577619513;7714.382849372149;7752.1472638008645;7809.921900781147;7595.924040759522;7734.2265773422205;7796.415268854972;7808.726694565663;7952.681892724227;6467.159269294962;6666.666666666744;6791.864162716619;6843.144606924135;6866.656667166521;7113.928860711534;7117.217106118426;7138.143422789299;7144.928550714426;7151.964240178974;6536.673166341759;6556.213254409501;6631.3700198481065;6693.062971183941;6816.693248803915;6489.675516224264;6531.673416329069;6607.471402287902;6750;6880.518363714492;6792;6830.624315662686;6845.760398386033;6875.278095799869;6888.793336199922;6202.81391558254;6231.065340199007;6242.719077641426;6249.6562689052535;6269.404406581368;6298.779542715983;6310.684465776784;6317.147185129948;6326.6836658165985;6328.873422531616 02:57:50 INFO - 2015-11-23 02:57:50,684 DEBUG : BROWSER_OUTPUT: |4;prototype.html;312.60455523762437;314.28029811731125;318.58583841006686;320.94864821628545;325.7508006375122;6250.218722659668;6328.5886417382835;6420.293767685551;6447.032945058238;6493.058506516552;6246.406591373823;6301.527385446098;6303.684815759217;6322.462590679786;6324.715387807548;4557.475890272628;4740.549647783472;4742.217534106868;4751.501092385284;4761.690490118149;4695.67130300879;4697.953020469786;4703.6472264580125;4727.574518293353;4737.644676649265;4652.767361631922;4657;4666.300054991744;4667.486576476585;4679.719216847;4667.509911459299;4669.929951050703;4683.157031734287;4683.344331793552;4685.086408150412;3895.61043895611;3971.0667993021616;4022.8591999279884;4023.155137421145;4035.7376770509823;5897.823065308047;5918.585699001072;5939;5944.673042982634;5974.940250597525;5317.813876514303;5359.651622644516;5380.946190538084;5402.054640437907;5409.648372855791;6615.17310336208;6625.436837868739;6629.635370054645;6630;6641.302663220341;4327.177836211141;4394.1870753910625;4400.075984043355;4407.162639098561;4413.845515406945;6842.521023528355;6903.309669033107;6916.20463646677;6923.653817309165;6938.618375989318;4471.5081341052455;4484.8430304939175;4485.147821913826;4490.887727806766;4493.752843593568;4441.511433742286;4551.681382303207;4552.567506086916;4553;4557.156925968707;5358.5177334039345;5394.811181608625;5416.485433883775;5416.539594134542;5420.674759514362;6711.530192886548;6720.865582688417;6729.5625784323865;6731.158605174353;6736.124303840567;1603.5670369000304;1609.8148712898167;1615.0794047393108;1616.765568992513;1620.9270582823801;1042.0673497220098;1043.0351924469835;1043.3583346242158;1051.8474821151044;1069.673749506408;6423.293437721847;6430.48556115519;6446.194225721785;6508.088867558546;6533.562616224423;6932.0988271524375;6970.407515361149;6972.163340399185;6974.197967233732;6985.336393042653;6485.9946708260295;6519.152510173647;6541.803745887631;6546.574472659262;6554.8361290968105;3709.295233905549;3758.098056466483;3763.2473505298503;3776.2069965307046;3781.905452363713;7245;7245.311695388929;7246.818829529304;7261.818454538573;7266.564006159648;7100;7141.535800172972;7155.570665759967;7157.2127066022695;7171;7124.43004559634;7212.71149154028;7233.782986510413;7251.963740181265;7257.419406447471;6914.170299564084;6943.47923905699;6953.68708408133;6968;6996.930030699627;6903.930960690329;6906.758263460755;6908.3437073477935;6908.896366554405;6911.067005954132;7112.288771122846;7182.2099569048405;7205.495615306878;7229.566226026455;7238.710451581877;4578.9771051144535;4603.58567728906;4609.423822022247;4614.123316569975;4624.838130665411;6908.896366554405;6935.930640693528;6944.652767361511;6948.652567371712;6964.129483814523;6639.734410623714;6756.087928129836;6812.523123381316;6814.114165158696;6832.555883867532;6734.629595372302;6749;6789.93210067893;6795;6802.115724955724;6477.1579694639395;6638.867222655424;6660.400563949268;6681.432078273401;6681.532292739462;6630.46956243509;6768.7292508299115;6792;6793.150856142982;6814.488913331421;6542.116814230209;6543.378379053982;6587.505937054836;6609.702563384755;6617.933820661924 02:57:50 INFO - 2015-11-23 02:57:50,686 DEBUG : BROWSER_OUTPUT: |5;yui.html;735.2316828913786;861.2076889261882;867.9869801952968;882.2743071027535;885.5173930208034;13511.79732304015;13857.653558661039;13887.722245555084;13893.861061389396;13920.582382528528;13188.142770719896;13213.537526186585;13249.138805977629;13280.269585172811;13351.732965340687;808.1796976069294;809.8744694572322;816.3265306122443;825.2984962781618;828.2214718164936;833.754042557444;837.5058715357937;838.3502785341349;843.8607629741085;844.8056946902216;864.2178828160494;866.3805379153904;870.8519551676198;871.5337294547419;872.0581771686595;852.1861622150863;858.5707146426787;859.5057841740961;861.4745005546612;862.5169904853271;629.0752593687272;630.6153246519619;634.0964126120306;634.6636282770139;636.8248731598801;14102.858971410256;14165.504207352797;14204.85795142056;14214.289285535682;14269.928650356682;11922.523099076026;12229.571964981184;12263.325517096557;12430.192037517532;12706.809397859039;10151.492425378776;10210.2852800304;10483.68548943533;10615.065515247006;10816.891831081746;3581.3752600146;3599.982000090009;3631.455281707765;3634.945475817865;3674.2835147146316;43509.78245108754;43709.56290437087;43780.78109609464;43865.34201986973;43907;9517.381370210915;9852.45811480361;9882.752931176778;10131.392116473035;10425.530851111567;17234.65530689379;17365.131743412778;17398.826011739722;17468.30126794914;17487.387941422243;7218.783436496913;7457.589832559262;7465.664045117983;7531.472796904164;7627.313541781266;4069.348904175318;4110.938335924963;4111.342185250345;4111.753294802262;4126.587341265849;3078.076577026883;3080.7073328033803;3085.41377138343;3086.089603566953;3107.9689203107678;522.0967725834328;538.9919151212735;541.3449725831709;562.9268195134606;563.1383982506771;607.6475644126396;630.5239544144142;657.9407853293227;663.4526515624628;706.3783870194196;8144.918550814535;8323.5005899645;8397.832043359098;8546.529940853312;8619.310455163572;508.46611058388544;525.3643091858817;650.3951325267547;674.4873895839099;682.4199430484049;3687.3362794697214;3755;3819.4652748615217;3858.6334298241622;3930.9582960515486;52745;57657.13514297289;58005.70997144987;59374.40625593689;59667.403325967054;50415;50773.23840142401;52307;52535.474645253824;53066.73466632642;45001.324980125326;46680.53319466898;48543.75728121407;48574.514254857706;48783.268250975554;7925.167857374892;8125.512469251864;8441.32469402434;8456.2812160967;8518.275946544612;36091.278174435836;36439.81780091082;36500;36604.81697591495;36617.63382366249;41425.585744142176;41814.163716724885;44154.55845441505;45905.31142032939;46073.76963115163;10346.793064138525;10591.5233814477;10614.416207108683;10669.946650266698;11266.098712103176;11591.478383472595;11779.175457717878;11827.408629568316;11955.581554645545;12015.519379224734;10528.473576321307;10690.518926648165;10731.40977246259;10950.890491095306;11009.174311926477;10715.732106697395;10788.568457261621;10891.346519208873;11248.7750244993;11336.489857956576;10364.948175259377;11101.888981110085;11116.777664446505;11276.210665253353;11529.769404612029;9392.295577831554;9623;9645.324827262024;9830.55762490704;9865.112139907444;8855.73432797017;9240.168384845396;9529.76113105292;9604.9039509604;9659.46872921996 02:57:50 INFO - 2015-11-23 02:57:50,686 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:57:50 INFO - 2015-11-23 02:57:50,686 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:57:50 INFO - 2015-11-23 02:57:50,686 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,301 02:57:50 INFO - 2015-11-23 02:57:50,686 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:57:50 INFO - 2015-11-23 02:57:50,686 DEBUG : BROWSER_OUTPUT: __startTimestamp1448276270674__endTimestamp 02:57:50 INFO - 2015-11-23 02:57:50,686 DEBUG : BROWSER_OUTPUT: 02:57:50 INFO - 2015-11-23 02:57:50,686 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:57:50 INFO - 2015-11-23 02:57:50,686 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:57:50 INFO - 2015-11-23 02:57:50,686 DEBUG : BROWSER_OUTPUT: 02:57:50 INFO - 2015-11-23 02:57:50,687 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5515.90 Median:5751.11 stddev:622.50 (10.8%) stddev-sans-first:598.10 02:57:50 INFO - 2015-11-23 02:57:50,687 DEBUG : BROWSER_OUTPUT: Values: 3233.2 3249.4 3286.9 3305.3 3322.3 5293.4 5485.3 5546.1 5550.9 5556.2 5434.7 5443.4 5516.6 5522.4 5547.6 4949.1 5005.1 5116.7 5153.8 5158.0 4919.5 5069.7 5091.8 5094.1 5173.4 4941.9 4969.0 5079.5 5089.2 5108.2 5016.0 5029.6 5034.3 5074.4 5086.3 4934.6 4995.6 5014.8 5024.4 5058.4 5252.9 5286.4 5292.2 5297.2 5373.1 5836.5 5863.4 5863.7 5870.5 5936.9 5781.7 5803.1 5898.6 5911.2 5938.4 5595.9 5603.4 5617.7 5631.3 5651.2 6090.3 6106.3 6149.1 6151.8 6158.1 5727.3 5784.8 5853.6 5930.1 5939.7 5940.3 5956.7 5961.7 5973.8 5993.1 5938.4 5950.7 5991.6 5992.3 5997.1 5778.8 5896.1 5907.3 5911.1 5912.2 4499.7 4533.3 4560.8 4566.8 4570.7 4025.6 4056.8 4058.2 4064.6 4086.2 5533.0 5648.6 5664.8 5677.7 5705.2 5823.7 5891.8 5970.6 6005.9 6018.1 5652.8 5681.1 5751.1 5764.8 5765.2 4988.9 5136.2 5210.6 5233.5 5263.9 6114.5 6153.7 6238.7 6319.8 6326.6 5915.6 5958.7 5972.4 5980.0 6027.5 5890.8 5999.7 6175.6 6176.0 6184.9 5804.4 5876.3 5878.2 5881.7 5919.2 5937.0 5974.0 5981.0 5983.9 5993.0 5660.1 5706.6 5725.1 5822.0 5836.4 5856.4 5864.4 5867.1 5872.7 5880.2 5755.9 5763.4 5768.7 5773.0 5778.8 5585.2 5762.3 5776.0 5860.6 5872.4 5583.2 5703.3 5730.5 5731.4 5735.2 02:57:50 INFO - 2015-11-23 02:57:50,687 DEBUG : BROWSER_OUTPUT: 02:57:50 INFO - 2015-11-23 02:57:50,687 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47189.69 Median:21457.85 stddev:81420.29 (379.4%) stddev-sans-first:81573.36 02:57:50 INFO - 2015-11-23 02:57:50,688 DEBUG : BROWSER_OUTPUT: Values: 539.4 543.3 547.7 579.9 580.6 38492.2 38990.2 39014.4 39150.2 39161.6 42060.4 42271.6 42283.4 42396.2 42496.0 8564.1 8666.0 8697.9 8699.6 8705.1 8579.4 8646.1 8687.7 8697.3 8726.9 8611.1 8655.4 8692.0 8712.3 8715.0 8616.5 8636.4 8672.2 8698.4 8700.6 8581.9 8672.7 8744.7 8746.8 8754.3 39314.8 39547.8 39662.2 39891.4 39959.8 3246.9 3443.7 3448.6 3890.0 3948.5 29527.0 29814.1 29972.7 30041.2 30257.7 3843.3 3869.3 3901.3 3948.5 4036.0 249708.0 250685.0 251123.0 251129.0 251953.0 41659.2 55200.7 55222.0 55392.0 55718.7 40844.6 40990.0 41036.4 41044.4 41207.0 13050.2 13150.1 13162.7 13193.8 13197.3 9786.3 9879.9 9901.8 9947.0 9957.4 14003.4 14305.8 14399.5 14404.4 14411.5 5765.2 5800.1 5856.9 5896.6 5918.2 905.9 939.6 1029.7 1036.2 1042.6 27502.4 32042.4 32676.0 32764.3 33036.0 986.3 1030.0 1063.5 1065.3 1098.1 16274.0 16904.8 16938.3 17166.0 17324.2 371318.0 372394.4 376544.0 377977.0 379567.0 53296.0 53761.5 53846.0 53989.5 53994.5 1303.5 1316.0 1321.1 1323.5 1325.0 28351.7 29411.0 29778.9 29811.6 30038.8 45466.0 45878.3 45879.8 45965.0 46231.5 287152.0 292768.0 293144.0 293268.0 293617.0 32020.4 45116.0 45412.1 45844.0 45978.0 43141.4 43368.0 43383.6 43683.3 43751.8 37012.8 37165.6 37368.8 37583.6 38823.6 36611.9 36946.3 37216.3 37465.4 37645.8 36467.5 36606.0 36737.3 36845.8 38095.2 30959.0 31904.0 34067.8 34091.8 40227.6 27312.3 27834.3 27898.6 28047.9 28193.6 02:57:50 INFO - 2015-11-23 02:57:50,688 DEBUG : BROWSER_OUTPUT: 02:57:50 INFO - 2015-11-23 02:57:50,688 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25830.49 Median:352.81 stddev:68418.14 (19392.4%) stddev-sans-first:68583.32 02:57:50 INFO - 2015-11-23 02:57:50,690 DEBUG : BROWSER_OUTPUT: Values: 350.1 355.5 359.6 360.5 362.9 16474.8 16818.6 17369.7 17430.0 18081.7 15627.5 15760.5 16030.4 16064.0 16130.4 4754.1 4840.2 4846.8 4868.4 4876.7 4823.3 4834.1 4864.3 4870.7 4894.2 4160.5 4294.5 6201.7 6405.0 6538.3 6632.1 6638.3 6654.6 6674.2 6712.7 6297.1 6363.3 6377.0 6439.5 6444.8 22398.6 22560.0 22787.0 23221.8 23822.4 2048.3 2134.3 2161.7 2171.9 2317.5 14286.5 14363.9 14586.2 14630.0 14810.7 1909.7 1996.0 2000.5 2009.3 2018.5 63778.0 64753.0 70385.6 70419.6 71670.3 15358.3 15493.8 15495.0 15495.9 15584.4 23990.9 24108.3 24246.2 24247.8 24397.9 8459.5 8644.2 8669.8 8696.7 8732.1 7252.6 7261.8 7304.7 7357.2 7368.2 7656.3 7748.6 7758.8 7763.5 7778.1 3029.7 3083.4 3092.4 3118.6 3221.5 388.3 392.5 417.2 423.2 426.2 14966.2 15581.4 17332.5 17412.8 17777.5 881.7 887.3 917.3 924.4 1012.9 9332.9 9386.6 9769.2 9890.4 9966.4 372849.0 374601.0 376468.0 377107.0 557452.0 61503.0 64809.5 67978.7 73488.6 74526.6 1058.7 1085.3 1093.5 1097.0 1097.5 14753.6 15176.0 15313.7 15443.5 15602.9 33345.3 33427.3 33585.0 34240.1 34569.5 43583.3 43897.0 44086.6 44522.6 46958.5 9082.6 9215.8 9221.8 9314.4 9343.3 12544.4 17026.0 17642.2 17766.6 17886.1 13614.5 13641.5 13910.8 14246.4 14315.1 13711.4 13919.2 13980.7 14173.4 14239.9 13653.2 14055.8 14138.0 14401.6 14515.3 8603.2 8615.6 8782.2 8822.6 8916.6 9245.9 11906.7 13771.9 13929.6 13986.4 02:57:50 INFO - 2015-11-23 02:57:50,690 DEBUG : BROWSER_OUTPUT: 02:57:50 INFO - 2015-11-23 02:57:50,690 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5226.12 Median:6313.92 stddev:2666.53 (42.2%) stddev-sans-first:2659.51 02:57:50 INFO - 2015-11-23 02:57:50,690 DEBUG : BROWSER_OUTPUT: Values: 1525.7 1645.3 1707.0 1729.1 1745.6 6900.6 6938.5 6974.7 7212.6 7394.2 7535.2 7553.8 7572.1 7626.4 7643.2 2214.6 2245.2 2248.3 2251.8 2256.5 2227.7 2270.2 2280.1 2294.2 2295.4 2203.7 2213.8 2239.7 2247.4 2249.0 2201.0 2270.9 2271.2 2274.8 2275.0 2237.8 2267.4 2275.1 2287.1 2296.8 7578.2 7653.2 7658.0 7668.0 7679.0 4480.4 4497.6 4529.3 4543.3 4551.6 2941.1 3013.8 3058.3 3064.0 3075.4 962.9 966.3 972.9 980.5 1009.6 10362.2 10398.4 10403.0 10416.4 10446.2 3949.3 3960.8 3971.8 4001.7 4004.3 8427.9 8440.6 8443.0 8457.6 8458.4 4488.5 4491.2 4511.7 4516.0 4525.5 4116.0 4125.8 4130.3 4144.3 4147.1 3306.7 3319.6 3325.1 3350.0 3351.7 1024.3 1034.3 1036.5 1041.4 1042.2 973.5 987.4 1016.9 1051.4 1282.8 6988.0 7127.3 7143.5 7147.5 7149.7 1070.1 1088.4 1107.9 1111.8 1118.5 5636.2 5654.9 5657.0 5685.7 5687.6 8717.6 8725.3 8930.4 8935.5 9050.1 8876.6 8882.9 8886.7 8922.7 8941.3 6936.9 6979.0 6999.3 7001.0 7027.5 6775.2 6811.9 6817.1 6817.9 6832.6 7349.6 7677.5 7714.4 7752.1 7809.9 7595.9 7734.2 7796.4 7808.7 7952.7 6467.2 6666.7 6791.9 6843.1 6866.7 7113.9 7117.2 7138.1 7144.9 7152.0 6536.7 6556.2 6631.4 6693.1 6816.7 6489.7 6531.7 6607.5 6750.0 6880.5 6792.0 6830.6 6845.8 6875.3 6888.8 6202.8 6231.1 6242.7 6249.7 6269.4 6298.8 6310.7 6317.1 6326.7 6328.9 02:57:50 INFO - 2015-11-23 02:57:50,690 DEBUG : BROWSER_OUTPUT: 02:57:50 INFO - 2015-11-23 02:57:50,690 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5562.56 Median:6446.61 stddev:1746.33 (27.1%) stddev-sans-first:1706.20 02:57:50 INFO - 2015-11-23 02:57:50,691 DEBUG : BROWSER_OUTPUT: Values: 312.6 314.3 318.6 320.9 325.8 6250.2 6328.6 6420.3 6447.0 6493.1 6246.4 6301.5 6303.7 6322.5 6324.7 4557.5 4740.5 4742.2 4751.5 4761.7 4695.7 4698.0 4703.6 4727.6 4737.6 4652.8 4657.0 4666.3 4667.5 4679.7 4667.5 4669.9 4683.2 4683.3 4685.1 3895.6 3971.1 4022.9 4023.2 4035.7 5897.8 5918.6 5939.0 5944.7 5974.9 5317.8 5359.7 5380.9 5402.1 5409.6 6615.2 6625.4 6629.6 6630.0 6641.3 4327.2 4394.2 4400.1 4407.2 4413.8 6842.5 6903.3 6916.2 6923.7 6938.6 4471.5 4484.8 4485.1 4490.9 4493.8 4441.5 4551.7 4552.6 4553.0 4557.2 5358.5 5394.8 5416.5 5416.5 5420.7 6711.5 6720.9 6729.6 6731.2 6736.1 1603.6 1609.8 1615.1 1616.8 1620.9 1042.1 1043.0 1043.4 1051.8 1069.7 6423.3 6430.5 6446.2 6508.1 6533.6 6932.1 6970.4 6972.2 6974.2 6985.3 6486.0 6519.2 6541.8 6546.6 6554.8 3709.3 3758.1 3763.2 3776.2 3781.9 7245.0 7245.3 7246.8 7261.8 7266.6 7100.0 7141.5 7155.6 7157.2 7171.0 7124.4 7212.7 7233.8 7252.0 7257.4 6914.2 6943.5 6953.7 6968.0 6996.9 6903.9 6906.8 6908.3 6908.9 6911.1 7112.3 7182.2 7205.5 7229.6 7238.7 4579.0 4603.6 4609.4 4614.1 4624.8 6908.9 6935.9 6944.7 6948.7 6964.1 6639.7 6756.1 6812.5 6814.1 6832.6 6734.6 6749.0 6789.9 6795.0 6802.1 6477.2 6638.9 6660.4 6681.4 6681.5 6630.5 6768.7 6792.0 6793.2 6814.5 6542.1 6543.4 6587.5 6609.7 6617.9 02:57:50 INFO - 2015-11-23 02:57:50,691 DEBUG : BROWSER_OUTPUT: 02:57:50 INFO - 2015-11-23 02:57:50,691 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13671.78 Median:45453.32 stddev:15839.69 (34.8%) stddev-sans-first:15854.33 02:57:50 INFO - 2015-11-23 02:57:50,692 DEBUG : BROWSER_OUTPUT: Values: 735.2 861.2 868.0 882.3 885.5 13511.8 13857.7 13887.7 13893.9 13920.6 13188.1 13213.5 13249.1 13280.3 13351.7 808.2 809.9 816.3 825.3 828.2 833.8 837.5 838.4 843.9 844.8 864.2 866.4 870.9 871.5 872.1 852.2 858.6 859.5 861.5 862.5 629.1 630.6 634.1 634.7 636.8 14102.9 14165.5 14204.9 14214.3 14269.9 11922.5 12229.6 12263.3 12430.2 12706.8 10151.5 10210.3 10483.7 10615.1 10816.9 3581.4 3600.0 3631.5 3634.9 3674.3 43509.8 43709.6 43780.8 43865.3 43907.0 9517.4 9852.5 9882.8 10131.4 10425.5 17234.7 17365.1 17398.8 17468.3 17487.4 7218.8 7457.6 7465.7 7531.5 7627.3 4069.3 4110.9 4111.3 4111.8 4126.6 3078.1 3080.7 3085.4 3086.1 3108.0 522.1 539.0 541.3 562.9 563.1 607.6 630.5 657.9 663.5 706.4 8144.9 8323.5 8397.8 8546.5 8619.3 508.5 525.4 650.4 674.5 682.4 3687.3 3755.0 3819.5 3858.6 3931.0 52745.0 57657.1 58005.7 59374.4 59667.4 50415.0 50773.2 52307.0 52535.5 53066.7 45001.3 46680.5 48543.8 48574.5 48783.3 7925.2 8125.5 8441.3 8456.3 8518.3 36091.3 36439.8 36500.0 36604.8 36617.6 41425.6 41814.2 44154.6 45905.3 46073.8 10346.8 10591.5 10614.4 10669.9 11266.1 11591.5 11779.2 11827.4 11955.6 12015.5 10528.5 10690.5 10731.4 10950.9 11009.2 10715.7 10788.6 10891.3 11248.8 11336.5 10364.9 11101.9 11116.8 11276.2 11529.8 9392.3 9623.0 9645.3 9830.6 9865.1 8855.7 9240.2 9529.8 9604.9 9659.5 02:57:50 INFO - 2015-11-23 02:57:50,692 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:57:50 INFO - 2015-11-23 02:57:50,692 DEBUG : BROWSER_OUTPUT: 02:57:51 INFO - 2015-11-23 02:57:51,372 INFO : Browser exited with error code: 0 02:57:51 INFO - 2015-11-23 02:57:51,396 INFO : Completed test dromaeo_css (00:18:30) 02:57:51 INFO - 2015-11-23 02:57:51,396 INFO : Starting test kraken 02:57:51 INFO - 2015-11-23 02:57:51,396 DEBUG : operating with platform_type : linux_ 02:57:51 INFO - 2015-11-23 02:57:51,396 INFO : Initialising browser for kraken test... 02:57:51 INFO - 2015-11-23 02:57:51,402 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRq1Glq/profile http://localhost:33104/getInfo.html 02:57:56 INFO - 2015-11-23 02:57:56,242 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:57:56 INFO - 2015-11-23 02:57:56,242 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:57:56 INFO - 2015-11-23 02:57:56,242 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:57:56 INFO - 2015-11-23 02:57:56,242 DEBUG : BROWSER_OUTPUT: __metrics 02:57:57 INFO - 2015-11-23 02:57:57,260 INFO : Browser initialized. 02:57:57 INFO - 2015-11-23 02:57:57,261 INFO : Running cycle 1/1 for kraken test... 02:57:57 INFO - 2015-11-23 02:57:57,261 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRq1Glq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:58:09 INFO - 2015-11-23 02:58:09,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 141410304 02:58:09 INFO - 2015-11-23 02:58:09,035 DEBUG : BROWSER_OUTPUT: 02:58:11 INFO - 2015-11-23 02:58:11,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33104/tests/kraken/driver.html?testName=audio-beat-detection) 02:58:12 INFO - 2015-11-23 02:58:12,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 141230080 02:58:12 INFO - 2015-11-23 02:58:12,149 DEBUG : BROWSER_OUTPUT: 02:58:14 INFO - 2015-11-23 02:58:14,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33104/tests/kraken/driver.html?testName=audio-dft) 02:58:15 INFO - 2015-11-23 02:58:15,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 141455360 02:58:15 INFO - 2015-11-23 02:58:15,420 DEBUG : BROWSER_OUTPUT: 02:58:18 INFO - 2015-11-23 02:58:18,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33104/tests/kraken/driver.html?testName=audio-fft) 02:58:18 INFO - 2015-11-23 02:58:18,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 137400320 02:58:18 INFO - 2015-11-23 02:58:18,877 DEBUG : BROWSER_OUTPUT: 02:58:20 INFO - 2015-11-23 02:58:20,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33104/tests/kraken/driver.html?testName=audio-oscillator) 02:58:21 INFO - 2015-11-23 02:58:21,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 137797632 02:58:21 INFO - 2015-11-23 02:58:21,442 DEBUG : BROWSER_OUTPUT: 02:58:23 INFO - 2015-11-23 02:58:23,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33104/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:58:24 INFO - 2015-11-23 02:58:24,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 139493376 02:58:24 INFO - 2015-11-23 02:58:24,237 DEBUG : BROWSER_OUTPUT: 02:58:27 INFO - 2015-11-23 02:58:27,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33104/tests/kraken/driver.html?testName=imaging-darkroom) 02:58:27 INFO - 2015-11-23 02:58:27,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 138248192 02:58:27 INFO - 2015-11-23 02:58:27,841 DEBUG : BROWSER_OUTPUT: 02:58:31 INFO - 2015-11-23 02:58:31,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33104/tests/kraken/driver.html?testName=imaging-desaturate) 02:58:31 INFO - 2015-11-23 02:58:31,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 138563584 02:58:31 INFO - 2015-11-23 02:58:31,834 DEBUG : BROWSER_OUTPUT: 02:58:34 INFO - 2015-11-23 02:58:34,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33104/tests/kraken/driver.html?testName=json-parse-financial) 02:58:35 INFO - 2015-11-23 02:58:35,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 139128832 02:58:35 INFO - 2015-11-23 02:58:35,386 DEBUG : BROWSER_OUTPUT: 02:58:36 INFO - 2015-11-23 02:58:36,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33104/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:58:37 INFO - 2015-11-23 02:58:37,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 139137024 02:58:37 INFO - 2015-11-23 02:58:37,563 DEBUG : BROWSER_OUTPUT: 02:58:39 INFO - 2015-11-23 02:58:39,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33104/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:58:40 INFO - 2015-11-23 02:58:40,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 138313728 02:58:40 INFO - 2015-11-23 02:58:40,007 DEBUG : BROWSER_OUTPUT: 02:58:42 INFO - 2015-11-23 02:58:42,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33104/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:58:42 INFO - 2015-11-23 02:58:42,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 140324864 02:58:42 INFO - 2015-11-23 02:58:42,677 DEBUG : BROWSER_OUTPUT: 02:58:45 INFO - 2015-11-23 02:58:45,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:58:45 INFO - 2015-11-23 02:58:45,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 140251136 02:58:45 INFO - 2015-11-23 02:58:45,745 DEBUG : BROWSER_OUTPUT: 02:58:48 INFO - 2015-11-23 02:58:48,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:58:48 INFO - 2015-11-23 02:58:48,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 139550720 02:58:48 INFO - 2015-11-23 02:58:48,933 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33104/tests/kraken/driver.html?testName=ai-astar) 02:58:50 INFO - 2015-11-23 02:58:50,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 139423744 02:58:50 INFO - 2015-11-23 02:58:50,876 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,879 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:58:50 INFO - 2015-11-23 02:58:50,880 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:58:50 INFO - 2015-11-23 02:58:50,880 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:58:50 INFO - 2015-11-23 02:58:50,880 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:58:50 INFO - 2015-11-23 02:58:50,880 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;106;110;110;112;123;110;111;111;110 02:58:50 INFO - 2015-11-23 02:58:50,881 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;139;155;163;129;152;161;130;171;130 02:58:50 INFO - 2015-11-23 02:58:50,881 DEBUG : BROWSER_OUTPUT: |2;audio-dft;168;162;162;163;162;163;162;166;167;161 02:58:50 INFO - 2015-11-23 02:58:50,881 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;71;72;72;155;71;78;70;72 02:58:50 INFO - 2015-11-23 02:58:50,881 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;146;92;92;94;137;94;94;140 02:58:50 INFO - 2015-11-23 02:58:50,881 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;109;110;110;109;110;110;110 02:58:50 INFO - 2015-11-23 02:58:50,881 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;148;147;146;146;146;147;146 02:58:50 INFO - 2015-11-23 02:58:50,881 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;97;96;96;96;96;96 02:58:50 INFO - 2015-11-23 02:58:50,882 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;65;63;60;60;61;67;65;61;58 02:58:50 INFO - 2015-11-23 02:58:50,882 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;70;70;71;71;70;69;69;70 02:58:50 INFO - 2015-11-23 02:58:50,882 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;86;93;85;84;84;87;85;86;86 02:58:50 INFO - 2015-11-23 02:58:50,882 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;118;115;116;127;124;123;124;129;135 02:58:50 INFO - 2015-11-23 02:58:50,882 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;149;152;157;155;151;154;146;152;139 02:58:50 INFO - 2015-11-23 02:58:50,882 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;67;69;68;67;69;69;65;72;67 02:58:50 INFO - 2015-11-23 02:58:50,882 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:58:50 INFO - 2015-11-23 02:58:50,883 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:58:50 INFO - 2015-11-23 02:58:50,883 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,728 02:58:50 INFO - 2015-11-23 02:58:50,883 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:58:50 INFO - 2015-11-23 02:58:50,883 DEBUG : BROWSER_OUTPUT: __startTimestamp1448276330878__endTimestamp 02:58:50 INFO - 2015-11-23 02:58:50,883 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,886 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:58:50 INFO - 2015-11-23 02:58:50,887 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:58:50 INFO - 2015-11-23 02:58:50,887 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,887 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.30 Median:110.50 stddev:4.40 (4.0%) stddev-sans-first:4.64 02:58:50 INFO - 2015-11-23 02:58:50,887 DEBUG : BROWSER_OUTPUT: Values: 110.0 106.0 110.0 110.0 112.0 123.0 110.0 111.0 111.0 110.0 02:58:50 INFO - 2015-11-23 02:58:50,887 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,887 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.20 Median:153.50 stddev:15.25 (9.9%) stddev-sans-first:16.12 02:58:50 INFO - 2015-11-23 02:58:50,888 DEBUG : BROWSER_OUTPUT: Values: 152.0 139.0 155.0 163.0 129.0 152.0 161.0 130.0 171.0 130.0 02:58:50 INFO - 2015-11-23 02:58:50,888 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,888 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.46 (1.5%) stddev-sans-first:2.03 02:58:50 INFO - 2015-11-23 02:58:50,888 DEBUG : BROWSER_OUTPUT: Values: 168.0 162.0 162.0 163.0 162.0 163.0 162.0 166.0 167.0 161.0 02:58:50 INFO - 2015-11-23 02:58:50,888 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,888 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:72.00 stddev:26.20 (36.4%) stddev-sans-first:27.64 02:58:50 INFO - 2015-11-23 02:58:50,888 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 71.0 72.0 72.0 155.0 71.0 78.0 70.0 72.0 02:58:50 INFO - 2015-11-23 02:58:50,888 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,889 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.70 Median:94.00 stddev:23.09 (24.6%) stddev-sans-first:23.96 02:58:50 INFO - 2015-11-23 02:58:50,889 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 146.0 92.0 92.0 94.0 137.0 94.0 94.0 140.0 02:58:50 INFO - 2015-11-23 02:58:50,889 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,889 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 02:58:50 INFO - 2015-11-23 02:58:50,889 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 110.0 02:58:50 INFO - 2015-11-23 02:58:50,889 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,889 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 02:58:50 INFO - 2015-11-23 02:58:50,889 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 148.0 147.0 146.0 146.0 146.0 147.0 146.0 02:58:50 INFO - 2015-11-23 02:58:50,889 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,889 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.10 Median:62.00 stddev:2.81 (4.5%) stddev-sans-first:2.95 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: Values: 61.0 65.0 63.0 60.0 60.0 61.0 67.0 65.0 61.0 58.0 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 70.0 71.0 71.0 70.0 69.0 69.0 70.0 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:2.98 (3.5%) stddev-sans-first:2.73 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: Values: 91.0 86.0 93.0 85.0 84.0 84.0 87.0 85.0 86.0 86.0 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:125.00 stddev:6.15 (4.9%) stddev-sans-first:6.46 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: Values: 126.0 118.0 115.0 116.0 127.0 124.0 123.0 124.0 129.0 135.0 02:58:50 INFO - 2015-11-23 02:58:50,890 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,891 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:152.00 stddev:5.93 (3.9%) stddev-sans-first:5.41 02:58:50 INFO - 2015-11-23 02:58:50,891 DEBUG : BROWSER_OUTPUT: Values: 141.0 149.0 152.0 157.0 155.0 151.0 154.0 146.0 152.0 139.0 02:58:50 INFO - 2015-11-23 02:58:50,891 DEBUG : BROWSER_OUTPUT: 02:58:50 INFO - 2015-11-23 02:58:50,891 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.87 (2.7%) stddev-sans-first:1.96 02:58:50 INFO - 2015-11-23 02:58:50,891 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 69.0 68.0 67.0 69.0 69.0 65.0 72.0 67.0 02:58:50 INFO - 2015-11-23 02:58:50,891 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:58:50 INFO - 2015-11-23 02:58:50,891 DEBUG : BROWSER_OUTPUT: 02:58:51 INFO - 2015-11-23 02:58:51,760 INFO : Browser exited with error code: 0 02:58:51 INFO - 2015-11-23 02:58:51,814 INFO : Completed test kraken (00:01:00) 02:58:51 INFO - 2015-11-23 02:58:51,814 INFO : Starting test v8_7 02:58:51 INFO - 2015-11-23 02:58:51,814 DEBUG : operating with platform_type : linux_ 02:58:51 INFO - 2015-11-23 02:58:51,814 INFO : Initialising browser for v8_7 test... 02:58:51 INFO - 2015-11-23 02:58:51,820 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJzIMYU/profile http://localhost:33104/getInfo.html 02:58:56 INFO - 2015-11-23 02:58:56,545 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:58:56 INFO - 2015-11-23 02:58:56,545 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:58:56 INFO - 2015-11-23 02:58:56,545 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:58:56 INFO - 2015-11-23 02:58:56,545 DEBUG : BROWSER_OUTPUT: __metrics 02:58:57 INFO - 2015-11-23 02:58:57,660 INFO : Browser initialized. 02:58:57 INFO - 2015-11-23 02:58:57,661 INFO : Running cycle 1/1 for v8_7 test... 02:58:57 INFO - 2015-11-23 02:58:57,661 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJzIMYU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:59:09 INFO - 2015-11-23 02:59:09,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 142172160 02:59:09 INFO - 2015-11-23 02:59:09,500 DEBUG : BROWSER_OUTPUT: 02:59:30 INFO - 2015-11-23 02:59:30,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33104/tests/v8_7/run.html (next: http://localhost:33104/tests/v8_7/run.html) 02:59:31 INFO - 2015-11-23 02:59:31,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 138473472 02:59:31 INFO - 2015-11-23 02:59:31,203 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-11-23 02:59:31,203 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:59:31 INFO - 2015-11-23 02:59:31,203 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:59:31 INFO - 2015-11-23 02:59:31,203 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:59:31 INFO - 2015-11-23 02:59:31,203 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:59:31 INFO - 2015-11-23 02:59:31,203 DEBUG : BROWSER_OUTPUT: |0;Richards;183.99264029438822 02:59:31 INFO - 2015-11-23 02:59:31,203 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.79133103183736 02:59:31 INFO - 2015-11-23 02:59:31,204 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.2690582959641 02:59:31 INFO - 2015-11-23 02:59:31,204 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5005 02:59:31 INFO - 2015-11-23 02:59:31,204 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1071.8113612004288 02:59:31 INFO - 2015-11-23 02:59:31,204 DEBUG : BROWSER_OUTPUT: |5;Earley;719.4244604316547 02:59:31 INFO - 2015-11-23 02:59:31,204 DEBUG : BROWSER_OUTPUT: |6;Boyer;12192.77108433735 02:59:31 INFO - 2015-11-23 02:59:31,204 DEBUG : BROWSER_OUTPUT: |7;RegExp;25146.341463414636 02:59:31 INFO - 2015-11-23 02:59:31,204 DEBUG : BROWSER_OUTPUT: |8;Splay;631.7119393556538 02:59:31 INFO - 2015-11-23 02:59:31,204 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 02:59:31 INFO - 2015-11-23 02:59:31,204 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:59:31 INFO - 2015-11-23 02:59:31,205 DEBUG : BROWSER_OUTPUT: __startTimestamp1448276371196__endTimestamp 02:59:31 INFO - 2015-11-23 02:59:31,205 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-11-23 02:59:31,205 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:59:31 INFO - 2015-11-23 02:59:31,205 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:59:31 INFO - 2015-11-23 02:59:31,205 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-11-23 02:59:31,205 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:183.99 Median:183.99 stddev:0.00 (0.0%) 02:59:31 INFO - 2015-11-23 02:59:31,205 DEBUG : BROWSER_OUTPUT: Values: 184.0 02:59:31 INFO - 2015-11-23 02:59:31,205 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-11-23 02:59:31,206 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.79 Median:191.79 stddev:0.00 (0.0%) 02:59:31 INFO - 2015-11-23 02:59:31,206 DEBUG : BROWSER_OUTPUT: Values: 191.8 02:59:31 INFO - 2015-11-23 02:59:31,206 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-11-23 02:59:31,206 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 02:59:31 INFO - 2015-11-23 02:59:31,206 DEBUG : BROWSER_OUTPUT: Values: 280.3 02:59:31 INFO - 2015-11-23 02:59:31,206 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-11-23 02:59:31,206 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5005.00 Median:5005.00 stddev:0.00 (0.0%) 02:59:31 INFO - 2015-11-23 02:59:31,207 DEBUG : BROWSER_OUTPUT: Values: 5005.0 02:59:31 INFO - 2015-11-23 02:59:31,207 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-11-23 02:59:31,207 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 02:59:31 INFO - 2015-11-23 02:59:31,207 DEBUG : BROWSER_OUTPUT: Values: 1071.8 02:59:31 INFO - 2015-11-23 02:59:31,207 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-11-23 02:59:31,207 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:719.42 Median:719.42 stddev:0.00 (0.0%) 02:59:31 INFO - 2015-11-23 02:59:31,208 DEBUG : BROWSER_OUTPUT: Values: 719.4 02:59:31 INFO - 2015-11-23 02:59:31,208 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-11-23 02:59:31,208 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 02:59:31 INFO - 2015-11-23 02:59:31,208 DEBUG : BROWSER_OUTPUT: Values: 12192.8 02:59:31 INFO - 2015-11-23 02:59:31,208 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-11-23 02:59:31,208 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25146.34 Median:25146.34 stddev:0.00 (0.0%) 02:59:31 INFO - 2015-11-23 02:59:31,208 DEBUG : BROWSER_OUTPUT: Values: 25146.3 02:59:31 INFO - 2015-11-23 02:59:31,208 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-11-23 02:59:31,208 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:631.71 Median:631.71 stddev:0.00 (0.0%) 02:59:31 INFO - 2015-11-23 02:59:31,208 DEBUG : BROWSER_OUTPUT: Values: 631.7 02:59:31 INFO - 2015-11-23 02:59:31,208 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-11-23 02:59:31,208 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 02:59:31 INFO - 2015-11-23 02:59:31,209 DEBUG : BROWSER_OUTPUT: Values: 4854.4 02:59:31 INFO - 2015-11-23 02:59:31,209 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:59:31 INFO - 2015-11-23 02:59:31,209 DEBUG : BROWSER_OUTPUT: 02:59:32 INFO - 2015-11-23 02:59:32,132 INFO : Browser exited with error code: 0 02:59:32 INFO - 2015-11-23 02:59:32,147 INFO : Completed test v8_7 (00:00:40) 02:59:32 INFO - 2015-11-23 02:59:32,218 INFO : Completed test suite (00:20:11) 02:59:32 INFO - 2015-11-23 02:59:32,219 DEBUG : Working with test: dromaeo_css 02:59:32 INFO - 2015-11-23 02:59:32,219 DEBUG : Generating results file: dromaeo_css 02:59:32 INFO - 2015-11-23 02:59:32,220 DEBUG : Working with test: kraken 02:59:32 INFO - 2015-11-23 02:59:32,220 DEBUG : Generating results file: kraken 02:59:32 INFO - 2015-11-23 02:59:32,220 INFO : javascript benchmark 02:59:32 INFO - 2015-11-23 02:59:32,221 DEBUG : Working with test: v8_7 02:59:32 INFO - 2015-11-23 02:59:32,221 DEBUG : Generating results file: v8_7 02:59:32 INFO - 2015-11-23 02:59:32,221 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:59:32 INFO - 2015-11-23 02:59:32,270 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 02:59:32 INFO - 2015-11-23 02:59:32,270 DEBUG : process_Request line: dromaeo_css 7062.51 graph.html#tests=[[72,63,43]] 02:59:32 INFO - 2015-11-23 02:59:32,271 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:59:32 INFO - 2015-11-23 02:59:32,310 DEBUG : process_Request line: kraken 1524.50 graph.html#tests=[[232,63,43]] 02:59:32 INFO - 2015-11-23 02:59:32,310 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:59:32 INFO - 2015-11-23 02:59:32,341 DEBUG : process_Request line: v8_7 21083.59 graph.html#tests=[[230,63,43]] 02:59:32 INFO - 2015-11-23 02:59:32,342 INFO : javascript benchmark 02:59:32 INFO - 2015-11-23 02:59:32,346 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3233.240188555689, 3249.3988612106778, 3286.86852525899, 3305.272839975206, 3322.252493189033, 5293.391260005101, 5485.286912701353, 5546.112621980479, 5550.916736248954, 5556.222128901952, 5434.701091439969, 5443.428440013801, 5516.558675305976, 5522.392536820947, 5547.583931205156, 4949.133901567229, 5005.0990821652085, 5116.667416617908, 5153.768080436389, 5158.045761534128, 4919.508049195088, 5069.695818250917, 5091.79632814687, 5094.1085310070775, 5173.379194496666, 4941.901161976758, 4969.006198760262, 5079.466656001141, 5089.211172268304, 5108.208227724708, 5015.974920125376, 5029.647924645276, 5034.3455350804525, 5074.441811400743, 5086.287919691209, 4934.6052315815, 4995.625328100371, 5014.799408023711, 5024.447310795809, 5058.3929928408825, 5252.947470525322, 5286.418493965661, 5292.20616907467, 5297.231901374279, 5373.086575282211, 5836.503897168745, 5863.355030946635, 5863.736131874076, 5870.501007414375, 5936.881262374772, 5781.710914454303, 5803.100519419497, 5898.64608123514, 5911.172435858984, 5938.406159384071, 5595.888082238333, 5603.411641777596, 5617.691026993554, 5631.2960879890015, 5651.2370829937845, 6090.33006369299, 6106.297775755845, 6149.0776383542825, 6151.784687535915, 6158.137860699506, 5727.31272247333, 5784.797532086441, 5853.560982926212, 5930.140129681172, 5939.70301484924, 5940.287165540163, 5956.702164891738, 5961.731722072431, 5973.790917317873, 5993.130996005642, 5938.406159384113, 5950.67271300074, 5991.610545314627, 5992.280926288873, 5997.1304160896425, 5778.797742079007, 5896.1450589664255, 5907.2911250650195, 5911.083782013795, 5912.17229587858, 4499.707519011254, 4533.297338912474, 4560.840370587013, 4566.794494247767, 4570.6800523963, 4025.5974402560096, 4056.8377264909072, 4058.188362327546, 4064.5732198119363, 4086.203190377848, 5532.972335138298, 5648.63283886546, 5664.773409063674, 5677.716114194273, 5705.2012718219485, 5823.708814559255, 5891.793787217427, 5970.552208584373, 6005.939940600538, 6018.067199584071, 5652.830415087554, 5681.147827825859, 5751.1085781703905, 5764.798232061858, 5765.221695071195, 4988.850334489971, 5136.1525348317855, 5210.609204309692, 5233.502817232356, 5263.894722105537, 6114.510272098727, 6153.692315384213, 6238.656873871981, 6319.8104056878365, 6326.557141000178, 5915.58590898633, 5958.672273025025, 5972.402759723993, 5980.0431930890845, 6027.487663548647, 5890.823275301748, 5999.670018149044, 6175.62946223228, 6175.96912015437, 6184.938150618436, 5804.419558044331, 5876.294844618673, 5878.2064421304285, 5881.735321910439, 5919.171316015675, 5936.970315148396, 5974.044152935509, 5981.043033114681, 5983.880322393615, 5993.0, 5660.122680984454, 5706.629069110494, 5725.055365864586, 5821.970890145522, 5836.358000619844, 5856.443637854397, 5864.44287792659, 5867.119932010232, 5872.677002764889, 5880.235569375954, 5755.884882302246, 5763.423657634371, 5768.740406681625, 5772.971135144466, 5778.8266352009505, 5585.1901474286815, 5762.279715035621, 5776.046952252831, 5860.560457965585, 5872.442117998783, 5583.162525621189, 5703.287089113861, 5730.541556675373, 5731.369549349485, 5735.168400581809], "unit": "ms", "name": "dojo.html", "value": 5474.7182481011205}, {"lowerIsBetter": false, "replicates": [539.4309004000779, 543.2611648158506, 547.7370861986248, 579.8637320229743, 580.5674772294641, 38492.23015539691, 38990.22019559607, 39014.414783778266, 39150.21699566007, 39161.60838391615, 42060.36909446361, 42271.57728422715, 42283.36574951371, 42396.152076958446, 42496.0, 8564.057953625112, 8666.0, 8697.869531957025, 8699.565021748918, 8705.129487051276, 8579.442336248156, 8646.135386461336, 8687.695930642429, 8697.260732837685, 8726.86909696355, 8611.095834937336, 8655.437396569203, 8692.043875173726, 8712.259457946082, 8714.956425217864, 8616.526091064989, 8636.39545231834, 8672.219500245008, 8698.434601750865, 8700.564971751419, 8581.914180858173, 8672.696455624086, 8744.737657870273, 8746.781330466725, 8754.343424243143, 39314.80342598269, 39547.8022609888, 39662.20675586472, 39891.40162897559, 39959.8002009991, 3246.853891574885, 3443.707284880788, 3448.5516882805327, 3890.0469385000574, 3948.486696729407, 29527.0, 29814.053903475033, 29972.70027299721, 30041.248968775737, 30257.697423025707, 3843.34881862232, 3869.303525365433, 3901.2782635212575, 3948.545917219528, 4035.959640403617, 249708.0, 250685.0, 251123.0, 251129.0, 251953.0, 41659.1668166635, 55200.72399637976, 55222.0, 55392.0, 55718.72140639271, 40844.591554084676, 40989.950502474756, 41036.38445423321, 41044.43289073794, 41207.0, 13050.151740137051, 13150.07949443549, 13162.736745265232, 13193.802092968614, 13197.340132993504, 9786.314957952874, 9879.901200987899, 9901.75245618851, 9947.0, 9957.352772069793, 14003.439862405594, 14305.78541321881, 14399.496017639332, 14404.351804168837, 14411.495597654242, 5765.221695071112, 5800.100984347433, 5856.941430585724, 5896.616719913192, 5918.171455996164, 905.8686490458847, 939.5771902643837, 1029.7425643589104, 1036.1555332404066, 1042.6142327338782, 27502.449951000868, 32042.35915281728, 32676.0, 32764.344713105605, 33036.0, 986.284943416032, 1029.984550231747, 1063.4682658670665, 1065.2969040433431, 1098.0995583621514, 16274.0, 16904.830951690572, 16938.322467101425, 17166.0, 17324.220410081576, 371318.0, 372394.414083789, 376544.0, 377977.0, 379567.0, 53296.0, 53761.46238537564, 53846.0, 53989.46010539923, 53994.46005539973, 1303.478608556566, 1315.967100822468, 1321.0554453565746, 1323.503686117706, 1325.032726109945, 28351.71648283491, 29411.0, 29778.851105744332, 29811.55282670805, 30038.849805751706, 45466.0, 45878.31182532198, 45879.77060114678, 45965.0, 46231.53768462272, 287152.0, 292768.0, 293144.0, 293268.0, 293617.0, 32020.35959280755, 45116.0, 45412.09175816399, 45844.0, 45978.0, 43141.352879707454, 43368.0, 43383.566164339216, 43683.344749828146, 43751.78124109359, 37012.81493592515, 37165.62834371622, 37368.81315593405, 37583.62416375911, 38823.611763882, 36611.901642950754, 36946.261074777816, 37216.25567488581, 37465.4380184292, 37645.81177094097, 36467.45298820467, 36606.0, 36737.26525469422, 36845.81577092098, 38095.23809523849, 30959.0, 31904.0, 34067.82966085154, 34091.82954085214, 40227.59772402239, 27312.317192070357, 27834.30414239579, 27898.581521276792, 28047.859760701067, 28193.57709634316], "unit": "ms", "name": "ext.html", "value": 18221.15098463409}, {"lowerIsBetter": false, "replicates": [350.1281808297337, 355.4880971401182, 359.6439524870379, 360.5241081772062, 362.9038304849214, 16474.83525164748, 16818.579535511602, 17369.739453908187, 17430.0, 18081.7287740684, 15627.453039143633, 15760.527184184493, 16030.35878564856, 16064.0, 16130.354785808582, 4754.096721622889, 4840.201366774478, 4846.781894814724, 4868.440129385113, 4876.73177975213, 4823.276508523714, 4834.057358815033, 4864.318995340655, 4870.707757534559, 4894.192458244385, 4160.500739911215, 4294.506131794837, 6201.720922558473, 6405.039244113374, 6538.346165383471, 6632.071509988606, 6638.269790323061, 6654.600723956578, 6674.16572928384, 6712.664366781666, 6297.086922396227, 6363.300036995926, 6376.9681151594405, 6439.549231553793, 6444.838879028015, 22398.55202895933, 22560.0, 22787.0, 23221.7677823223, 23822.404439888967, 2048.2523878784286, 2134.274346722106, 2161.6757486377014, 2171.8588291760984, 2317.5364927014666, 14286.499972501017, 14363.928180359031, 14586.197759123244, 14630.0, 14810.703785924328, 1909.6849019911697, 1996.0119740728433, 2000.4598758335314, 2009.25657506722, 2018.495376155961, 63778.0, 64753.0, 70385.64807175931, 70419.64790176017, 71670.2832971674, 15358.308876100602, 15493.845061549466, 15495.0, 15495.922520387552, 15584.376624934876, 23990.88004559966, 24108.276751697478, 24246.15138470145, 24247.7575224249, 24397.878010609835, 8459.450135741157, 8644.178803013703, 8669.826603467895, 8696.695615653422, 8732.126787321216, 7252.5648461092505, 7261.782146535613, 7304.671289791972, 7357.153927298322, 7368.15266244378, 7656.349210317074, 7748.6125693715085, 7758.844823103506, 7763.456558040883, 7778.105517865405, 3029.727324540802, 3083.429565530384, 3092.3969825884187, 3118.5892476553163, 3221.4684577044527, 388.3281922274481, 392.45644781977165, 417.1573421688173, 423.1621389648513, 426.1689705075116, 14966.17686027279, 15581.376744930076, 17332.480025599252, 17412.825871741374, 17777.46667599974, 881.6980408370565, 887.3211992825494, 917.3211823250747, 924.4037595750704, 1012.9088382045651, 9332.90667093334, 9386.577604007836, 9769.218462522982, 9890.357126786736, 9966.35218710796, 372849.0, 374601.0, 376468.0, 377107.0, 557452.0, 61503.0, 64809.519048094815, 67978.66010670013, 73488.63255683688, 74526.6273668639, 1058.6771034834296, 1085.2999815119204, 1093.4969913839723, 1096.9780604387868, 1097.4841824342545, 14753.557393278219, 15176.0, 15313.693726125637, 15443.459478918634, 15602.921985390001, 33345.33309333751, 33427.33145337031, 33585.0, 34240.143996400286, 34569.48145777866, 43583.34624980565, 43897.0, 44086.55913440824, 44522.55477445184, 46958.530414695415, 9082.636694532144, 9215.76960575991, 9221.769455763659, 9314.44113353201, 9343.252539796937, 12544.372781361079, 17026.0, 17642.206100725754, 17766.644667106844, 17886.105694715472, 13614.50240473567, 13641.454341826216, 13910.791338129733, 14246.430142794172, 14315.141091534124, 13711.382987765774, 13919.23444210578, 13980.720385592434, 14173.36219870129, 14239.857601424268, 13653.180809151483, 14055.789163162357, 14138.0, 14401.567952961428, 14515.274236287933, 8603.225709685908, 8615.569221539023, 8782.209601135928, 8822.602982865657, 8916.598753056258, 9245.86131208019, 11906.702332441759, 13771.931140344233, 13929.58211253664, 13986.370613322628], "unit": "ms", "name": "jquery.html", "value": 9251.343813819805}, {"lowerIsBetter": false, "replicates": [1525.725369433503, 1645.3336398758502, 1706.9743953840696, 1729.135432283858, 1745.6334169824336, 6900.5514641548325, 6938.514303998722, 6974.721011159554, 7212.567245965232, 7394.186639469667, 7535.2464753524755, 7553.811154721135, 7572.053493313336, 7626.389888808896, 7643.197464266242, 2214.6124428225035, 2245.1805091141696, 2248.325502349297, 2251.8198544116512, 2256.458449972003, 2227.6992605998144, 2270.182734215681, 2280.110756804839, 2294.208498068172, 2295.4146692593367, 2203.680466332381, 2213.8228941684706, 2239.6528538076623, 2247.438140464884, 2248.955020899581, 2200.9889950550223, 2270.8523945943625, 2271.171022576756, 2274.8180145588312, 2275.0217406515276, 2237.7985981261763, 2267.399139228106, 2275.1354485295483, 2287.0623044551653, 2296.781805728453, 7578.204288549678, 7653.196414376466, 7658.0, 7668.041494813148, 7679.0, 4480.350349199348, 4497.572730590588, 4529.320601909707, 4543.273076307808, 4551.590356867865, 2941.0882626385887, 3013.8342391168476, 3058.250728571514, 3063.9540406893916, 3075.369549242422, 962.8507581324906, 966.3235734985539, 972.9178122229001, 980.54404701814, 1009.6365308488938, 10362.222833287533, 10398.428086455242, 10403.011713887094, 10416.42709650969, 10446.164306855433, 3949.269385163754, 3960.7821569813937, 3971.821268042945, 4001.7198796083994, 4004.3392840181627, 8427.873581896276, 8440.620172092147, 8443.0, 8457.619407126695, 8458.365622578209, 4488.528704486047, 4491.191585514639, 4511.684182107221, 4515.9774201128785, 4525.456945166601, 4115.97942010294, 4125.752454852718, 4130.318497447947, 4144.254034273859, 4147.149834283965, 3306.702396784301, 3319.55186049885, 3325.0856014595697, 3350.0284917373688, 3351.7151042161204, 1024.3137098144261, 1034.250168627754, 1036.5076588620345, 1041.3647674918293, 1042.1506472225112, 973.4597298499401, 987.3779518903045, 1016.903394177552, 1051.4164638625637, 1282.7819270723999, 6987.965060174666, 7127.322904324081, 7143.464240182007, 7147.463940204506, 7149.7497587584185, 1070.1171533484905, 1088.357868857378, 1107.8504401905639, 1111.7887601355717, 1118.5246270335076, 5636.210930469655, 5654.886902261932, 5657.038303488417, 5685.715714214272, 5687.630304030307, 8717.607707653171, 8725.258353039935, 8930.374873758774, 8935.463872167691, 9050.140236677506, 8876.556172191365, 8882.86675699865, 8886.73339799807, 8922.68770593026, 8941.284697224206, 6936.895946560806, 6979.0, 6999.335063168991, 7000.964995174992, 7027.543209691456, 6775.1531058617675, 6811.863762724619, 6817.079694241214, 6817.93182068173, 6832.59004459734, 7349.595772232365, 7677.462577619513, 7714.382849372149, 7752.1472638008645, 7809.921900781147, 7595.924040759522, 7734.2265773422205, 7796.415268854972, 7808.726694565663, 7952.681892724227, 6467.159269294962, 6666.666666666744, 6791.864162716619, 6843.144606924135, 6866.656667166521, 7113.928860711534, 7117.217106118426, 7138.143422789299, 7144.928550714426, 7151.964240178974, 6536.673166341759, 6556.213254409501, 6631.3700198481065, 6693.062971183941, 6816.693248803915, 6489.675516224264, 6531.673416329069, 6607.471402287902, 6750.0, 6880.518363714492, 6792.0, 6830.624315662686, 6845.760398386033, 6875.278095799869, 6888.793336199922, 6202.81391558254, 6231.065340199007, 6242.719077641426, 6249.6562689052535, 6269.404406581368, 6298.779542715983, 6310.684465776784, 6317.147185129948, 6326.6836658165985, 6328.873422531616], "unit": "ms", "name": "mootools.html", "value": 4316.095648515142}, {"lowerIsBetter": false, "replicates": [312.60455523762437, 314.28029811731125, 318.58583841006686, 320.94864821628545, 325.7508006375122, 6250.218722659668, 6328.5886417382835, 6420.293767685551, 6447.032945058238, 6493.058506516552, 6246.406591373823, 6301.527385446098, 6303.684815759217, 6322.462590679786, 6324.715387807548, 4557.475890272628, 4740.549647783472, 4742.217534106868, 4751.501092385284, 4761.690490118149, 4695.67130300879, 4697.953020469786, 4703.6472264580125, 4727.574518293353, 4737.644676649265, 4652.767361631922, 4657.0, 4666.300054991744, 4667.486576476585, 4679.719216847, 4667.509911459299, 4669.929951050703, 4683.157031734287, 4683.344331793552, 4685.086408150412, 3895.61043895611, 3971.0667993021616, 4022.8591999279884, 4023.155137421145, 4035.7376770509823, 5897.823065308047, 5918.585699001072, 5939.0, 5944.673042982634, 5974.940250597525, 5317.813876514303, 5359.651622644516, 5380.946190538084, 5402.054640437907, 5409.648372855791, 6615.17310336208, 6625.436837868739, 6629.635370054645, 6630.0, 6641.302663220341, 4327.177836211141, 4394.1870753910625, 4400.075984043355, 4407.162639098561, 4413.845515406945, 6842.521023528355, 6903.309669033107, 6916.20463646677, 6923.653817309165, 6938.618375989318, 4471.5081341052455, 4484.8430304939175, 4485.147821913826, 4490.887727806766, 4493.752843593568, 4441.511433742286, 4551.681382303207, 4552.567506086916, 4553.0, 4557.156925968707, 5358.5177334039345, 5394.811181608625, 5416.485433883775, 5416.539594134542, 5420.674759514362, 6711.530192886548, 6720.865582688417, 6729.5625784323865, 6731.158605174353, 6736.124303840567, 1603.5670369000304, 1609.8148712898167, 1615.0794047393108, 1616.765568992513, 1620.9270582823801, 1042.0673497220098, 1043.0351924469835, 1043.3583346242158, 1051.8474821151044, 1069.673749506408, 6423.293437721847, 6430.48556115519, 6446.194225721785, 6508.088867558546, 6533.562616224423, 6932.0988271524375, 6970.407515361149, 6972.163340399185, 6974.197967233732, 6985.336393042653, 6485.9946708260295, 6519.152510173647, 6541.803745887631, 6546.574472659262, 6554.8361290968105, 3709.295233905549, 3758.098056466483, 3763.2473505298503, 3776.2069965307046, 3781.905452363713, 7245.0, 7245.311695388929, 7246.818829529304, 7261.818454538573, 7266.564006159648, 7100.0, 7141.535800172972, 7155.570665759967, 7157.2127066022695, 7171.0, 7124.43004559634, 7212.71149154028, 7233.782986510413, 7251.963740181265, 7257.419406447471, 6914.170299564084, 6943.47923905699, 6953.68708408133, 6968.0, 6996.930030699627, 6903.930960690329, 6906.758263460755, 6908.3437073477935, 6908.896366554405, 6911.067005954132, 7112.288771122846, 7182.2099569048405, 7205.495615306878, 7229.566226026455, 7238.710451581877, 4578.9771051144535, 4603.58567728906, 4609.423822022247, 4614.123316569975, 4624.838130665411, 6908.896366554405, 6935.930640693528, 6944.652767361511, 6948.652567371712, 6964.129483814523, 6639.734410623714, 6756.087928129836, 6812.523123381316, 6814.114165158696, 6832.555883867532, 6734.629595372302, 6749.0, 6789.93210067893, 6795.0, 6802.115724955724, 6477.1579694639395, 6638.867222655424, 6660.400563949268, 6681.432078273401, 6681.532292739462, 6630.46956243509, 6768.7292508299115, 6792.0, 6793.150856142982, 6814.488913331421, 6542.116814230209, 6543.378379053982, 6587.505937054836, 6609.702563384755, 6617.933820661924], "unit": "ms", "name": "prototype.html", "value": 4976.675052880779}, {"lowerIsBetter": false, "replicates": [735.2316828913786, 861.2076889261882, 867.9869801952968, 882.2743071027535, 885.5173930208034, 13511.79732304015, 13857.653558661039, 13887.722245555084, 13893.861061389396, 13920.582382528528, 13188.142770719896, 13213.537526186585, 13249.138805977629, 13280.269585172811, 13351.732965340687, 808.1796976069294, 809.8744694572322, 816.3265306122443, 825.2984962781618, 828.2214718164936, 833.754042557444, 837.5058715357937, 838.3502785341349, 843.8607629741085, 844.8056946902216, 864.2178828160494, 866.3805379153904, 870.8519551676198, 871.5337294547419, 872.0581771686595, 852.1861622150863, 858.5707146426787, 859.5057841740961, 861.4745005546612, 862.5169904853271, 629.0752593687272, 630.6153246519619, 634.0964126120306, 634.6636282770139, 636.8248731598801, 14102.858971410256, 14165.504207352797, 14204.85795142056, 14214.289285535682, 14269.928650356682, 11922.523099076026, 12229.571964981184, 12263.325517096557, 12430.192037517532, 12706.809397859039, 10151.492425378776, 10210.2852800304, 10483.68548943533, 10615.065515247006, 10816.891831081746, 3581.3752600146, 3599.982000090009, 3631.455281707765, 3634.945475817865, 3674.2835147146316, 43509.78245108754, 43709.56290437087, 43780.78109609464, 43865.34201986973, 43907.0, 9517.381370210915, 9852.45811480361, 9882.752931176778, 10131.392116473035, 10425.530851111567, 17234.65530689379, 17365.131743412778, 17398.826011739722, 17468.30126794914, 17487.387941422243, 7218.783436496913, 7457.589832559262, 7465.664045117983, 7531.472796904164, 7627.313541781266, 4069.348904175318, 4110.938335924963, 4111.342185250345, 4111.753294802262, 4126.587341265849, 3078.076577026883, 3080.7073328033803, 3085.41377138343, 3086.089603566953, 3107.9689203107678, 522.0967725834328, 538.9919151212735, 541.3449725831709, 562.9268195134606, 563.1383982506771, 607.6475644126396, 630.5239544144142, 657.9407853293227, 663.4526515624628, 706.3783870194196, 8144.918550814535, 8323.5005899645, 8397.832043359098, 8546.529940853312, 8619.310455163572, 508.46611058388544, 525.3643091858817, 650.3951325267547, 674.4873895839099, 682.4199430484049, 3687.3362794697214, 3755.0, 3819.4652748615217, 3858.6334298241622, 3930.9582960515486, 52745.0, 57657.13514297289, 58005.70997144987, 59374.40625593689, 59667.403325967054, 50415.0, 50773.23840142401, 52307.0, 52535.474645253824, 53066.73466632642, 45001.324980125326, 46680.53319466898, 48543.75728121407, 48574.514254857706, 48783.268250975554, 7925.167857374892, 8125.512469251864, 8441.32469402434, 8456.2812160967, 8518.275946544612, 36091.278174435836, 36439.81780091082, 36500.0, 36604.81697591495, 36617.63382366249, 41425.585744142176, 41814.163716724885, 44154.55845441505, 45905.31142032939, 46073.76963115163, 10346.793064138525, 10591.5233814477, 10614.416207108683, 10669.946650266698, 11266.098712103176, 11591.478383472595, 11779.175457717878, 11827.408629568316, 11955.581554645545, 12015.519379224734, 10528.473576321307, 10690.518926648165, 10731.40977246259, 10950.890491095306, 11009.174311926477, 10715.732106697395, 10788.568457261621, 10891.346519208873, 11248.7750244993, 11336.489857956576, 10364.948175259377, 11101.888981110085, 11116.777664446505, 11276.210665253353, 11529.769404612029, 9392.295577831554, 9623.0, 9645.324827262024, 9830.55762490704, 9865.112139907444, 8855.73432797017, 9240.168384845396, 9529.76113105292, 9604.9039509604, 9659.46872921996], "unit": "ms", "name": "yui.html", "value": 6259.533615913915}], "name": "dromaeo_css", "value": 7062.506410058993}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 110.0, 110.0, 112.0, 123.0, 110.0, 111.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [152.0, 139.0, 155.0, 163.0, 129.0, 152.0, 161.0, 130.0, 171.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [168.0, 162.0, 162.0, 163.0, 162.0, 163.0, 162.0, 166.0, 167.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 71.0, 72.0, 72.0, 155.0, 71.0, 78.0, 70.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 146.0, 92.0, 92.0, 94.0, 137.0, 94.0, 94.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [61.0, 65.0, 63.0, 60.0, 60.0, 61.0, 67.0, 65.0, 61.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 62.1}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 71.0, 71.0, 70.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [91.0, 86.0, 93.0, 85.0, 84.0, 84.0, 87.0, 85.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [126.0, 118.0, 115.0, 116.0, 127.0, 124.0, 123.0, 124.0, 129.0, 135.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [141.0, 149.0, 152.0, 157.0, 155.0, 151.0, 154.0, 146.0, 152.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 69.0, 68.0, 67.0, 69.0, 69.0, 65.0, 72.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1524.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [183.99264029438822], "unit": "score", "name": "Richards", "value": 191.86637}, {"lowerIsBetter": false, "replicates": [191.79133103183736], "unit": "score", "name": "DeltaBlue", "value": 344.73925199999996}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5005.0], "unit": "score", "name": "Decrypt", "value": 53.18301698301701}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [719.4244604316547], "unit": "score", "name": "Earley", "value": 926.3835699999998}, {"lowerIsBetter": false, "replicates": [12192.77108433735], "unit": "score", "name": "Boyer", "value": 54.66050296442688}, {"lowerIsBetter": false, "replicates": [25146.341463414636], "unit": "score", "name": "RegExp", "value": 36.22733753637248}, {"lowerIsBetter": false, "replicates": [631.7119393556538], "unit": "score", "name": "Splay", "value": 129.000253}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21083.586698249466}]} 02:59:32 INFO - RETURN: dromaeo_css: 7062.51 02:59:32 INFO - RETURN: kraken: 1524.50 02:59:32 INFO - RETURN: v8_7: 21083.59 02:59:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21083.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1524.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "7062.51"}}} 02:59:32 INFO - Return code: 0 02:59:32 INFO - # TBPL SUCCESS # 02:59:32 INFO - Running post-action listener: _resource_record_post_action 02:59:32 INFO - Running post-run listener: _resource_record_post_run 02:59:33 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 527609856; Read time: 0; Write time: 672444 02:59:33 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 242401280; Read time: 0; Write time: 489236 02:59:33 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 280457216; Read time: 0; Write time: 182952 02:59:33 INFO - Running post-run listener: _upload_blobber_files 02:59:33 INFO - Blob upload gear active. 02:59:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:59:33 INFO - Copying logs to upload dir... 02:59:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.466700 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-23 02:59:32.038601) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 02:59:32.042444) ========= 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=820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008933 build_url: 'https://queue.taskcluster.net/v1/task/RhMFtPq_SuWQLCQ87_jbdw/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-23 02:59:32.091109) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:59:32.091424) ========= 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=820bb6602ddf640013a48df2000001a9-1448271799.77280-429495729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:59:32.141040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 02:59:32.141380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 02:59:32.141729) ========= ========= Total master_lag: 0.27 =========