builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1447912597.34 results: success (0) buildid: 20151118203114 builduid: 230ea67b005f47afa8fa77ec69f9fb89 revision: cae56980cbec07da0f7c28be592bff3461086520 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.337539) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.338821) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.339123) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006727 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.360675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.360967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.374175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.374446) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.424806) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.425133) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.425513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.425810) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 21:56:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-11-18 21:56:37 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182645 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.621374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.621646) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013993 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.671285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:37.671632) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cae56980cbec07da0f7c28be592bff3461086520 --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/fx-team --rev cae56980cbec07da0f7c28be592bff3461086520 --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=9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 21:56:37,799 truncating revision to first 12 chars 2015-11-18 21:56:37,799 Setting DEBUG logging. 2015-11-18 21:56:37,800 attempt 1/10 2015-11-18 21:56:37,800 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cae56980cbec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 21:56:38,059 unpacking tar archive at: fx-team-cae56980cbec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544356 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:38.228721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:38.229019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:38.245491) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:38.245822) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:38.246229) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-18 21:56:38.246540) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:56:38 INFO - MultiFileLogger online at 20151118 21:56:38 in /builds/slave/test-pgo 21:56:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:56:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:56:38 INFO - {'append_to_log': False, 21:56:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:56:38 INFO - 'blob_upload_branch': 'Fx-Team', 21:56:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:56:38 INFO - 'branch': 'Fx-Team', 21:56:38 INFO - 'buildbot_json_path': 'buildprops.json', 21:56:38 INFO - 'config_files': ('talos/linux_config.py',), 21:56:38 INFO - 'default_actions': ('clobber', 21:56:38 INFO - 'read-buildbot-config', 21:56:38 INFO - 'download-and-extract', 21:56:38 INFO - 'populate-webroot', 21:56:38 INFO - 'create-virtualenv', 21:56:38 INFO - 'install', 21:56:38 INFO - 'run-tests'), 21:56:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:56:38 INFO - 'download_minidump_stackwalk': True, 21:56:38 INFO - 'download_symbols': 'ondemand', 21:56:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:56:38 INFO - 'tooltool.py': '/tools/tooltool.py', 21:56:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:56:38 INFO - '/tools/misc-python/virtualenv.py')}, 21:56:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:56:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:56:38 INFO - 'installer_path': 'installer.exe', 21:56:38 INFO - 'log_level': 'info', 21:56:38 INFO - 'log_name': 'talos', 21:56:38 INFO - 'log_to_console': True, 21:56:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:56:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:56:38 INFO - 'opt_config_files': (), 21:56:38 INFO - 'pip_index': False, 21:56:38 INFO - 'sps_profile': False, 21:56:38 INFO - 'sps_profile_interval': 0, 21:56:38 INFO - 'suite': 'dromaeojs-e10s', 21:56:38 INFO - 'system_bits': '64', 21:56:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:56:38 INFO - 'title': 'talos-linux64-ix-036', 21:56:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:56:38 INFO - 'use_talos_json': True, 21:56:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:56:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:56:38 INFO - 'work_dir': 'build'} 21:56:38 INFO - ##### 21:56:38 INFO - ##### Running clobber step. 21:56:38 INFO - ##### 21:56:38 INFO - Running pre-action listener: _resource_record_pre_action 21:56:38 INFO - Running main action method: clobber 21:56:38 INFO - rmtree: /builds/slave/test-pgo/build 21:56:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:56:38 INFO - Running post-action listener: _resource_record_post_action 21:56:38 INFO - ##### 21:56:38 INFO - ##### Running read-buildbot-config step. 21:56:38 INFO - ##### 21:56:38 INFO - Running pre-action listener: _resource_record_pre_action 21:56:38 INFO - Running main action method: read_buildbot_config 21:56:38 INFO - Using buildbot properties: 21:56:38 INFO - { 21:56:38 INFO - "properties": { 21:56:38 INFO - "buildnumber": 343, 21:56:38 INFO - "product": "firefox", 21:56:38 INFO - "script_repo_revision": "production", 21:56:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:56:38 INFO - "repository": "", 21:56:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 21:56:38 INFO - "buildid": "20151118203114", 21:56:38 INFO - "slavename": "talos-linux64-ix-036", 21:56:38 INFO - "pgo_build": "True", 21:56:38 INFO - "basedir": "/builds/slave/test-pgo", 21:56:38 INFO - "project": "", 21:56:38 INFO - "platform": "ubuntu64_hw", 21:56:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:56:38 INFO - "slavebuilddir": "test", 21:56:38 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:56:38 INFO - "branch": "fx-team", 21:56:38 INFO - "repo_path": "integration/fx-team", 21:56:38 INFO - "stage_platform": "linux64-pgo", 21:56:38 INFO - "builduid": "230ea67b005f47afa8fa77ec69f9fb89", 21:56:38 INFO - "revision": "cae56980cbec07da0f7c28be592bff3461086520" 21:56:38 INFO - }, 21:56:38 INFO - "sourcestamp": { 21:56:38 INFO - "repository": "", 21:56:38 INFO - "hasPatch": false, 21:56:38 INFO - "project": "", 21:56:38 INFO - "branch": "fx-team-linux64-pgo-talos", 21:56:38 INFO - "changes": [ 21:56:38 INFO - { 21:56:38 INFO - "category": null, 21:56:38 INFO - "files": [ 21:56:38 INFO - { 21:56:38 INFO - "url": null, 21:56:38 INFO - "name": "https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:56:38 INFO - } 21:56:38 INFO - ], 21:56:38 INFO - "repository": "", 21:56:38 INFO - "rev": "cae56980cbec07da0f7c28be592bff3461086520", 21:56:38 INFO - "who": "sendchange", 21:56:38 INFO - "when": 1447912536, 21:56:38 INFO - "number": 6681145, 21:56:38 INFO - "comments": "", 21:56:38 INFO - "project": "", 21:56:38 INFO - "at": "Wed 18 Nov 2015 21:55:36", 21:56:38 INFO - "branch": "fx-team-linux64-pgo-talos", 21:56:38 INFO - "revlink": "", 21:56:38 INFO - "properties": [ 21:56:38 INFO - [ 21:56:38 INFO - "buildid", 21:56:38 INFO - "20151118203114", 21:56:38 INFO - "Change" 21:56:38 INFO - ], 21:56:38 INFO - [ 21:56:38 INFO - "builduid", 21:56:38 INFO - "230ea67b005f47afa8fa77ec69f9fb89", 21:56:38 INFO - "Change" 21:56:38 INFO - ], 21:56:38 INFO - [ 21:56:38 INFO - "pgo_build", 21:56:38 INFO - "True", 21:56:38 INFO - "Change" 21:56:38 INFO - ] 21:56:38 INFO - ], 21:56:38 INFO - "revision": "cae56980cbec07da0f7c28be592bff3461086520" 21:56:38 INFO - } 21:56:38 INFO - ], 21:56:38 INFO - "revision": "cae56980cbec07da0f7c28be592bff3461086520" 21:56:38 INFO - } 21:56:38 INFO - } 21:56:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:56:38 INFO - Running post-action listener: _resource_record_post_action 21:56:38 INFO - ##### 21:56:38 INFO - ##### Running download-and-extract step. 21:56:38 INFO - ##### 21:56:38 INFO - Running pre-action listener: _resource_record_pre_action 21:56:38 INFO - Running main action method: download_and_extract 21:56:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:38 INFO - https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/test_packages.json 21:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/test_packages.json 21:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:56:44 INFO - Downloaded 1302 bytes. 21:56:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:56:44 INFO - Using the following test package requirements: 21:56:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:56:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:44 INFO - u'jsshell-linux-x86_64.zip'], 21:56:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:56:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:56:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:56:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:56:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:56:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:56: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')]} 21:56:44 INFO - https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:56:49 INFO - Downloaded 22475893 bytes. 21:56:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:56:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:56:50 INFO - Return code: 0 21:56:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:56: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')]} 21:56:50 INFO - https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:56:52 INFO - Downloaded 22475893 bytes. 21:56:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:56:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:56:53 INFO - Return code: 0 21:56: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')]} 21:56:53 INFO - https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:56:54 INFO - Downloaded 11130997 bytes. 21:56:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 21:56:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:56:55 INFO - Return code: 0 21:56: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')]} 21:56:55 INFO - https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:56:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:56:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:56:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:56:57 INFO - Downloaded 57209453 bytes. 21:56:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:56:57 INFO - mkdir: /builds/slave/test-pgo/properties 21:56:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:56:57 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:56:57 INFO - Contents: 21:56:57 INFO - build_url:https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:56:57 INFO - Running post-action listener: _resource_record_post_action 21:56:57 INFO - Running post-action listener: set_extra_try_arguments 21:56:57 INFO - ##### 21:56:57 INFO - ##### Running populate-webroot step. 21:56:57 INFO - ##### 21:56:57 INFO - Running pre-action listener: _resource_record_pre_action 21:56:57 INFO - Running main action method: populate_webroot 21:56:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:56:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:56:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:56:57 INFO - '../fennec_ids.txt'], 21:56:57 INFO - 'tests': ['tcheck2']}, 21:56:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:56:57 INFO - '--tppagecycles', 21:56:57 INFO - '7'], 21:56:57 INFO - 'tests': ['tsvgm']}}, 21:56:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:56:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:56:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:56:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:56:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:56:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:56:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:57 INFO - 'talos_options': ['--e10s'], 21:56:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:57 INFO - 'tests': ['damp', 'tps']}, 21:56:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:57 INFO - 'talos_options': ['--e10s'], 21:56:57 INFO - 'tests': ['damp', 'tps']}, 21:56:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:56:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:56:57 INFO - 'other': {'tests': ['a11yr', 21:56:57 INFO - 'ts_paint', 21:56:57 INFO - 'tpaint', 21:56:57 INFO - 'sessionrestore', 21:56:57 INFO - 'sessionrestore_no_auto_restore']}, 21:56:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:56:57 INFO - 'tests': ['a11yr', 21:56:57 INFO - 'ts_paint', 21:56:57 INFO - 'tpaint', 21:56:57 INFO - 'sessionrestore', 21:56:57 INFO - 'sessionrestore_no_auto_restore']}, 21:56:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:56:57 INFO - 'tests': ['a11yr', 21:56:57 INFO - 'ts_paint', 21:56:57 INFO - 'tpaint', 21:56:57 INFO - 'sessionrestore', 21:56:57 INFO - 'sessionrestore_no_auto_restore']}, 21:56:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:56:57 INFO - 'tests': ['a11yr', 21:56:57 INFO - 'ts_paint', 21:56:57 INFO - 'tpaint', 21:56:57 INFO - 'sessionrestore', 21:56:57 INFO - 'sessionrestore_no_auto_restore']}, 21:56:57 INFO - 'other_l64': {'tests': ['a11yr', 21:56:57 INFO - 'ts_paint', 21:56:57 INFO - 'tpaint', 21:56:57 INFO - 'sessionrestore', 21:56:57 INFO - 'sessionrestore_no_auto_restore']}, 21:56:57 INFO - 'other_nol64': {'tests': ['a11yr', 21:56:57 INFO - 'ts_paint', 21:56:57 INFO - 'tpaint', 21:56:57 INFO - 'sessionrestore', 21:56:57 INFO - 'sessionrestore_no_auto_restore']}, 21:56:57 INFO - 'svgr': {'tests': ['tsvgx', 21:56:57 INFO - 'tsvgr_opacity', 21:56:57 INFO - 'tart', 21:56:57 INFO - 'tscrollx', 21:56:57 INFO - 'cart']}, 21:56:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:56:57 INFO - 'tests': ['tsvgx', 21:56:57 INFO - 'tsvgr_opacity', 21:56:57 INFO - 'tart', 21:56:57 INFO - 'tscrollx', 21:56:57 INFO - 'cart']}, 21:56:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:57 INFO - 'tests': ['tp5o']}, 21:56:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:57 INFO - 'talos_options': ['--e10s'], 21:56:57 INFO - 'tests': ['tp5o']}, 21:56:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:57 INFO - 'talos_options': ['--xperf_path', 21:56:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:57 INFO - 'tests': ['tp5n']}, 21:56:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:57 INFO - 'talos_options': ['--e10s', 21:56:57 INFO - '--xperf_path', 21:56:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:57 INFO - 'tests': ['tp5n']}}, 21:56:57 INFO - 'talos.zip': {'path': '', 21:56:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:56:57 INFO - Running post-action listener: _resource_record_post_action 21:56:57 INFO - ##### 21:56:57 INFO - ##### Running create-virtualenv step. 21:56:57 INFO - ##### 21:56:57 INFO - Running pre-action listener: _resource_record_pre_action 21:56:57 INFO - Running main action method: create_virtualenv 21:56:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:56:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 21:56:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:56:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:56:57 INFO - Using real prefix '/usr' 21:56:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:56:58 INFO - Installing distribute.............................................................................................................................................................................................done. 21:57:00 INFO - Installing pip.................done. 21:57:00 INFO - Return code: 0 21:57:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:00 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 0x7f38e76f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1d70>, '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 0xfd2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd2fb0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:57:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:57:00 INFO - Using env: {'DISPLAY': ':0', 21:57:00 INFO - 'HOME': '/home/cltbld', 21:57:00 INFO - 'LANG': 'en_US.UTF-8', 21:57:00 INFO - 'LANGUAGE': 'en_US:en', 21:57:00 INFO - 'LOGNAME': 'cltbld', 21:57:00 INFO - 'MAIL': '/var/mail/cltbld', 21:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:00 INFO - 'MOZ_NO_REMOTE': '1', 21:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:00 INFO - 'NO_EM_RESTART': '1', 21:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:00 INFO - 'SHELL': '/bin/bash', 21:57:00 INFO - 'SHLVL': '1', 21:57:00 INFO - 'TERM': 'linux', 21:57:00 INFO - 'TMOUT': '86400', 21:57:00 INFO - 'USER': 'cltbld', 21:57:00 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 21:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:00 INFO - '_': '/tools/buildbot/bin/python'} 21:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:57:00 INFO - Cleaning up... 21:57:00 INFO - Return code: 0 21:57:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:00 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 0x7f38e76f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1d70>, '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 0xfd2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd2fb0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:57:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:57:00 INFO - Using env: {'DISPLAY': ':0', 21:57:00 INFO - 'HOME': '/home/cltbld', 21:57:00 INFO - 'LANG': 'en_US.UTF-8', 21:57:00 INFO - 'LANGUAGE': 'en_US:en', 21:57:00 INFO - 'LOGNAME': 'cltbld', 21:57:00 INFO - 'MAIL': '/var/mail/cltbld', 21:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:00 INFO - 'MOZ_NO_REMOTE': '1', 21:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:00 INFO - 'NO_EM_RESTART': '1', 21:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:00 INFO - 'SHELL': '/bin/bash', 21:57:00 INFO - 'SHLVL': '1', 21:57:00 INFO - 'TERM': 'linux', 21:57:00 INFO - 'TMOUT': '86400', 21:57:00 INFO - 'USER': 'cltbld', 21:57:00 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 21:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:00 INFO - '_': '/tools/buildbot/bin/python'} 21:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:00 INFO - Downloading/unpacking psutil>=0.7.1 21:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:02 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:57:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:57:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:57:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:57:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:57:02 INFO - Installing collected packages: psutil 21:57:02 INFO - Running setup.py install for psutil 21:57:02 INFO - building 'psutil._psutil_linux' extension 21:57:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:57:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:57:02 INFO - building 'psutil._psutil_posix' extension 21:57:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:57:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:57:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:57:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:57:02 INFO - Successfully installed psutil 21:57:02 INFO - Cleaning up... 21:57:03 INFO - Return code: 0 21:57:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f38e76f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1d70>, '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 0xfd2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd2fb0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:57:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:57:03 INFO - Using env: {'DISPLAY': ':0', 21:57:03 INFO - 'HOME': '/home/cltbld', 21:57:03 INFO - 'LANG': 'en_US.UTF-8', 21:57:03 INFO - 'LANGUAGE': 'en_US:en', 21:57:03 INFO - 'LOGNAME': 'cltbld', 21:57:03 INFO - 'MAIL': '/var/mail/cltbld', 21:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:03 INFO - 'MOZ_NO_REMOTE': '1', 21:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:03 INFO - 'NO_EM_RESTART': '1', 21:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:03 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:03 INFO - 'SHELL': '/bin/bash', 21:57:03 INFO - 'SHLVL': '1', 21:57:03 INFO - 'TERM': 'linux', 21:57:03 INFO - 'TMOUT': '86400', 21:57:03 INFO - 'USER': 'cltbld', 21:57:03 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 21:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:03 INFO - '_': '/tools/buildbot/bin/python'} 21:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:57:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:57:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:57:04 INFO - Installing collected packages: mozsystemmonitor 21:57:04 INFO - Running setup.py install for mozsystemmonitor 21:57:05 INFO - Successfully installed mozsystemmonitor 21:57:05 INFO - Cleaning up... 21:57:05 INFO - Return code: 0 21:57:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:57: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')]} 21:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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')]} 21:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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', '--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 0x7f38e76f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1d70>, '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 0xfd2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd2fb0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:57:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:57:05 INFO - Using env: {'DISPLAY': ':0', 21:57:05 INFO - 'HOME': '/home/cltbld', 21:57:05 INFO - 'LANG': 'en_US.UTF-8', 21:57:05 INFO - 'LANGUAGE': 'en_US:en', 21:57:05 INFO - 'LOGNAME': 'cltbld', 21:57:05 INFO - 'MAIL': '/var/mail/cltbld', 21:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:05 INFO - 'MOZ_NO_REMOTE': '1', 21:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:05 INFO - 'NO_EM_RESTART': '1', 21:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:05 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:05 INFO - 'SHELL': '/bin/bash', 21:57:05 INFO - 'SHLVL': '1', 21:57:05 INFO - 'TERM': 'linux', 21:57:05 INFO - 'TMOUT': '86400', 21:57:05 INFO - 'USER': 'cltbld', 21:57:05 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 21:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:05 INFO - '_': '/tools/buildbot/bin/python'} 21:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:05 INFO - Downloading/unpacking blobuploader==1.2.4 21:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:06 INFO - Downloading blobuploader-1.2.4.tar.gz 21:57:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:57:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:57:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:57:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:57:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:07 INFO - Downloading docopt-0.6.1.tar.gz 21:57:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:57:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:57:07 INFO - Installing collected packages: blobuploader, requests, docopt 21:57:07 INFO - Running setup.py install for blobuploader 21:57:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:57:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:57:07 INFO - Running setup.py install for requests 21:57:08 INFO - Running setup.py install for docopt 21:57:08 INFO - Successfully installed blobuploader requests docopt 21:57:08 INFO - Cleaning up... 21:57:08 INFO - Return code: 0 21:57:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:08 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 0x7f38e76f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1d70>, '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 0xfd2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd2fb0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:57:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:57:08 INFO - Using env: {'DISPLAY': ':0', 21:57:08 INFO - 'HOME': '/home/cltbld', 21:57:08 INFO - 'LANG': 'en_US.UTF-8', 21:57:08 INFO - 'LANGUAGE': 'en_US:en', 21:57:08 INFO - 'LOGNAME': 'cltbld', 21:57:08 INFO - 'MAIL': '/var/mail/cltbld', 21:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:08 INFO - 'MOZ_NO_REMOTE': '1', 21:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:08 INFO - 'NO_EM_RESTART': '1', 21:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:08 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:08 INFO - 'SHELL': '/bin/bash', 21:57:08 INFO - 'SHLVL': '1', 21:57:08 INFO - 'TERM': 'linux', 21:57:08 INFO - 'TMOUT': '86400', 21:57:08 INFO - 'USER': 'cltbld', 21:57:08 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 21:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:08 INFO - '_': '/tools/buildbot/bin/python'} 21:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:08 INFO - Running setup.py (path:/tmp/pip-w3oQjF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:08 INFO - Running setup.py (path:/tmp/pip-iqixN_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:08 INFO - Running setup.py (path:/tmp/pip-iGWmsG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:08 INFO - Running setup.py (path:/tmp/pip-E8714t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:08 INFO - Running setup.py (path:/tmp/pip-KblIhu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:08 INFO - Running setup.py (path:/tmp/pip-TNE6xC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:08 INFO - Running setup.py (path:/tmp/pip-G0QnoH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:08 INFO - Running setup.py (path:/tmp/pip-T3XUx_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:09 INFO - Running setup.py (path:/tmp/pip-8arLYw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:09 INFO - Running setup.py (path:/tmp/pip-KgXGXL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:09 INFO - Running setup.py (path:/tmp/pip-aKdz5g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:09 INFO - Running setup.py (path:/tmp/pip-GQYfJb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:09 INFO - Running setup.py (path:/tmp/pip-2moaLn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:09 INFO - Running setup.py (path:/tmp/pip-90YWIv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:09 INFO - Running setup.py (path:/tmp/pip-bt0Dfi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:09 INFO - Running setup.py (path:/tmp/pip-MSlSSq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:09 INFO - Running setup.py (path:/tmp/pip-W57wQB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:57:09 INFO - Running setup.py install for manifestparser 21:57:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:57:09 INFO - Running setup.py install for mozcrash 21:57:09 INFO - Running setup.py install for mozdebug 21:57:09 INFO - Running setup.py install for mozdevice 21:57:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Running setup.py install for mozfile 21:57:10 INFO - Running setup.py install for mozhttpd 21:57:10 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Running setup.py install for mozinfo 21:57:10 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Running setup.py install for mozInstall 21:57:10 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Running setup.py install for mozleak 21:57:10 INFO - Running setup.py install for mozlog 21:57:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Running setup.py install for moznetwork 21:57:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Running setup.py install for mozprocess 21:57:10 INFO - Running setup.py install for mozprofile 21:57:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:57:10 INFO - Running setup.py install for mozrunner 21:57:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:57:11 INFO - Running setup.py install for mozscreenshot 21:57:11 INFO - Running setup.py install for moztest 21:57:11 INFO - Running setup.py install for mozversion 21:57:11 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:57:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:57:11 INFO - Cleaning up... 21:57:11 INFO - Return code: 0 21:57:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f38e76f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1d70>, '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 0xfd2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd2fb0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:57:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:57:11 INFO - Using env: {'DISPLAY': ':0', 21:57:11 INFO - 'HOME': '/home/cltbld', 21:57:11 INFO - 'LANG': 'en_US.UTF-8', 21:57:11 INFO - 'LANGUAGE': 'en_US:en', 21:57:11 INFO - 'LOGNAME': 'cltbld', 21:57:11 INFO - 'MAIL': '/var/mail/cltbld', 21:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:11 INFO - 'MOZ_NO_REMOTE': '1', 21:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:11 INFO - 'NO_EM_RESTART': '1', 21:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:11 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:11 INFO - 'SHELL': '/bin/bash', 21:57:11 INFO - 'SHLVL': '1', 21:57:11 INFO - 'TERM': 'linux', 21:57:11 INFO - 'TMOUT': '86400', 21:57:11 INFO - 'USER': 'cltbld', 21:57:11 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 21:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:11 INFO - '_': '/tools/buildbot/bin/python'} 21:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:11 INFO - Running setup.py (path:/tmp/pip-GetZqt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 21:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:11 INFO - Running setup.py (path:/tmp/pip-b71_YV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:11 INFO - Running setup.py (path:/tmp/pip-h4DNjY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 21:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:11 INFO - Running setup.py (path:/tmp/pip-oFAXXp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:11 INFO - Running setup.py (path:/tmp/pip-XWrim6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 21:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:12 INFO - Running setup.py (path:/tmp/pip-yykCSZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 21:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:12 INFO - Running setup.py (path:/tmp/pip-zB_fWT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 21:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:12 INFO - Running setup.py (path:/tmp/pip-BXN6Vx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 21:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:12 INFO - Running setup.py (path:/tmp/pip-_v5i5b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 21:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:12 INFO - Running setup.py (path:/tmp/pip-KuUUyT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:12 INFO - Running setup.py (path:/tmp/pip-6CuDxE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 21:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:12 INFO - Running setup.py (path:/tmp/pip-vlJHVY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 21:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:12 INFO - Running setup.py (path:/tmp/pip-0p0svh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 21:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:12 INFO - Running setup.py (path:/tmp/pip-O6w43a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 21:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:12 INFO - Running setup.py (path:/tmp/pip-M9iWSx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 21:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:12 INFO - Running setup.py (path:/tmp/pip-XYq1jU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 21:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:12 INFO - Running setup.py (path:/tmp/pip-GxSuly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:57:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:14 INFO - Downloading blessings-1.5.1.tar.gz 21:57:14 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 21:57:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:57:14 INFO - Installing collected packages: blessings 21:57:14 INFO - Running setup.py install for blessings 21:57:14 INFO - Successfully installed blessings 21:57:14 INFO - Cleaning up... 21:57:14 INFO - Return code: 0 21:57:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:57:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:57:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:57:14 INFO - Reading from file tmpfile_stdout 21:57:14 INFO - Current package versions: 21:57:14 INFO - argparse == 1.2.1 21:57:14 INFO - blessings == 1.5.1 21:57:14 INFO - blobuploader == 1.2.4 21:57:14 INFO - docopt == 0.6.1 21:57:14 INFO - manifestparser == 1.1 21:57:14 INFO - mozInstall == 1.12 21:57:14 INFO - mozcrash == 0.16 21:57:14 INFO - mozdebug == 0.1 21:57:14 INFO - mozdevice == 0.47 21:57:14 INFO - mozfile == 1.2 21:57:14 INFO - mozhttpd == 0.7 21:57:14 INFO - mozinfo == 0.9 21:57:14 INFO - mozleak == 0.1 21:57:14 INFO - mozlog == 3.0 21:57:14 INFO - moznetwork == 0.27 21:57:14 INFO - mozprocess == 0.22 21:57:14 INFO - mozprofile == 0.27 21:57:14 INFO - mozrunner == 6.11 21:57:14 INFO - mozscreenshot == 0.1 21:57:14 INFO - mozsystemmonitor == 0.0 21:57:14 INFO - moztest == 0.7 21:57:14 INFO - mozversion == 1.4 21:57:14 INFO - psutil == 3.1.1 21:57:14 INFO - requests == 1.2.3 21:57:14 INFO - wsgiref == 0.1.2 21:57:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:14 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 0x7f38e76f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1d70>, '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 0xfd2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd2fb0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 21:57:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:57:14 INFO - Using env: {'DISPLAY': ':0', 21:57:14 INFO - 'HOME': '/home/cltbld', 21:57:14 INFO - 'LANG': 'en_US.UTF-8', 21:57:14 INFO - 'LANGUAGE': 'en_US:en', 21:57:14 INFO - 'LOGNAME': 'cltbld', 21:57:14 INFO - 'MAIL': '/var/mail/cltbld', 21:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:14 INFO - 'MOZ_NO_REMOTE': '1', 21:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:14 INFO - 'NO_EM_RESTART': '1', 21:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:14 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:14 INFO - 'SHELL': '/bin/bash', 21:57:14 INFO - 'SHLVL': '1', 21:57:14 INFO - 'TERM': 'linux', 21:57:14 INFO - 'TMOUT': '86400', 21:57:14 INFO - 'USER': 'cltbld', 21:57:14 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 21:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:14 INFO - '_': '/tools/buildbot/bin/python'} 21:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 21:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 21:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 21:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 21:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 21:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 21:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 21:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:57:15 INFO - Cleaning up... 21:57:15 INFO - Return code: 0 21:57:15 INFO - Running post-action listener: _resource_record_post_action 21:57:15 INFO - Running post-action listener: _start_resource_monitoring 21:57:15 INFO - Starting resource monitoring. 21:57:15 INFO - ##### 21:57:15 INFO - ##### Running install step. 21:57:15 INFO - ##### 21:57:15 INFO - Running pre-action listener: _resource_record_pre_action 21:57:15 INFO - Running main action method: install 21:57:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:57:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:57:15 INFO - Reading from file tmpfile_stdout 21:57:15 INFO - Detecting whether we're running mozinstall >=1.0... 21:57:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:57:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:57:15 INFO - Reading from file tmpfile_stdout 21:57:15 INFO - Output received: 21:57:15 INFO - Usage: mozinstall [options] installer 21:57:15 INFO - Options: 21:57:15 INFO - -h, --help show this help message and exit 21:57:15 INFO - -d DEST, --destination=DEST 21:57:15 INFO - Directory to install application into. [default: 21:57:15 INFO - "/builds/slave/test-pgo"] 21:57:15 INFO - --app=APP Application being installed. [default: firefox] 21:57:15 INFO - mkdir: /builds/slave/test-pgo/build/application 21:57:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 21:57:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 21:57:29 INFO - Reading from file tmpfile_stdout 21:57:29 INFO - Output received: 21:57:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:57:29 INFO - Running post-action listener: _resource_record_post_action 21:57:29 INFO - ##### 21:57:29 INFO - ##### Running run-tests step. 21:57:29 INFO - ##### 21:57:29 INFO - Running pre-action listener: _resource_record_pre_action 21:57:29 INFO - Running main action method: run_tests 21:57:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:57:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:57:29 INFO - Python 2.7.3 21:57:29 INFO - Return code: 0 21:57:29 INFO - grabbing minidump binary from tooltool 21:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:29 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 0xfd1d70>, '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 0xfd2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd2fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:57:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 21:57:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:57:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:57:29 INFO - Return code: 0 21:57:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:57:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:57:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:57:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:57:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:57:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 21:57:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost 21:57:29 INFO - Using env: {'DISPLAY': ':0', 21:57:29 INFO - 'HOME': '/home/cltbld', 21:57:29 INFO - 'LANG': 'en_US.UTF-8', 21:57:29 INFO - 'LANGUAGE': 'en_US:en', 21:57:29 INFO - 'LOGNAME': 'cltbld', 21:57:29 INFO - 'MAIL': '/var/mail/cltbld', 21:57:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:57:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:29 INFO - 'MOZ_NO_REMOTE': '1', 21:57:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:29 INFO - 'NO_EM_RESTART': '1', 21:57:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:29 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:57:29 INFO - 'SHELL': '/bin/bash', 21:57:29 INFO - 'SHLVL': '1', 21:57:29 INFO - 'TERM': 'linux', 21:57:29 INFO - 'TMOUT': '86400', 21:57:29 INFO - 'USER': 'cltbld', 21:57:29 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302', 21:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:29 INFO - '_': '/tools/buildbot/bin/python'} 21:57:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] with output_timeout 3600 21:57:30 INFO - mozversion INFO | application_buildid: 20151118203114 21:57:30 INFO - mozversion INFO | application_changeset: cae56980cbec07da0f7c28be592bff3461086520 21:57:30 INFO - mozversion INFO | application_display_name: Nightly 21:57:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:57:30 INFO - mozversion INFO | application_name: Firefox 21:57:30 INFO - mozversion INFO | application_remotingname: firefox 21:57:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:57:30 INFO - mozversion INFO | application_vendor: Mozilla 21:57:30 INFO - mozversion INFO | application_version: 45.0a1 21:57:30 INFO - mozversion INFO | platform_buildid: 20151118203114 21:57:30 INFO - mozversion INFO | platform_changeset: cae56980cbec07da0f7c28be592bff3461086520 21:57:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:57:30 INFO - mozversion INFO | platform_version: 45.0a1 21:57:30 INFO - 2015-11-18 21:57:30,170 DEBUG : using testdate: 1447912650 21:57:30 INFO - 2015-11-18 21:57:30,170 DEBUG : actual date: 1447912650 21:57:30 INFO - 2015-11-18 21:57:30,217 INFO : starting webserver on 'localhost:49340' 21:57:30 INFO - 2015-11-18 21:57:30,218 INFO : Starting test suite talos-linux64-ix-036.e 21:57:30 INFO - 2015-11-18 21:57:30,218 INFO : Starting test dromaeo_css 21:57:30 INFO - 2015-11-18 21:57:30,218 DEBUG : operating with platform_type : linux_ 21:57:30 INFO - 2015-11-18 21:57:30,219 INFO : Initialising browser for dromaeo_css test... 21:57:30 INFO - 2015-11-18 21:57:30,234 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpf07iR2/profile http://localhost:49340/getInfo.html 21:57:36 INFO - 2015-11-18 21:57:36,409 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:57:36 INFO - 2015-11-18 21:57:36,409 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:57:36 INFO - 2015-11-18 21:57:36,409 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:57:36 INFO - 2015-11-18 21:57:36,409 DEBUG : BROWSER_OUTPUT: __metrics 21:57:37 INFO - 2015-11-18 21:57:37,507 INFO : Browser initialized. 21:57:37 INFO - 2015-11-18 21:57:37,507 INFO : Running cycle 1/1 for dromaeo_css test... 21:57:37 INFO - 2015-11-18 21:57:37,507 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpf07iR2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:57:49 INFO - 2015-11-18 21:57:49,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 140144640 21:57:49 INFO - 2015-11-18 21:57:49,288 DEBUG : BROWSER_OUTPUT: 21:58:38 INFO - 2015-11-18 21:58:38,895 DEBUG : BROWSER_OUTPUT: 1447912718892 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] 22:00:47 INFO - 2015-11-18 22:00:47,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49340/tests/dromaeo/cssquery-ext.html) 22:00:49 INFO - 2015-11-18 22:00:49,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 148271104 22:00:49 INFO - 2015-11-18 22:00:49,007 DEBUG : BROWSER_OUTPUT: 22:03:50 INFO - 2015-11-18 22:03:50,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/dromaeo/cssquery-ext.html (next: http://localhost:49340/tests/dromaeo/cssquery-jquery.html) 22:03:51 INFO - 2015-11-18 22:03:51,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 141438976 22:03:51 INFO - 2015-11-18 22:03:51,511 DEBUG : BROWSER_OUTPUT: 22:06:53 INFO - 2015-11-18 22:06:53,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49340/tests/dromaeo/cssquery-mootools.html) 22:06:53 INFO - 2015-11-18 22:06:53,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 142446592 22:06:53 INFO - 2015-11-18 22:06:53,694 DEBUG : BROWSER_OUTPUT: 22:09:55 INFO - 2015-11-18 22:09:55,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49340/tests/dromaeo/cssquery-prototype.html) 22:09:55 INFO - 2015-11-18 22:09:55,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 140525568 22:09:55 INFO - 2015-11-18 22:09:55,928 DEBUG : BROWSER_OUTPUT: 22:12:58 INFO - 2015-11-18 22:12:58,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49340/tests/dromaeo/cssquery-yui.html) 22:12:58 INFO - 2015-11-18 22:12:58,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 141828096 22:12:58 INFO - 2015-11-18 22:12:58,846 DEBUG : BROWSER_OUTPUT: 22:16:01 INFO - 2015-11-18 22:16:01,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/dromaeo/cssquery-yui.html (next: http://localhost:49340/tests/dromaeo/cssquery-dojo.html) 22:16:01 INFO - 2015-11-18 22:16:01,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 145174528 22:16:01 INFO - 2015-11-18 22:16:01,492 DEBUG : BROWSER_OUTPUT: 22:16:01 INFO - 2015-11-18 22:16:01,492 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:16:01 INFO - 2015-11-18 22:16:01,492 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:16:01 INFO - 2015-11-18 22:16:01,492 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:16:01 INFO - 2015-11-18 22:16:01,492 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:16:01 INFO - 2015-11-18 22:16:01,492 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3271.8527666255018;3302.0589132097357;3325.251818340872;3347.3472672828793;3357.916052098697;5393.029254734156;5652.547796176306;5662.6036177467595;5667.518260947824;5683.488486036256;5447.945520544793;5551.056320425528;5602.7758889644465;5623.128415095667;5662.952353814547;5094.668846524983;5120.513551212638;5142.894277730287;5205.3233079699585;5229.163333866582;5170.224466330062;5205.245239440298;5205.505476979681;5257.526822585966;5270.367555893298;4948.307236986825;5011.298418221452;5057.519535644108;5101.464346243665;5109.897802043975;5097.337346145015;5158.819441319573;5162.74186290684;5181.766820493087;5243.397009343936;4981.053599816023;5161.767720452589;5164.302819119408;5168.586513078944;5170.302009228743;5263.499967503081;5307.681539107666;5323.334583177103;5350.91973620396;5364.544013758835;6031.065184896304;6049.758009679607;6049.939500604982;6051.243594550681;6077.36187700294;5792.739326730307;5895.528357731371;6087.969560152171;6096.939030609726;6097.603655762361;5577.9163312550345;5656.462636049569;5661.490465858052;5662.85842853932;5695.943040569624;6193.535484838655;6210.658413787195;6211.720472578745;6212.751489940442;6222.097795819672;5861.941380586225;5879.470847623649;5949.405059494103;5984.760609575568;5997.340292567814;6127.4485296322655;6133.958051319447;6145.5698101133385;6169.753209871555;6184.257889053342;6100.115717648922;6117.796956032686;6136.427173609184;6137.324894261627;6143.082036032938;5801.100829371454;5938.109283607493;5959.851003724855;5969.850753731104;6134.803982731532;4514.345419914094;4518.525554816697;4520.547945205453;4520.683552151384;4550.2492088804975;4057.0668746188544;4057.39139129133;4080.0615858352153;4126.628603425706;4185.434966279574;5622.156676498476;5657.9434205658235;5695.03184458643;5702.287214098238;5742.913856292159;5850.9414905851245;5954.523638108941;5994.970025149846;6015.39846015395;6097.725602347905;5849.151872978395;5892;5893.764249430061;5898.174255604219;5907.940920590739;5117.8720531987;5147.330846989942;5151.021305951857;5161.974190129025;5179.19722443022;6001.3098493672915;6112.898653789679;6117.522930757244;6121.452973575903;6137.693115344215;5902.085176797603;6054.3642917493025;6055.394460553909;6058.848528786815;6107.961646520191;6219.813405597839;6362.650054246876;6379.138816259746;6432.614043157426;6439.67801609927;5783.7397317119985;5881.05903055509;6110.052941794029;6147.569670123048;6148.231471066117;6060.484858786876;6075.058365953284;6079.969600151971;6140.057253910645;6146.200993870768;5857.853553661193;5867.471927526372;5876.94123058781;5898.882022359443;5954;5765.538756899354;5774.393688662798;5810.912836307543;5853.64878107315;5885.028970219866;5841;5847.210626565359;5855.414458554111;5858;5945.197398351167;5971.343152253162;6027.78902738402;6029.306629737461;6038.969805150946;6049.546284028627;5613.887722245614;5659.801906933238;5686.829395117988;5746.741396637245;5838.32859221195 22:16:01 INFO - 2015-11-18 22:16:01,492 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.878366759313;581.9796307129251;586.7711592478937;602.5360472436223;603.8128180264118;39858.40212396816;40241.19517609653;40374;40488.797556012214;40674.38988415176;44061.559384406144;44415;44468.33297500532;44566.77716611412;44597.55402445974;8746.912530874706;8920.821583568324;8923.063078376774;8949.105089491064;8985.326100542452;8612.913870861274;8754.737357879241;8762.474251544896;8781.473111613324;8787.384883058188;8846.115388461167;8850.822983540325;8889.377743557954;8890.644374225056;8906.910930890674;8767.254783343391;8844.999999999936;8861.73414797554;8864.423812452202;8876.778080547974;8689.217970382695;8818.955905220433;8838.116188381111;8856;8856.335774816851;40596.79701601503;41078.79460602678;41204.587954120376;41205.793971029954;41297.58702412967;3434.334347841295;3487.2676737885076;4074.5110586729484;4078.6395222963074;4100.65144462721;30140.8492957536;30273.848630756926;30562;31849.203769905707;31966.360672786413;3467.2025434150287;3472.374972504948;3508.842102105386;3596.9100772480638;3629.7822130672243;280441;282160;282979;283280;283959.99999999796;56677.716611416676;57741.71129144327;60944.39055609387;61500;61569;57736.13395799066;57907;58067.419325807045;58116.709416453494;58149;15520.223988800515;15589.68820623581;15709.135997520018;15732.134732589817;15769.29038193284;11709.88290117105;11770.411479425995;11797.351145686898;11873.703157421134;11887.465064072137;19812.60374792496;20380.38858834237;20390.69413958792;20406.69389959152;20426.285080022128;7975.122736498981;8070.878936815952;8141.633626486822;8218.054923683734;8276.462029968154;911.5897845969208;929.1219797291494;960.9327347085637;962.485070487286;971.0386717149971;25783.226503204933;26997.460050798873;27086.729132708813;27097.322566935985;27574.448511029666;1063.2875973098044;1074.1460538871459;1081.4971038467152;1101.823708206683;1126.0653657464286;14107.36516856744;14370.13779173232;14502.202378869053;14552.927235363968;14576.41694332236;312593;318292;318710;318945;319702;53144.734276328374;53292.200616990776;53304;53350.199747003826;53354;1275.9425825837675;1336.8395792504766;1349.838019437654;1361.2241022617013;1369.5343583181766;27081.1875643731;27676.723232767414;27985.720142799128;28045.719542805127;28170.85914570414;45111.54888451205;45282.09435811331;45567.77216113898;45715.085698285184;45791.77104114458;289787;291776;292135;292444;292496;31231.53152702666;32671.836640816644;32717.672823271463;33083;33135.834320829206;40416;43589;44371.77814110909;44662.3300650484;45104.09791804211;33534.49698254577;33841.661583384834;34170;34466.655333446346;36077;36169.81915090408;36447.81776091103;37033.62966370302;37295.81352093222;37395.81302093472;35562.82218588891;35743;35893.461598076574;36288.092797679215;36304;31077.844610776803;32372.676273236964;32876.50685239676;32938.83530582332;32990.67009329876;25174.874125629256;25532.872335638203;25602.743972560034;25782.355441114123;26068.73931260739 22:16:01 INFO - 2015-11-18 22:16:01,493 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.0574741304077;360.3729510651467;362.4418395670667;367.1170834143884;367.5699431664952;12304.138710290283;12672.112952093357;16963.83036169638;18201.362952296673;19264.133114009885;11813.2321399109;11969.521219151224;11992.280463172216;12087.274763514195;12284.938575307111;4467.374567560536;4608.354830323758;4616.653750968674;4622.468416132154;4626.606738427221;4418.80115394808;4592.632589392841;4610.561996610317;4630.189716799563;4632.4441067072;4547.295169248771;4556.9088618227615;4663.580277775;4758.904821903578;4778.307145463906;4709.175894218498;4717.740524271164;4734.502877197913;4738.170820106502;4744.64415168862;4117.197146556423;4265.232258193524;4276.23027854986;4281.678874084456;4306.310990241577;13128.277944713038;13341.332933353293;13429.261390623511;13533.864661353358;13559.118657287245;2090.926817561378;2109.040386624082;2121.321177223289;2127.5532138250833;2139.882306473143;9788.119069283799;9798.412095274307;10019.89980100197;10036.949815250877;10177.949110254476;1709.102721071435;1714.5027941896835;1716.5880188754609;1733.6792693351645;1750.9737353939574;57378.42621573772;59102.203246626756;59135.704321478544;59778.10332845011;59969.99999999956;6791.456683465311;6855.211650660238;7007.7196912122945;7035.6482175891;7082.575045497287;8302.667893284322;8317.584120793936;8327.292180164633;8329.583520824055;8336.416450848503;5617.38208797032;5671.886562268732;5734.397888221677;5751.396103409165;5754.798582049608;5681;5707.086866101404;5728.398518155534;5923.6149650273455;6010.218671572755;3210.7270881974828;3232.563603913489;3254.9511757323658;3269.084656296241;3276.737860971117;1145.5360578965533;1157.542770605623;1166.9824952625718;1168.9240199387013;1199.8620158681688;409.22043507118985;414.5999110858036;421.1660911395454;421.63317913414915;428.1522585281099;10491.213159013105;10972;11063.834042489369;11167.497462614201;11190;439.9626031787334;447.19728088081973;448.07472569144613;450.94363204599426;471.73347058912293;5826.70866456684;5987;6013.098035294741;6052.606580572248;6090.33006369299;536872.8938131862;558226;559850;561459;568266;72717;74310.25689743142;74776.25223747693;75351;78352;546.8687514996373;553.8781468077017;555.2420945409486;560.3024234827666;560.571163060251;10415.791684166426;10933.562657493929;11121.110311175249;11358.886411135783;11439.08487321029;34108.658913410545;34563.30873382569;35024.824875875456;35238;36038.27923441569;42894.78552607217;44335.77832110948;44639.330410044524;44663.77668111639;44790.55209447864;5822.359540450631;6798.49877313194;6826.965865170841;6900.827479313058;6909.067275917888;12037.277763334228;12304.815427768412;12383;12441.315727635067;12483.812742808683;10244.546927583198;10462.895371046192;10638.574457021632;10698.679039628823;10787.67636970892;10360.430176340073;10453.425061621683;10528.736781580521;10715.946420267848;10959.835602466128;8923.464592124494;10550.947245264031;10906.80088166046;10946.835797462885;11001.284916480403;6751.966240168767;6785.728570857111;6829.69266383004;6871.587704737732;6876.587404755731;10159.79680406373;10684.09185219234;10887.401192934149;10897.67306980792;10952.56189752401 22:16:01 INFO - 2015-11-18 22:16:01,493 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1560.196498803116;1594.505703231998;1674.213119833678;1763.673720361733;1809.1316168239246;7554.584497852623;7996.40026997976;8046.356291496681;8083.151269116746;8116.797080073001;8050.838983220332;8087.1508491608265;8119.837603247932;8121.675132994673;8126.228008339213;2275.488015196576;2328.313147621447;2331.3006098170567;2337.964930526035;2339.02930283932;2277.5900337939165;2324.5583339165587;2370.9881450592725;2390.3307074019303;2391.0196819304088;2307.6423154411095;2323.3262353917344;2331.0209711920947;2342.6368912818457;2349.3539276698957;2287.8284128690416;2293.4381076636164;2309.8383113182085;2336.754640762721;2338.251759436981;2288.8512246704076;2309.58427483053;2317.2584772872688;2327.7090363704538;2334.323046316566;7795.649195786204;7808.960955195188;7839.471303095898;7849.293563579248;7890.723824666166;4639.141758774637;4717.669763116583;4722.055588882237;4737.194676904935;4771.904561908777;3245.415825151472;3278.426275401795;3292.3579901919134;3300.092474569489;3309.983450082734;1003.6687892995367;1004.5178314409052;1027.809855176787;1041.6250149946013;1063.0326402973258;10777.946110269477;10897.618583349546;10933.398663073527;10942.288751231144;10965.451727413598;4143.150654115899;4155.501339839238;4206.810693518799;4240.1307731914885;4247.447831781848;8806.031336552975;8833.734987950373;8854.158854908774;8868.379213455126;8871.556422178865;4590.104929538707;4602;4605.171069207508;4617.238155704338;4640;4130.545639979599;4226.450561426995;4245.745255284631;4265.146970605829;4283.1433713257475;3695.611960744137;3697.1311741741206;3714.405695088827;3718.8140592970244;3735.0849041984343;1163.7148898519747;1170.988290117105;1173.16705139352;1174.0900801878443;1176.3471273443322;1024.779672370444;1040.5057597641212;1041;1041.375174895072;1046.8115739167024;7515.286047825448;7522.924770752332;7534.434917381109;7547.8113047173165;7580.9620951894885;503.1747933389245;505.5298572327697;515.7163560041962;515.7498613172609;517.8032347707847;5864.970675146682;5866.12008198765;5916.2013128228;5917.6745279010065;5919.526437884959;9248;9251.306152038624;9513.619455221851;9672.613095476243;9691.70924872255;9361.859572106423;9380.296477764196;9488.620455181715;9495.90504094964;9548.045195480536;7304.306090921354;7326.96336518314;7385.519941203805;7400.925990740131;7455.4408419368765;7076.540024898365;7105.573665580082;7137.571745695275;7143.607101609461;7174.677139528838;8208.671653133808;8269.875951860606;8405.453645513022;8448.577571121543;8522.36082293818;8576.699815506427;8581.35639827003;8655.653773848975;8663.91336086631;8684.39209255346;6353.205849268841;6451.612903225634;6767.154105736783;7046.1192350956135;7066.540674856118;7718.035245594301;7734;7742.458027937991;7756.767296980874;7791.766247012599;7041.5422997505;7217.278272172741;7222.711091556279;7313.670884810303;7325.743598974011;7133.072700548895;7166.355028047501;7192.568445893263;7215.350618444365;7316.378107860892;7107.147142342952;7227.096612923385;7274.96362518184;7298.23368546295;7313.085864266966;6577.901331480128;6581.440577550962;6585.6377899216;6591.802245932629;6596.241432235354;6529.804105876831;6652.168478940132;6671.46628269747;6687.76592819249;6704.195496540447 22:16:01 INFO - 2015-11-18 22:16:01,493 DEBUG : BROWSER_OUTPUT: |4;prototype.html;333.39988021561186;335.65044687189686;341.6208009109889;342.14634486955043;350.1997934719166;6249.093881387196;6308.243010838694;6371.299157092716;6403.583767055138;6429.067785171147;6104.603200791946;6320.905186422196;6337.081123237128;6340.175777148976;6341.080543321215;4792.568668819806;4820.662553621248;4837.685550439211;4841.6852904561265;4850.248211527219;4844.854654360375;4849.709017458946;4851.199552073904;4854.708717476963;4854.844351171731;4717.9056418871605;4815.229563269878;4822.107910036637;4822.7829747661435;4830.637702172334;4807.831725889595;4808.3989501312335;4819.903601927959;4832.226843704991;4837.443693975203;4200.957990420087;4210.936835947463;4211.220924129046;4218.641415479688;4220.599043090901;5886.05823068307;5939.792107276267;5964.910526342108;5970.940290597082;5982.312034116088;5581.720913954286;5593.272874526327;5616.0171969905105;5617.80337688183;5625.09998400254;6628.8674226515195;6644.93355066448;6675.766348177839;6702.396784289437;6717;4664.113818374532;4672.415948006499;4683.274092515631;4690.273007683814;4694.788734506921;6857.897131543031;6945.826354341131;6985.266547012541;7000.229974702778;7011.949801836166;4782.0435912817575;4791.6406269529225;4793.209120495079;4796.448408433075;4807.110684523374;4831.299461578122;4848.587870031087;4849.733264670406;4855.101806165871;4856.587190088811;5582.162675598612;5588.0779671354585;5589.35722391922;5589.916151257735;5595.048841696921;6490.740370385131;6779.830504237433;6787.830304242335;6794.898076528856;6826.146731658543;1637.0505107038127;1645.5556999610037;1660.435451946344;1671.055853442801;1673.3473945161397;1080.5785743560018;1085.495244711213;1110.4725255503572;1112.6439539347332;1113.5378817790688;6417.582857114273;6424.646644434601;6447.484201263887;6454.225492940877;6458.515611329169;6808.285130061371;6827.351401616838;6853.7943861684225;6862.862742745117;6877.58734475923;6325.5255855811;6358.682065896686;6380.489560835215;6387.872242555216;6413.070104834773;3808.638179372955;3808.914459379064;3831.5210598675167;3844.2695887781233;3852.3836186210633;7286.8178295541975;7321.78034658961;7322;7326.780196594111;7343.596102214429;7018.227994920555;7263.0921134858145;7288.562686238736;7293.27067293277;7293.781186564305;7225.04923670606;7264.237255088246;7293.8905916411295;7296.306850849161;7298.160711518137;6995.825104372431;7006.439484841302;7009.684564194726;7019.438444924292;7033.366996970297;6720.395164435225;6937.861242775217;6947.722091116501;6952.130983627047;6957.512974091765;7234.312740289664;7251.601161935933;7252.673629686571;7316.0489136411925;7323.853522929405;4690.835820746258;4718.480967093686;4721.9055618888115;4767.213409787346;4780.808767649255;6754.628495432798;6775.932240677727;7015.6842942066705;7049.118860142482;7080.858382832417;6835.521513494008;6858.971154326891;6869.931300687129;6871.587704737732;6872.931270687229;6830.59016459014;6834;6835.350641689031;6840.973853921952;6847.246802851582;6557.278699342973;6716.899246511209;6725.125733654593;6725.4283385910785;6727.260001399744;6841.657917104224;6846.075779769667;6854.828629284308;6870.793876183722;6889.793306200822;6640.83397915056;6671.6330601815425;6698.129243198353;6699.9665001674675;6703.564268322543 22:16:01 INFO - 2015-11-18 22:16:01,494 DEBUG : BROWSER_OUTPUT: |5;yui.html;738.283864651288;745.1356426545208;785.83104632504;865.1737590600977;868.674247157316;13776.655583610414;13964.44142234312;14068.085574437655;14158.716825663481;14194.290285485724;12545.937270313636;12561;12690.619281421548;12721.10952233344;14365.425382984668;814.2630919018297;830.4145577367972;835.1523203947997;837.5979529825687;837.6774941647479;821.3798582070528;824.5382585751968;826.4751882554591;831.3349320543571;833.7748807821885;865.2645251536206;870.6909047288217;873.1312344217513;875.251659830845;881.5415983688478;863.7451951674271;864.4165188497801;868.4745728834059;872.2455076358967;872.5419154943673;642.1459458919626;642.1715986377567;643.4016364780751;644.9451796597294;644.9774257900998;12922.095453318272;12983.87016129836;13040.869591304061;13059.085863989525;13183.14309569875;11917.94041029798;12010;12303.077269204845;12601.495940162382;12961.351932403342;10423.270371074028;10489.895101048967;10500.474976251233;10602.56047215224;10654.307470014424;3618.8009659468717;3679.7056235501095;3695.981520092382;3699.315626609086;3811.599782022903;40658.79670601628;41108.79445602783;44348.55651443509;45219.09561808746;46662.30006549905;7607.961960190274;7787.5716835574585;9674.322797404115;10539.525721342558;10631.149508039338;11654.125940554492;11716.297022178696;11726.941365293289;11791.35147566892;11823.231489953125;6789.626570538668;6983.790486285419;7006.264342244093;7006.334398232159;7081.362677358959;4251.808668609858;4350.973901146871;4382.539833317455;4439.378487011821;4497.775111244425;2753.9586906196423;2783.3459137102764;2786.2337857089055;2786.749192572678;2791.52544067509;452.92300308947557;461.5984093838382;467.621226806288;468.98358557450325;470.41433415398046;527.0276340152412;653.5817077070678;679.1951537428164;680.938715515606;734.3757805865079;9026.954865225764;9192.954035229915;9196.356255062215;9263.120003599648;9385.67150149755;599.848291280742;654.2835595023441;664.2095905871997;694.7741983855267;709.7764204275637;4203.285441474956;4445.444319460067;4499.572540608637;4510.797014134372;4589.4722106958125;61316.693416533526;61520.69239653862;61667.383326166164;61830.38169618246;61963.6901815488;52524;54259.76012758505;54550.181747273826;54955.70265784066;55548.16677749837;44088.55911440909;45726.77136614296;45876.541234587894;46536.5346346539;48067;8778.297736180963;8784.560771961504;9187.908120918706;9432.717018489457;9530.952345238507;36203;36249;36340.63659363478;36936.44595331018;36954;43150.35274470948;44359.55640443554;44960.550394495636;47174;47614.76192619015;8413.411061225655;8608.65565377378;8737.126287371211;8751.868721969047;8887.644494220158;12339.75320493603;12738;12773.2336059833;12905.741885162432;12911.096223264656;11696.649100526998;11733.76532469363;11864.11019173548;11912.642620721392;12288.877111228774;11289.71775705614;11374.886251137383;11642.185047046625;11650.53397864076;12006.879931200925;11667.416629168678;11783.76432471363;12007;12239.204451710966;12271.631851044483;9989.500524973868;9993.524283935243;10245.641402550875;10337.534810933677;10360.378377297386;9401.623935042795;9544.570494327632;10388.324758890649;10401.21990850674;10438.321509101885 22:16:01 INFO - 2015-11-18 22:16:01,494 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:16:01 INFO - 2015-11-18 22:16:01,494 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:16:01 INFO - 2015-11-18 22:16:01,494 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,301 22:16:01 INFO - 2015-11-18 22:16:01,494 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:16:01 INFO - 2015-11-18 22:16:01,494 DEBUG : BROWSER_OUTPUT: __startTimestamp1447913761486__endTimestamp 22:16:01 INFO - 2015-11-18 22:16:01,494 DEBUG : BROWSER_OUTPUT: 22:16:01 INFO - 2015-11-18 22:16:01,494 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:16:01 INFO - 2015-11-18 22:16:01,495 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:16:01 INFO - 2015-11-18 22:16:01,495 DEBUG : BROWSER_OUTPUT: 22:16:01 INFO - 2015-11-18 22:16:01,495 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5602.92 Median:5847.21 stddev:646.20 (11.1%) stddev-sans-first:621.77 22:16:01 INFO - 2015-11-18 22:16:01,495 DEBUG : BROWSER_OUTPUT: Values: 3271.9 3302.1 3325.3 3347.3 3357.9 5393.0 5652.5 5662.6 5667.5 5683.5 5447.9 5551.1 5602.8 5623.1 5663.0 5094.7 5120.5 5142.9 5205.3 5229.2 5170.2 5205.2 5205.5 5257.5 5270.4 4948.3 5011.3 5057.5 5101.5 5109.9 5097.3 5158.8 5162.7 5181.8 5243.4 4981.1 5161.8 5164.3 5168.6 5170.3 5263.5 5307.7 5323.3 5350.9 5364.5 6031.1 6049.8 6049.9 6051.2 6077.4 5792.7 5895.5 6088.0 6096.9 6097.6 5577.9 5656.5 5661.5 5662.9 5695.9 6193.5 6210.7 6211.7 6212.8 6222.1 5861.9 5879.5 5949.4 5984.8 5997.3 6127.4 6134.0 6145.6 6169.8 6184.3 6100.1 6117.8 6136.4 6137.3 6143.1 5801.1 5938.1 5959.9 5969.9 6134.8 4514.3 4518.5 4520.5 4520.7 4550.2 4057.1 4057.4 4080.1 4126.6 4185.4 5622.2 5657.9 5695.0 5702.3 5742.9 5850.9 5954.5 5995.0 6015.4 6097.7 5849.2 5892.0 5893.8 5898.2 5907.9 5117.9 5147.3 5151.0 5162.0 5179.2 6001.3 6112.9 6117.5 6121.5 6137.7 5902.1 6054.4 6055.4 6058.8 6108.0 6219.8 6362.7 6379.1 6432.6 6439.7 5783.7 5881.1 6110.1 6147.6 6148.2 6060.5 6075.1 6080.0 6140.1 6146.2 5857.9 5867.5 5876.9 5898.9 5954.0 5765.5 5774.4 5810.9 5853.6 5885.0 5841.0 5847.2 5855.4 5858.0 5945.2 5971.3 6027.8 6029.3 6039.0 6049.5 5613.9 5659.8 5686.8 5746.7 5838.3 22:16:01 INFO - 2015-11-18 22:16:01,495 DEBUG : BROWSER_OUTPUT: 22:16:01 INFO - 2015-11-18 22:16:01,495 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46867.62 Median:19958.94 stddev:77742.51 (389.5%) stddev-sans-first:77882.82 22:16:01 INFO - 2015-11-18 22:16:01,495 DEBUG : BROWSER_OUTPUT: Values: 552.9 582.0 586.8 602.5 603.8 39858.4 40241.2 40374.0 40488.8 40674.4 44061.6 44415.0 44468.3 44566.8 44597.6 8746.9 8920.8 8923.1 8949.1 8985.3 8612.9 8754.7 8762.5 8781.5 8787.4 8846.1 8850.8 8889.4 8890.6 8906.9 8767.3 8845.0 8861.7 8864.4 8876.8 8689.2 8819.0 8838.1 8856.0 8856.3 40596.8 41078.8 41204.6 41205.8 41297.6 3434.3 3487.3 4074.5 4078.6 4100.7 30140.8 30273.8 30562.0 31849.2 31966.4 3467.2 3472.4 3508.8 3596.9 3629.8 280441.0 282160.0 282979.0 283280.0 283960.0 56677.7 57741.7 60944.4 61500.0 61569.0 57736.1 57907.0 58067.4 58116.7 58149.0 15520.2 15589.7 15709.1 15732.1 15769.3 11709.9 11770.4 11797.4 11873.7 11887.5 19812.6 20380.4 20390.7 20406.7 20426.3 7975.1 8070.9 8141.6 8218.1 8276.5 911.6 929.1 960.9 962.5 971.0 25783.2 26997.5 27086.7 27097.3 27574.4 1063.3 1074.1 1081.5 1101.8 1126.1 14107.4 14370.1 14502.2 14552.9 14576.4 312593.0 318292.0 318710.0 318945.0 319702.0 53144.7 53292.2 53304.0 53350.2 53354.0 1275.9 1336.8 1349.8 1361.2 1369.5 27081.2 27676.7 27985.7 28045.7 28170.9 45111.5 45282.1 45567.8 45715.1 45791.8 289787.0 291776.0 292135.0 292444.0 292496.0 31231.5 32671.8 32717.7 33083.0 33135.8 40416.0 43589.0 44371.8 44662.3 45104.1 33534.5 33841.7 34170.0 34466.7 36077.0 36169.8 36447.8 37033.6 37295.8 37395.8 35562.8 35743.0 35893.5 36288.1 36304.0 31077.8 32372.7 32876.5 32938.8 32990.7 25174.9 25532.9 25602.7 25782.4 26068.7 22:16:01 INFO - 2015-11-18 22:16:01,496 DEBUG : BROWSER_OUTPUT: 22:16:01 INFO - 2015-11-18 22:16:01,496 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27151.93 Median:23588.23 stddev:91240.81 (386.8%) stddev-sans-first:91474.58 22:16:01 INFO - 2015-11-18 22:16:01,497 DEBUG : BROWSER_OUTPUT: Values: 359.1 360.4 362.4 367.1 367.6 12304.1 12672.1 16963.8 18201.4 19264.1 11813.2 11969.5 11992.3 12087.3 12284.9 4467.4 4608.4 4616.7 4622.5 4626.6 4418.8 4592.6 4610.6 4630.2 4632.4 4547.3 4556.9 4663.6 4758.9 4778.3 4709.2 4717.7 4734.5 4738.2 4744.6 4117.2 4265.2 4276.2 4281.7 4306.3 13128.3 13341.3 13429.3 13533.9 13559.1 2090.9 2109.0 2121.3 2127.6 2139.9 9788.1 9798.4 10019.9 10036.9 10177.9 1709.1 1714.5 1716.6 1733.7 1751.0 57378.4 59102.2 59135.7 59778.1 59970.0 6791.5 6855.2 7007.7 7035.6 7082.6 8302.7 8317.6 8327.3 8329.6 8336.4 5617.4 5671.9 5734.4 5751.4 5754.8 5681.0 5707.1 5728.4 5923.6 6010.2 3210.7 3232.6 3255.0 3269.1 3276.7 1145.5 1157.5 1167.0 1168.9 1199.9 409.2 414.6 421.2 421.6 428.2 10491.2 10972.0 11063.8 11167.5 11190.0 440.0 447.2 448.1 450.9 471.7 5826.7 5987.0 6013.1 6052.6 6090.3 536872.9 558226.0 559850.0 561459.0 568266.0 72717.0 74310.3 74776.3 75351.0 78352.0 546.9 553.9 555.2 560.3 560.6 10415.8 10933.6 11121.1 11358.9 11439.1 34108.7 34563.3 35024.8 35238.0 36038.3 42894.8 44335.8 44639.3 44663.8 44790.6 5822.4 6798.5 6827.0 6900.8 6909.1 12037.3 12304.8 12383.0 12441.3 12483.8 10244.5 10462.9 10638.6 10698.7 10787.7 10360.4 10453.4 10528.7 10715.9 10959.8 8923.5 10550.9 10906.8 10946.8 11001.3 6752.0 6785.7 6829.7 6871.6 6876.6 10159.8 10684.1 10887.4 10897.7 10952.6 22:16:01 INFO - 2015-11-18 22:16:01,497 DEBUG : BROWSER_OUTPUT: 22:16:01 INFO - 2015-11-18 22:16:01,497 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5520.37 Median:6402.41 stddev:2885.94 (45.1%) stddev-sans-first:2878.69 22:16:01 INFO - 2015-11-18 22:16:01,498 DEBUG : BROWSER_OUTPUT: Values: 1560.2 1594.5 1674.2 1763.7 1809.1 7554.6 7996.4 8046.4 8083.2 8116.8 8050.8 8087.2 8119.8 8121.7 8126.2 2275.5 2328.3 2331.3 2338.0 2339.0 2277.6 2324.6 2371.0 2390.3 2391.0 2307.6 2323.3 2331.0 2342.6 2349.4 2287.8 2293.4 2309.8 2336.8 2338.3 2288.9 2309.6 2317.3 2327.7 2334.3 7795.6 7809.0 7839.5 7849.3 7890.7 4639.1 4717.7 4722.1 4737.2 4771.9 3245.4 3278.4 3292.4 3300.1 3310.0 1003.7 1004.5 1027.8 1041.6 1063.0 10777.9 10897.6 10933.4 10942.3 10965.5 4143.2 4155.5 4206.8 4240.1 4247.4 8806.0 8833.7 8854.2 8868.4 8871.6 4590.1 4602.0 4605.2 4617.2 4640.0 4130.5 4226.5 4245.7 4265.1 4283.1 3695.6 3697.1 3714.4 3718.8 3735.1 1163.7 1171.0 1173.2 1174.1 1176.3 1024.8 1040.5 1041.0 1041.4 1046.8 7515.3 7522.9 7534.4 7547.8 7581.0 503.2 505.5 515.7 515.7 517.8 5865.0 5866.1 5916.2 5917.7 5919.5 9248.0 9251.3 9513.6 9672.6 9691.7 9361.9 9380.3 9488.6 9495.9 9548.0 7304.3 7327.0 7385.5 7400.9 7455.4 7076.5 7105.6 7137.6 7143.6 7174.7 8208.7 8269.9 8405.5 8448.6 8522.4 8576.7 8581.4 8655.7 8663.9 8684.4 6353.2 6451.6 6767.2 7046.1 7066.5 7718.0 7734.0 7742.5 7756.8 7791.8 7041.5 7217.3 7222.7 7313.7 7325.7 7133.1 7166.4 7192.6 7215.4 7316.4 7107.1 7227.1 7275.0 7298.2 7313.1 6577.9 6581.4 6585.6 6591.8 6596.2 6529.8 6652.2 6671.5 6687.8 6704.2 22:16:01 INFO - 2015-11-18 22:16:01,498 DEBUG : BROWSER_OUTPUT: 22:16:01 INFO - 2015-11-18 22:16:01,498 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5644.57 Median:6384.18 stddev:1719.37 (26.9%) stddev-sans-first:1677.34 22:16:01 INFO - 2015-11-18 22:16:01,499 DEBUG : BROWSER_OUTPUT: Values: 333.4 335.7 341.6 342.1 350.2 6249.1 6308.2 6371.3 6403.6 6429.1 6104.6 6320.9 6337.1 6340.2 6341.1 4792.6 4820.7 4837.7 4841.7 4850.2 4844.9 4849.7 4851.2 4854.7 4854.8 4717.9 4815.2 4822.1 4822.8 4830.6 4807.8 4808.4 4819.9 4832.2 4837.4 4201.0 4210.9 4211.2 4218.6 4220.6 5886.1 5939.8 5964.9 5970.9 5982.3 5581.7 5593.3 5616.0 5617.8 5625.1 6628.9 6644.9 6675.8 6702.4 6717.0 4664.1 4672.4 4683.3 4690.3 4694.8 6857.9 6945.8 6985.3 7000.2 7011.9 4782.0 4791.6 4793.2 4796.4 4807.1 4831.3 4848.6 4849.7 4855.1 4856.6 5582.2 5588.1 5589.4 5589.9 5595.0 6490.7 6779.8 6787.8 6794.9 6826.1 1637.1 1645.6 1660.4 1671.1 1673.3 1080.6 1085.5 1110.5 1112.6 1113.5 6417.6 6424.6 6447.5 6454.2 6458.5 6808.3 6827.4 6853.8 6862.9 6877.6 6325.5 6358.7 6380.5 6387.9 6413.1 3808.6 3808.9 3831.5 3844.3 3852.4 7286.8 7321.8 7322.0 7326.8 7343.6 7018.2 7263.1 7288.6 7293.3 7293.8 7225.0 7264.2 7293.9 7296.3 7298.2 6995.8 7006.4 7009.7 7019.4 7033.4 6720.4 6937.9 6947.7 6952.1 6957.5 7234.3 7251.6 7252.7 7316.0 7323.9 4690.8 4718.5 4721.9 4767.2 4780.8 6754.6 6775.9 7015.7 7049.1 7080.9 6835.5 6859.0 6869.9 6871.6 6872.9 6830.6 6834.0 6835.4 6841.0 6847.2 6557.3 6716.9 6725.1 6725.4 6727.3 6841.7 6846.1 6854.8 6870.8 6889.8 6640.8 6671.6 6698.1 6700.0 6703.6 22:16:01 INFO - 2015-11-18 22:16:01,499 DEBUG : BROWSER_OUTPUT: 22:16:01 INFO - 2015-11-18 22:16:01,499 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13777.70 Median:45472.93 stddev:16314.14 (35.9%) stddev-sans-first:16330.51 22:16:01 INFO - 2015-11-18 22:16:01,499 DEBUG : BROWSER_OUTPUT: Values: 738.3 745.1 785.8 865.2 868.7 13776.7 13964.4 14068.1 14158.7 14194.3 12545.9 12561.0 12690.6 12721.1 14365.4 814.3 830.4 835.2 837.6 837.7 821.4 824.5 826.5 831.3 833.8 865.3 870.7 873.1 875.3 881.5 863.7 864.4 868.5 872.2 872.5 642.1 642.2 643.4 644.9 645.0 12922.1 12983.9 13040.9 13059.1 13183.1 11917.9 12010.0 12303.1 12601.5 12961.4 10423.3 10489.9 10500.5 10602.6 10654.3 3618.8 3679.7 3696.0 3699.3 3811.6 40658.8 41108.8 44348.6 45219.1 46662.3 7608.0 7787.6 9674.3 10539.5 10631.1 11654.1 11716.3 11726.9 11791.4 11823.2 6789.6 6983.8 7006.3 7006.3 7081.4 4251.8 4351.0 4382.5 4439.4 4497.8 2754.0 2783.3 2786.2 2786.7 2791.5 452.9 461.6 467.6 469.0 470.4 527.0 653.6 679.2 680.9 734.4 9027.0 9193.0 9196.4 9263.1 9385.7 599.8 654.3 664.2 694.8 709.8 4203.3 4445.4 4499.6 4510.8 4589.5 61316.7 61520.7 61667.4 61830.4 61963.7 52524.0 54259.8 54550.2 54955.7 55548.2 44088.6 45726.8 45876.5 46536.5 48067.0 8778.3 8784.6 9187.9 9432.7 9531.0 36203.0 36249.0 36340.6 36936.4 36954.0 43150.4 44359.6 44960.6 47174.0 47614.8 8413.4 8608.7 8737.1 8751.9 8887.6 12339.8 12738.0 12773.2 12905.7 12911.1 11696.6 11733.8 11864.1 11912.6 12288.9 11289.7 11374.9 11642.2 11650.5 12006.9 11667.4 11783.8 12007.0 12239.2 12271.6 9989.5 9993.5 10245.6 10337.5 10360.4 9401.6 9544.6 10388.3 10401.2 10438.3 22:16:01 INFO - 2015-11-18 22:16:01,499 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:16:01 INFO - 2015-11-18 22:16:01,499 DEBUG : BROWSER_OUTPUT: 22:16:02 INFO - 2015-11-18 22:16:02,173 INFO : Browser exited with error code: 0 22:16:02 INFO - 2015-11-18 22:16:02,192 INFO : Completed test dromaeo_css (00:18:31) 22:16:02 INFO - 2015-11-18 22:16:02,192 INFO : Starting test kraken 22:16:02 INFO - 2015-11-18 22:16:02,192 DEBUG : operating with platform_type : linux_ 22:16:02 INFO - 2015-11-18 22:16:02,192 INFO : Initialising browser for kraken test... 22:16:02 INFO - 2015-11-18 22:16:02,198 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXBhovW/profile http://localhost:49340/getInfo.html 22:16:07 INFO - 2015-11-18 22:16:07,453 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:16:07 INFO - 2015-11-18 22:16:07,453 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:16:07 INFO - 2015-11-18 22:16:07,453 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:16:07 INFO - 2015-11-18 22:16:07,453 DEBUG : BROWSER_OUTPUT: __metrics 22:16:08 INFO - 2015-11-18 22:16:08,565 INFO : Browser initialized. 22:16:08 INFO - 2015-11-18 22:16:08,566 INFO : Running cycle 1/1 for kraken test... 22:16:08 INFO - 2015-11-18 22:16:08,566 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXBhovW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:16:20 INFO - 2015-11-18 22:16:20,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 142114816 22:16:20 INFO - 2015-11-18 22:16:20,421 DEBUG : BROWSER_OUTPUT: 22:16:22 INFO - 2015-11-18 22:16:22,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49340/tests/kraken/driver.html?testName=audio-beat-detection) 22:16:23 INFO - 2015-11-18 22:16:23,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 142082048 22:16:23 INFO - 2015-11-18 22:16:23,506 DEBUG : BROWSER_OUTPUT: 22:16:26 INFO - 2015-11-18 22:16:26,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49340/tests/kraken/driver.html?testName=audio-dft) 22:16:26 INFO - 2015-11-18 22:16:26,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 141828096 22:16:26 INFO - 2015-11-18 22:16:26,728 DEBUG : BROWSER_OUTPUT: 22:16:29 INFO - 2015-11-18 22:16:29,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49340/tests/kraken/driver.html?testName=audio-fft) 22:16:30 INFO - 2015-11-18 22:16:30,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 135909376 22:16:30 INFO - 2015-11-18 22:16:30,148 DEBUG : BROWSER_OUTPUT: 22:16:32 INFO - 2015-11-18 22:16:32,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49340/tests/kraken/driver.html?testName=audio-oscillator) 22:16:32 INFO - 2015-11-18 22:16:32,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 136470528 22:16:32 INFO - 2015-11-18 22:16:32,685 DEBUG : BROWSER_OUTPUT: 22:16:34 INFO - 2015-11-18 22:16:34,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49340/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:16:35 INFO - 2015-11-18 22:16:35,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 137043968 22:16:35 INFO - 2015-11-18 22:16:35,457 DEBUG : BROWSER_OUTPUT: 22:16:38 INFO - 2015-11-18 22:16:38,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49340/tests/kraken/driver.html?testName=imaging-darkroom) 22:16:39 INFO - 2015-11-18 22:16:39,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 137211904 22:16:39 INFO - 2015-11-18 22:16:39,043 DEBUG : BROWSER_OUTPUT: 22:16:42 INFO - 2015-11-18 22:16:42,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49340/tests/kraken/driver.html?testName=imaging-desaturate) 22:16:43 INFO - 2015-11-18 22:16:43,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 136339456 22:16:43 INFO - 2015-11-18 22:16:43,147 DEBUG : BROWSER_OUTPUT: 22:16:45 INFO - 2015-11-18 22:16:45,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49340/tests/kraken/driver.html?testName=json-parse-financial) 22:16:46 INFO - 2015-11-18 22:16:46,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 137486336 22:16:46 INFO - 2015-11-18 22:16:46,584 DEBUG : BROWSER_OUTPUT: 22:16:48 INFO - 2015-11-18 22:16:48,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49340/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:16:48 INFO - 2015-11-18 22:16:48,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 138850304 22:16:48 INFO - 2015-11-18 22:16:48,728 DEBUG : BROWSER_OUTPUT: 22:16:50 INFO - 2015-11-18 22:16:50,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49340/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:16:51 INFO - 2015-11-18 22:16:51,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 138567680 22:16:51 INFO - 2015-11-18 22:16:51,157 DEBUG : BROWSER_OUTPUT: 22:16:53 INFO - 2015-11-18 22:16:53,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49340/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:16:53 INFO - 2015-11-18 22:16:53,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 140304384 22:16:53 INFO - 2015-11-18 22:16:53,846 DEBUG : BROWSER_OUTPUT: 22:16:56 INFO - 2015-11-18 22:16:56,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:16:56 INFO - 2015-11-18 22:16:56,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 139599872 22:16:56 INFO - 2015-11-18 22:16:56,932 DEBUG : BROWSER_OUTPUT: 22:16:59 INFO - 2015-11-18 22:16:59,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:17:00 INFO - 2015-11-18 22:17:00,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 138465280 22:17:00 INFO - 2015-11-18 22:17:00,094 DEBUG : BROWSER_OUTPUT: 22:17:01 INFO - 2015-11-18 22:17:01,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49340/tests/kraken/driver.html?testName=ai-astar) 22:17:02 INFO - 2015-11-18 22:17:02,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 138838016 22:17:02 INFO - 2015-11-18 22:17:02,066 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,066 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:17:02 INFO - 2015-11-18 22:17:02,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:17:02 INFO - 2015-11-18 22:17:02,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:17:02 INFO - 2015-11-18 22:17:02,067 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:17:02 INFO - 2015-11-18 22:17:02,067 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;106;112;110;111;125;110;111;111;112 22:17:02 INFO - 2015-11-18 22:17:02,067 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;125;152;165;124;152;152;127;177;133 22:17:02 INFO - 2015-11-18 22:17:02,067 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;163;163;162;165;162;161;163;173;162 22:17:02 INFO - 2015-11-18 22:17:02,067 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;79;74;73;73;135;73;73;72;72 22:17:02 INFO - 2015-11-18 22:17:02,067 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;141;89;92;92;141;90;91;132 22:17:02 INFO - 2015-11-18 22:17:02,067 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;113;111;111;110;110;110;110;110 22:17:02 INFO - 2015-11-18 22:17:02,067 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;151;148;146;146;146;147;147;146;147;146 22:17:02 INFO - 2015-11-18 22:17:02,068 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;98;96;96;97;97;96;96;97 22:17:02 INFO - 2015-11-18 22:17:02,068 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;62;61;61;63;61;62;67;59;61 22:17:02 INFO - 2015-11-18 22:17:02,068 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;68;69;69;69;70;69;71 22:17:02 INFO - 2015-11-18 22:17:02,068 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;86;89;85;84;85;85;85;87 22:17:02 INFO - 2015-11-18 22:17:02,068 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;120;121;121;121;118;138;130;120;121 22:17:02 INFO - 2015-11-18 22:17:02,068 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;150;144;150;151;141;158;149;155;151 22:17:02 INFO - 2015-11-18 22:17:02,068 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;68;71;68;69;68;68;68;68;67 22:17:02 INFO - 2015-11-18 22:17:02,069 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:17:02 INFO - 2015-11-18 22:17:02,069 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:17:02 INFO - 2015-11-18 22:17:02,069 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,695 22:17:02 INFO - 2015-11-18 22:17:02,069 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:17:02 INFO - 2015-11-18 22:17:02,069 DEBUG : BROWSER_OUTPUT: __startTimestamp1447913822064__endTimestamp 22:17:02 INFO - 2015-11-18 22:17:02,069 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,072 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:17:02 INFO - 2015-11-18 22:17:02,073 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:17:02 INFO - 2015-11-18 22:17:02,073 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,073 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:111.00 stddev:4.91 (4.4%) stddev-sans-first:5.20 22:17:02 INFO - 2015-11-18 22:17:02,073 DEBUG : BROWSER_OUTPUT: Values: 111.0 106.0 112.0 110.0 111.0 125.0 110.0 111.0 111.0 112.0 22:17:02 INFO - 2015-11-18 22:17:02,073 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,073 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.00 Median:152.00 stddev:18.06 (11.9%) stddev-sans-first:18.97 22:17:02 INFO - 2015-11-18 22:17:02,074 DEBUG : BROWSER_OUTPUT: Values: 153.0 125.0 152.0 165.0 124.0 152.0 152.0 127.0 177.0 133.0 22:17:02 INFO - 2015-11-18 22:17:02,074 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,074 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.43 (2.1%) stddev-sans-first:3.63 22:17:02 INFO - 2015-11-18 22:17:02,074 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 163.0 162.0 165.0 162.0 161.0 163.0 173.0 162.0 22:17:02 INFO - 2015-11-18 22:17:02,074 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,074 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:73.00 stddev:19.57 (26.8%) stddev-sans-first:20.57 22:17:02 INFO - 2015-11-18 22:17:02,074 DEBUG : BROWSER_OUTPUT: Values: 72.0 79.0 74.0 73.0 73.0 135.0 73.0 73.0 72.0 72.0 22:17:02 INFO - 2015-11-18 22:17:02,075 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,075 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:90.50 stddev:22.99 (25.4%) stddev-sans-first:23.83 22:17:02 INFO - 2015-11-18 22:17:02,075 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 141.0 89.0 92.0 92.0 141.0 90.0 91.0 132.0 22:17:02 INFO - 2015-11-18 22:17:02,075 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,075 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:110.50 stddev:0.97 (0.9%) stddev-sans-first:1.01 22:17:02 INFO - 2015-11-18 22:17:02,075 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 113.0 111.0 111.0 110.0 110.0 110.0 110.0 110.0 22:17:02 INFO - 2015-11-18 22:17:02,075 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,075 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.56 (1.1%) stddev-sans-first:0.73 22:17:02 INFO - 2015-11-18 22:17:02,075 DEBUG : BROWSER_OUTPUT: Values: 151.0 148.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 22:17:02 INFO - 2015-11-18 22:17:02,075 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,076 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 22:17:02 INFO - 2015-11-18 22:17:02,076 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 98.0 96.0 96.0 97.0 97.0 96.0 96.0 97.0 22:17:02 INFO - 2015-11-18 22:17:02,076 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,076 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.80 Median:61.50 stddev:2.10 (3.4%) stddev-sans-first:2.20 22:17:02 INFO - 2015-11-18 22:17:02,076 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 61.0 61.0 63.0 61.0 62.0 67.0 59.0 61.0 22:17:02 INFO - 2015-11-18 22:17:02,076 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,076 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 22:17:02 INFO - 2015-11-18 22:17:02,076 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 68.0 69.0 69.0 69.0 70.0 69.0 71.0 22:17:02 INFO - 2015-11-18 22:17:02,076 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,077 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:1.51 (1.8%) stddev-sans-first:1.50 22:17:02 INFO - 2015-11-18 22:17:02,077 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 86.0 89.0 85.0 84.0 85.0 85.0 85.0 87.0 22:17:02 INFO - 2015-11-18 22:17:02,077 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,077 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:121.00 stddev:6.23 (5.1%) stddev-sans-first:6.44 22:17:02 INFO - 2015-11-18 22:17:02,077 DEBUG : BROWSER_OUTPUT: Values: 119.0 120.0 121.0 121.0 121.0 118.0 138.0 130.0 120.0 121.0 22:17:02 INFO - 2015-11-18 22:17:02,077 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,077 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:150.50 stddev:5.58 (3.7%) stddev-sans-first:5.11 22:17:02 INFO - 2015-11-18 22:17:02,077 DEBUG : BROWSER_OUTPUT: Values: 141.0 150.0 144.0 150.0 151.0 141.0 158.0 149.0 155.0 151.0 22:17:02 INFO - 2015-11-18 22:17:02,077 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,078 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.00 stddev:1.81 (2.7%) stddev-sans-first:1.12 22:17:02 INFO - 2015-11-18 22:17:02,078 DEBUG : BROWSER_OUTPUT: Values: 73.0 68.0 71.0 68.0 69.0 68.0 68.0 68.0 68.0 67.0 22:17:02 INFO - 2015-11-18 22:17:02,078 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:17:02 INFO - 2015-11-18 22:17:02,078 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-18 22:17:02,981 INFO : Browser exited with error code: 0 22:17:03 INFO - 2015-11-18 22:17:03,029 INFO : Completed test kraken (00:01:00) 22:17:03 INFO - 2015-11-18 22:17:03,029 INFO : Starting test v8_7 22:17:03 INFO - 2015-11-18 22:17:03,029 DEBUG : operating with platform_type : linux_ 22:17:03 INFO - 2015-11-18 22:17:03,029 INFO : Initialising browser for v8_7 test... 22:17:03 INFO - 2015-11-18 22:17:03,035 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpomygD5/profile http://localhost:49340/getInfo.html 22:17:08 INFO - 2015-11-18 22:17:08,020 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:17:08 INFO - 2015-11-18 22:17:08,021 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:17:08 INFO - 2015-11-18 22:17:08,021 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:17:08 INFO - 2015-11-18 22:17:08,021 DEBUG : BROWSER_OUTPUT: __metrics 22:17:09 INFO - 2015-11-18 22:17:09,073 INFO : Browser initialized. 22:17:09 INFO - 2015-11-18 22:17:09,074 INFO : Running cycle 1/1 for v8_7 test... 22:17:09 INFO - 2015-11-18 22:17:09,074 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpomygD5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:17:20 INFO - 2015-11-18 22:17:20,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 141934592 22:17:20 INFO - 2015-11-18 22:17:20,882 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49340/tests/v8_7/run.html (next: http://localhost:49340/tests/v8_7/run.html) 22:17:42 INFO - 2015-11-18 22:17:42,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 138694656 22:17:42 INFO - 2015-11-18 22:17:42,488 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,488 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:17:42 INFO - 2015-11-18 22:17:42,489 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:17:42 INFO - 2015-11-18 22:17:42,489 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:17:42 INFO - 2015-11-18 22:17:42,489 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:17:42 INFO - 2015-11-18 22:17:42,489 DEBUG : BROWSER_OUTPUT: |0;Richards;165.42597187758477 22:17:42 INFO - 2015-11-18 22:17:42,489 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.5903872348706 22:17:42 INFO - 2015-11-18 22:17:42,489 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.8776443682104 22:17:42 INFO - 2015-11-18 22:17:42,489 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5065.656565656565 22:17:42 INFO - 2015-11-18 22:17:42,490 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1062.6992561105208 22:17:42 INFO - 2015-11-18 22:17:42,490 DEBUG : BROWSER_OUTPUT: |5;Earley;750.1875468867216 22:17:42 INFO - 2015-11-18 22:17:42,490 DEBUG : BROWSER_OUTPUT: |6;Boyer;11976.190476190477 22:17:42 INFO - 2015-11-18 22:17:42,490 DEBUG : BROWSER_OUTPUT: |7;RegExp;25948.71794871795 22:17:42 INFO - 2015-11-18 22:17:42,490 DEBUG : BROWSER_OUTPUT: |8;Splay;606.7961165048544 22:17:42 INFO - 2015-11-18 22:17:42,490 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 22:17:42 INFO - 2015-11-18 22:17:42,490 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:17:42 INFO - 2015-11-18 22:17:42,491 DEBUG : BROWSER_OUTPUT: __startTimestamp1447913862481__endTimestamp 22:17:42 INFO - 2015-11-18 22:17:42,491 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,491 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:17:42 INFO - 2015-11-18 22:17:42,491 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:17:42 INFO - 2015-11-18 22:17:42,491 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,491 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.43 Median:165.43 stddev:0.00 (0.0%) 22:17:42 INFO - 2015-11-18 22:17:42,491 DEBUG : BROWSER_OUTPUT: Values: 165.4 22:17:42 INFO - 2015-11-18 22:17:42,491 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,492 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.59 Median:194.59 stddev:0.00 (0.0%) 22:17:42 INFO - 2015-11-18 22:17:42,492 DEBUG : BROWSER_OUTPUT: Values: 194.6 22:17:42 INFO - 2015-11-18 22:17:42,492 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,492 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.88 Median:285.88 stddev:0.00 (0.0%) 22:17:42 INFO - 2015-11-18 22:17:42,492 DEBUG : BROWSER_OUTPUT: Values: 285.9 22:17:42 INFO - 2015-11-18 22:17:42,492 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,492 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5065.66 Median:5065.66 stddev:0.00 (0.0%) 22:17:42 INFO - 2015-11-18 22:17:42,493 DEBUG : BROWSER_OUTPUT: Values: 5065.7 22:17:42 INFO - 2015-11-18 22:17:42,493 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,493 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 22:17:42 INFO - 2015-11-18 22:17:42,493 DEBUG : BROWSER_OUTPUT: Values: 1062.7 22:17:42 INFO - 2015-11-18 22:17:42,493 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,493 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:750.19 Median:750.19 stddev:0.00 (0.0%) 22:17:42 INFO - 2015-11-18 22:17:42,493 DEBUG : BROWSER_OUTPUT: Values: 750.2 22:17:42 INFO - 2015-11-18 22:17:42,493 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,493 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11976.19 Median:11976.19 stddev:0.00 (0.0%) 22:17:42 INFO - 2015-11-18 22:17:42,493 DEBUG : BROWSER_OUTPUT: Values: 11976.2 22:17:42 INFO - 2015-11-18 22:17:42,493 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,493 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25948.72 Median:25948.72 stddev:0.00 (0.0%) 22:17:42 INFO - 2015-11-18 22:17:42,494 DEBUG : BROWSER_OUTPUT: Values: 25948.7 22:17:42 INFO - 2015-11-18 22:17:42,494 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,494 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:606.80 Median:606.80 stddev:0.00 (0.0%) 22:17:42 INFO - 2015-11-18 22:17:42,494 DEBUG : BROWSER_OUTPUT: Values: 606.8 22:17:42 INFO - 2015-11-18 22:17:42,494 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-18 22:17:42,494 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 22:17:42 INFO - 2015-11-18 22:17:42,494 DEBUG : BROWSER_OUTPUT: Values: 4854.4 22:17:42 INFO - 2015-11-18 22:17:42,494 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:17:42 INFO - 2015-11-18 22:17:42,494 DEBUG : BROWSER_OUTPUT: 22:17:43 INFO - 2015-11-18 22:17:43,393 INFO : Browser exited with error code: 0 22:17:43 INFO - 2015-11-18 22:17:43,408 INFO : Completed test v8_7 (00:00:40) 22:17:43 INFO - 2015-11-18 22:17:43,585 INFO : Completed test suite (00:20:13) 22:17:43 INFO - 2015-11-18 22:17:43,586 DEBUG : Working with test: dromaeo_css 22:17:43 INFO - 2015-11-18 22:17:43,586 DEBUG : Generating results file: dromaeo_css 22:17:43 INFO - 2015-11-18 22:17:43,587 DEBUG : Working with test: kraken 22:17:43 INFO - 2015-11-18 22:17:43,587 DEBUG : Generating results file: kraken 22:17:43 INFO - 2015-11-18 22:17:43,587 INFO : javascript benchmark 22:17:43 INFO - 2015-11-18 22:17:43,587 DEBUG : Working with test: v8_7 22:17:43 INFO - 2015-11-18 22:17:43,587 DEBUG : Generating results file: v8_7 22:17:43 INFO - 2015-11-18 22:17:43,588 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:17:43 INFO - 2015-11-18 22:17:43,641 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 22:17:43 INFO - 2015-11-18 22:17:43,641 DEBUG : process_Request line: dromaeo_css 6808.74 graph.html#tests=[[72,64,43]] 22:17:43 INFO - 2015-11-18 22:17:43,641 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:17:43 INFO - 2015-11-18 22:17:43,669 DEBUG : process_Request line: kraken 1517.30 graph.html#tests=[[232,64,43]] 22:17:43 INFO - 2015-11-18 22:17:43,669 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:17:43 INFO - 2015-11-18 22:17:43,699 DEBUG : process_Request line: v8_7 21197.17 graph.html#tests=[[230,64,43]] 22:17:43 INFO - 2015-11-18 22:17:43,700 INFO : javascript benchmark 22:17:43 INFO - 2015-11-18 22:17:43,704 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3271.8527666255018, 3302.0589132097357, 3325.251818340872, 3347.3472672828793, 3357.916052098697, 5393.029254734156, 5652.547796176306, 5662.6036177467595, 5667.518260947824, 5683.488486036256, 5447.945520544793, 5551.056320425528, 5602.7758889644465, 5623.128415095667, 5662.952353814547, 5094.668846524983, 5120.513551212638, 5142.894277730287, 5205.3233079699585, 5229.163333866582, 5170.224466330062, 5205.245239440298, 5205.505476979681, 5257.526822585966, 5270.367555893298, 4948.307236986825, 5011.298418221452, 5057.519535644108, 5101.464346243665, 5109.897802043975, 5097.337346145015, 5158.819441319573, 5162.74186290684, 5181.766820493087, 5243.397009343936, 4981.053599816023, 5161.767720452589, 5164.302819119408, 5168.586513078944, 5170.302009228743, 5263.499967503081, 5307.681539107666, 5323.334583177103, 5350.91973620396, 5364.544013758835, 6031.065184896304, 6049.758009679607, 6049.939500604982, 6051.243594550681, 6077.36187700294, 5792.739326730307, 5895.528357731371, 6087.969560152171, 6096.939030609726, 6097.603655762361, 5577.9163312550345, 5656.462636049569, 5661.490465858052, 5662.85842853932, 5695.943040569624, 6193.535484838655, 6210.658413787195, 6211.720472578745, 6212.751489940442, 6222.097795819672, 5861.941380586225, 5879.470847623649, 5949.405059494103, 5984.760609575568, 5997.340292567814, 6127.4485296322655, 6133.958051319447, 6145.5698101133385, 6169.753209871555, 6184.257889053342, 6100.115717648922, 6117.796956032686, 6136.427173609184, 6137.324894261627, 6143.082036032938, 5801.100829371454, 5938.109283607493, 5959.851003724855, 5969.850753731104, 6134.803982731532, 4514.345419914094, 4518.525554816697, 4520.547945205453, 4520.683552151384, 4550.2492088804975, 4057.0668746188544, 4057.39139129133, 4080.0615858352153, 4126.628603425706, 4185.434966279574, 5622.156676498476, 5657.9434205658235, 5695.03184458643, 5702.287214098238, 5742.913856292159, 5850.9414905851245, 5954.523638108941, 5994.970025149846, 6015.39846015395, 6097.725602347905, 5849.151872978395, 5892.0, 5893.764249430061, 5898.174255604219, 5907.940920590739, 5117.8720531987, 5147.330846989942, 5151.021305951857, 5161.974190129025, 5179.19722443022, 6001.3098493672915, 6112.898653789679, 6117.522930757244, 6121.452973575903, 6137.693115344215, 5902.085176797603, 6054.3642917493025, 6055.394460553909, 6058.848528786815, 6107.961646520191, 6219.813405597839, 6362.650054246876, 6379.138816259746, 6432.614043157426, 6439.67801609927, 5783.7397317119985, 5881.05903055509, 6110.052941794029, 6147.569670123048, 6148.231471066117, 6060.484858786876, 6075.058365953284, 6079.969600151971, 6140.057253910645, 6146.200993870768, 5857.853553661193, 5867.471927526372, 5876.94123058781, 5898.882022359443, 5954.0, 5765.538756899354, 5774.393688662798, 5810.912836307543, 5853.64878107315, 5885.028970219866, 5841.0, 5847.210626565359, 5855.414458554111, 5858.0, 5945.197398351167, 5971.343152253162, 6027.78902738402, 6029.306629737461, 6038.969805150946, 6049.546284028627, 5613.887722245614, 5659.801906933238, 5686.829395117988, 5746.741396637245, 5838.32859221195], "unit": "ms", "name": "dojo.html", "value": 5559.334008201573}, {"lowerIsBetter": false, "replicates": [552.878366759313, 581.9796307129251, 586.7711592478937, 602.5360472436223, 603.8128180264118, 39858.40212396816, 40241.19517609653, 40374.0, 40488.797556012214, 40674.38988415176, 44061.559384406144, 44415.0, 44468.33297500532, 44566.77716611412, 44597.55402445974, 8746.912530874706, 8920.821583568324, 8923.063078376774, 8949.105089491064, 8985.326100542452, 8612.913870861274, 8754.737357879241, 8762.474251544896, 8781.473111613324, 8787.384883058188, 8846.115388461167, 8850.822983540325, 8889.377743557954, 8890.644374225056, 8906.910930890674, 8767.254783343391, 8844.999999999936, 8861.73414797554, 8864.423812452202, 8876.778080547974, 8689.217970382695, 8818.955905220433, 8838.116188381111, 8856.0, 8856.335774816851, 40596.79701601503, 41078.79460602678, 41204.587954120376, 41205.793971029954, 41297.58702412967, 3434.334347841295, 3487.2676737885076, 4074.5110586729484, 4078.6395222963074, 4100.65144462721, 30140.8492957536, 30273.848630756926, 30562.0, 31849.203769905707, 31966.360672786413, 3467.2025434150287, 3472.374972504948, 3508.842102105386, 3596.9100772480638, 3629.7822130672243, 280441.0, 282160.0, 282979.0, 283280.0, 283959.99999999796, 56677.716611416676, 57741.71129144327, 60944.39055609387, 61500.0, 61569.0, 57736.13395799066, 57907.0, 58067.419325807045, 58116.709416453494, 58149.0, 15520.223988800515, 15589.68820623581, 15709.135997520018, 15732.134732589817, 15769.29038193284, 11709.88290117105, 11770.411479425995, 11797.351145686898, 11873.703157421134, 11887.465064072137, 19812.60374792496, 20380.38858834237, 20390.69413958792, 20406.69389959152, 20426.285080022128, 7975.122736498981, 8070.878936815952, 8141.633626486822, 8218.054923683734, 8276.462029968154, 911.5897845969208, 929.1219797291494, 960.9327347085637, 962.485070487286, 971.0386717149971, 25783.226503204933, 26997.460050798873, 27086.729132708813, 27097.322566935985, 27574.448511029666, 1063.2875973098044, 1074.1460538871459, 1081.4971038467152, 1101.823708206683, 1126.0653657464286, 14107.36516856744, 14370.13779173232, 14502.202378869053, 14552.927235363968, 14576.41694332236, 312593.0, 318292.0, 318710.0, 318945.0, 319702.0, 53144.734276328374, 53292.200616990776, 53304.0, 53350.199747003826, 53354.0, 1275.9425825837675, 1336.8395792504766, 1349.838019437654, 1361.2241022617013, 1369.5343583181766, 27081.1875643731, 27676.723232767414, 27985.720142799128, 28045.719542805127, 28170.85914570414, 45111.54888451205, 45282.09435811331, 45567.77216113898, 45715.085698285184, 45791.77104114458, 289787.0, 291776.0, 292135.0, 292444.0, 292496.0, 31231.53152702666, 32671.836640816644, 32717.672823271463, 33083.0, 33135.834320829206, 40416.0, 43589.0, 44371.77814110909, 44662.3300650484, 45104.09791804211, 33534.49698254577, 33841.661583384834, 34170.0, 34466.655333446346, 36077.0, 36169.81915090408, 36447.81776091103, 37033.62966370302, 37295.81352093222, 37395.81302093472, 35562.82218588891, 35743.0, 35893.461598076574, 36288.092797679215, 36304.0, 31077.844610776803, 32372.676273236964, 32876.50685239676, 32938.83530582332, 32990.67009329876, 25174.874125629256, 25532.872335638203, 25602.743972560034, 25782.355441114123, 26068.73931260739], "unit": "ms", "name": "ext.html", "value": 18622.930851213354}, {"lowerIsBetter": false, "replicates": [359.0574741304077, 360.3729510651467, 362.4418395670667, 367.1170834143884, 367.5699431664952, 12304.138710290283, 12672.112952093357, 16963.83036169638, 18201.362952296673, 19264.133114009885, 11813.2321399109, 11969.521219151224, 11992.280463172216, 12087.274763514195, 12284.938575307111, 4467.374567560536, 4608.354830323758, 4616.653750968674, 4622.468416132154, 4626.606738427221, 4418.80115394808, 4592.632589392841, 4610.561996610317, 4630.189716799563, 4632.4441067072, 4547.295169248771, 4556.9088618227615, 4663.580277775, 4758.904821903578, 4778.307145463906, 4709.175894218498, 4717.740524271164, 4734.502877197913, 4738.170820106502, 4744.64415168862, 4117.197146556423, 4265.232258193524, 4276.23027854986, 4281.678874084456, 4306.310990241577, 13128.277944713038, 13341.332933353293, 13429.261390623511, 13533.864661353358, 13559.118657287245, 2090.926817561378, 2109.040386624082, 2121.321177223289, 2127.5532138250833, 2139.882306473143, 9788.119069283799, 9798.412095274307, 10019.89980100197, 10036.949815250877, 10177.949110254476, 1709.102721071435, 1714.5027941896835, 1716.5880188754609, 1733.6792693351645, 1750.9737353939574, 57378.42621573772, 59102.203246626756, 59135.704321478544, 59778.10332845011, 59969.99999999956, 6791.456683465311, 6855.211650660238, 7007.7196912122945, 7035.6482175891, 7082.575045497287, 8302.667893284322, 8317.584120793936, 8327.292180164633, 8329.583520824055, 8336.416450848503, 5617.38208797032, 5671.886562268732, 5734.397888221677, 5751.396103409165, 5754.798582049608, 5681.0, 5707.086866101404, 5728.398518155534, 5923.6149650273455, 6010.218671572755, 3210.7270881974828, 3232.563603913489, 3254.9511757323658, 3269.084656296241, 3276.737860971117, 1145.5360578965533, 1157.542770605623, 1166.9824952625718, 1168.9240199387013, 1199.8620158681688, 409.22043507118985, 414.5999110858036, 421.1660911395454, 421.63317913414915, 428.1522585281099, 10491.213159013105, 10972.0, 11063.834042489369, 11167.497462614201, 11190.0, 439.9626031787334, 447.19728088081973, 448.07472569144613, 450.94363204599426, 471.73347058912293, 5826.70866456684, 5987.0, 6013.098035294741, 6052.606580572248, 6090.33006369299, 536872.8938131862, 558226.0, 559850.0, 561459.0, 568266.0, 72717.0, 74310.25689743142, 74776.25223747693, 75351.0, 78352.0, 546.8687514996373, 553.8781468077017, 555.2420945409486, 560.3024234827666, 560.571163060251, 10415.791684166426, 10933.562657493929, 11121.110311175249, 11358.886411135783, 11439.08487321029, 34108.658913410545, 34563.30873382569, 35024.824875875456, 35238.0, 36038.27923441569, 42894.78552607217, 44335.77832110948, 44639.330410044524, 44663.77668111639, 44790.55209447864, 5822.359540450631, 6798.49877313194, 6826.965865170841, 6900.827479313058, 6909.067275917888, 12037.277763334228, 12304.815427768412, 12383.0, 12441.315727635067, 12483.812742808683, 10244.546927583198, 10462.895371046192, 10638.574457021632, 10698.679039628823, 10787.67636970892, 10360.430176340073, 10453.425061621683, 10528.736781580521, 10715.946420267848, 10959.835602466128, 8923.464592124494, 10550.947245264031, 10906.80088166046, 10946.835797462885, 11001.284916480403, 6751.966240168767, 6785.728570857111, 6829.69266383004, 6871.587704737732, 6876.587404755731, 10159.79680406373, 10684.09185219234, 10887.401192934149, 10897.67306980792, 10952.56189752401], "unit": "ms", "name": "jquery.html", "value": 6814.08151507061}, {"lowerIsBetter": false, "replicates": [1560.196498803116, 1594.505703231998, 1674.213119833678, 1763.673720361733, 1809.1316168239246, 7554.584497852623, 7996.40026997976, 8046.356291496681, 8083.151269116746, 8116.797080073001, 8050.838983220332, 8087.1508491608265, 8119.837603247932, 8121.675132994673, 8126.228008339213, 2275.488015196576, 2328.313147621447, 2331.3006098170567, 2337.964930526035, 2339.02930283932, 2277.5900337939165, 2324.5583339165587, 2370.9881450592725, 2390.3307074019303, 2391.0196819304088, 2307.6423154411095, 2323.3262353917344, 2331.0209711920947, 2342.6368912818457, 2349.3539276698957, 2287.8284128690416, 2293.4381076636164, 2309.8383113182085, 2336.754640762721, 2338.251759436981, 2288.8512246704076, 2309.58427483053, 2317.2584772872688, 2327.7090363704538, 2334.323046316566, 7795.649195786204, 7808.960955195188, 7839.471303095898, 7849.293563579248, 7890.723824666166, 4639.141758774637, 4717.669763116583, 4722.055588882237, 4737.194676904935, 4771.904561908777, 3245.415825151472, 3278.426275401795, 3292.3579901919134, 3300.092474569489, 3309.983450082734, 1003.6687892995367, 1004.5178314409052, 1027.809855176787, 1041.6250149946013, 1063.0326402973258, 10777.946110269477, 10897.618583349546, 10933.398663073527, 10942.288751231144, 10965.451727413598, 4143.150654115899, 4155.501339839238, 4206.810693518799, 4240.1307731914885, 4247.447831781848, 8806.031336552975, 8833.734987950373, 8854.158854908774, 8868.379213455126, 8871.556422178865, 4590.104929538707, 4602.0, 4605.171069207508, 4617.238155704338, 4640.0, 4130.545639979599, 4226.450561426995, 4245.745255284631, 4265.146970605829, 4283.1433713257475, 3695.611960744137, 3697.1311741741206, 3714.405695088827, 3718.8140592970244, 3735.0849041984343, 1163.7148898519747, 1170.988290117105, 1173.16705139352, 1174.0900801878443, 1176.3471273443322, 1024.779672370444, 1040.5057597641212, 1041.0, 1041.375174895072, 1046.8115739167024, 7515.286047825448, 7522.924770752332, 7534.434917381109, 7547.8113047173165, 7580.9620951894885, 503.1747933389245, 505.5298572327697, 515.7163560041962, 515.7498613172609, 517.8032347707847, 5864.970675146682, 5866.12008198765, 5916.2013128228, 5917.6745279010065, 5919.526437884959, 9248.0, 9251.306152038624, 9513.619455221851, 9672.613095476243, 9691.70924872255, 9361.859572106423, 9380.296477764196, 9488.620455181715, 9495.90504094964, 9548.045195480536, 7304.306090921354, 7326.96336518314, 7385.519941203805, 7400.925990740131, 7455.4408419368765, 7076.540024898365, 7105.573665580082, 7137.571745695275, 7143.607101609461, 7174.677139528838, 8208.671653133808, 8269.875951860606, 8405.453645513022, 8448.577571121543, 8522.36082293818, 8576.699815506427, 8581.35639827003, 8655.653773848975, 8663.91336086631, 8684.39209255346, 6353.205849268841, 6451.612903225634, 6767.154105736783, 7046.1192350956135, 7066.540674856118, 7718.035245594301, 7734.0, 7742.458027937991, 7756.767296980874, 7791.766247012599, 7041.5422997505, 7217.278272172741, 7222.711091556279, 7313.670884810303, 7325.743598974011, 7133.072700548895, 7166.355028047501, 7192.568445893263, 7215.350618444365, 7316.378107860892, 7107.147142342952, 7227.096612923385, 7274.96362518184, 7298.23368546295, 7313.085864266966, 6577.901331480128, 6581.440577550962, 6585.6377899216, 6591.802245932629, 6596.241432235354, 6529.804105876831, 6652.168478940132, 6671.46628269747, 6687.76592819249, 6704.195496540447], "unit": "ms", "name": "mootools.html", "value": 4450.6535290418}, {"lowerIsBetter": false, "replicates": [333.39988021561186, 335.65044687189686, 341.6208009109889, 342.14634486955043, 350.1997934719166, 6249.093881387196, 6308.243010838694, 6371.299157092716, 6403.583767055138, 6429.067785171147, 6104.603200791946, 6320.905186422196, 6337.081123237128, 6340.175777148976, 6341.080543321215, 4792.568668819806, 4820.662553621248, 4837.685550439211, 4841.6852904561265, 4850.248211527219, 4844.854654360375, 4849.709017458946, 4851.199552073904, 4854.708717476963, 4854.844351171731, 4717.9056418871605, 4815.229563269878, 4822.107910036637, 4822.7829747661435, 4830.637702172334, 4807.831725889595, 4808.3989501312335, 4819.903601927959, 4832.226843704991, 4837.443693975203, 4200.957990420087, 4210.936835947463, 4211.220924129046, 4218.641415479688, 4220.599043090901, 5886.05823068307, 5939.792107276267, 5964.910526342108, 5970.940290597082, 5982.312034116088, 5581.720913954286, 5593.272874526327, 5616.0171969905105, 5617.80337688183, 5625.09998400254, 6628.8674226515195, 6644.93355066448, 6675.766348177839, 6702.396784289437, 6717.0, 4664.113818374532, 4672.415948006499, 4683.274092515631, 4690.273007683814, 4694.788734506921, 6857.897131543031, 6945.826354341131, 6985.266547012541, 7000.229974702778, 7011.949801836166, 4782.0435912817575, 4791.6406269529225, 4793.209120495079, 4796.448408433075, 4807.110684523374, 4831.299461578122, 4848.587870031087, 4849.733264670406, 4855.101806165871, 4856.587190088811, 5582.162675598612, 5588.0779671354585, 5589.35722391922, 5589.916151257735, 5595.048841696921, 6490.740370385131, 6779.830504237433, 6787.830304242335, 6794.898076528856, 6826.146731658543, 1637.0505107038127, 1645.5556999610037, 1660.435451946344, 1671.055853442801, 1673.3473945161397, 1080.5785743560018, 1085.495244711213, 1110.4725255503572, 1112.6439539347332, 1113.5378817790688, 6417.582857114273, 6424.646644434601, 6447.484201263887, 6454.225492940877, 6458.515611329169, 6808.285130061371, 6827.351401616838, 6853.7943861684225, 6862.862742745117, 6877.58734475923, 6325.5255855811, 6358.682065896686, 6380.489560835215, 6387.872242555216, 6413.070104834773, 3808.638179372955, 3808.914459379064, 3831.5210598675167, 3844.2695887781233, 3852.3836186210633, 7286.8178295541975, 7321.78034658961, 7322.0, 7326.780196594111, 7343.596102214429, 7018.227994920555, 7263.0921134858145, 7288.562686238736, 7293.27067293277, 7293.781186564305, 7225.04923670606, 7264.237255088246, 7293.8905916411295, 7296.306850849161, 7298.160711518137, 6995.825104372431, 7006.439484841302, 7009.684564194726, 7019.438444924292, 7033.366996970297, 6720.395164435225, 6937.861242775217, 6947.722091116501, 6952.130983627047, 6957.512974091765, 7234.312740289664, 7251.601161935933, 7252.673629686571, 7316.0489136411925, 7323.853522929405, 4690.835820746258, 4718.480967093686, 4721.9055618888115, 4767.213409787346, 4780.808767649255, 6754.628495432798, 6775.932240677727, 7015.6842942066705, 7049.118860142482, 7080.858382832417, 6835.521513494008, 6858.971154326891, 6869.931300687129, 6871.587704737732, 6872.931270687229, 6830.59016459014, 6834.0, 6835.350641689031, 6840.973853921952, 6847.246802851582, 6557.278699342973, 6716.899246511209, 6725.125733654593, 6725.4283385910785, 6727.260001399744, 6841.657917104224, 6846.075779769667, 6854.828629284308, 6870.793876183722, 6889.793306200822, 6640.83397915056, 6671.6330601815425, 6698.129243198353, 6699.9665001674675, 6703.564268322543], "unit": "ms", "name": "prototype.html", "value": 5075.145111099719}, {"lowerIsBetter": false, "replicates": [738.283864651288, 745.1356426545208, 785.83104632504, 865.1737590600977, 868.674247157316, 13776.655583610414, 13964.44142234312, 14068.085574437655, 14158.716825663481, 14194.290285485724, 12545.937270313636, 12561.0, 12690.619281421548, 12721.10952233344, 14365.425382984668, 814.2630919018297, 830.4145577367972, 835.1523203947997, 837.5979529825687, 837.6774941647479, 821.3798582070528, 824.5382585751968, 826.4751882554591, 831.3349320543571, 833.7748807821885, 865.2645251536206, 870.6909047288217, 873.1312344217513, 875.251659830845, 881.5415983688478, 863.7451951674271, 864.4165188497801, 868.4745728834059, 872.2455076358967, 872.5419154943673, 642.1459458919626, 642.1715986377567, 643.4016364780751, 644.9451796597294, 644.9774257900998, 12922.095453318272, 12983.87016129836, 13040.869591304061, 13059.085863989525, 13183.14309569875, 11917.94041029798, 12010.0, 12303.077269204845, 12601.495940162382, 12961.351932403342, 10423.270371074028, 10489.895101048967, 10500.474976251233, 10602.56047215224, 10654.307470014424, 3618.8009659468717, 3679.7056235501095, 3695.981520092382, 3699.315626609086, 3811.599782022903, 40658.79670601628, 41108.79445602783, 44348.55651443509, 45219.09561808746, 46662.30006549905, 7607.961960190274, 7787.5716835574585, 9674.322797404115, 10539.525721342558, 10631.149508039338, 11654.125940554492, 11716.297022178696, 11726.941365293289, 11791.35147566892, 11823.231489953125, 6789.626570538668, 6983.790486285419, 7006.264342244093, 7006.334398232159, 7081.362677358959, 4251.808668609858, 4350.973901146871, 4382.539833317455, 4439.378487011821, 4497.775111244425, 2753.9586906196423, 2783.3459137102764, 2786.2337857089055, 2786.749192572678, 2791.52544067509, 452.92300308947557, 461.5984093838382, 467.621226806288, 468.98358557450325, 470.41433415398046, 527.0276340152412, 653.5817077070678, 679.1951537428164, 680.938715515606, 734.3757805865079, 9026.954865225764, 9192.954035229915, 9196.356255062215, 9263.120003599648, 9385.67150149755, 599.848291280742, 654.2835595023441, 664.2095905871997, 694.7741983855267, 709.7764204275637, 4203.285441474956, 4445.444319460067, 4499.572540608637, 4510.797014134372, 4589.4722106958125, 61316.693416533526, 61520.69239653862, 61667.383326166164, 61830.38169618246, 61963.6901815488, 52524.0, 54259.76012758505, 54550.181747273826, 54955.70265784066, 55548.16677749837, 44088.55911440909, 45726.77136614296, 45876.541234587894, 46536.5346346539, 48067.0, 8778.297736180963, 8784.560771961504, 9187.908120918706, 9432.717018489457, 9530.952345238507, 36203.0, 36249.0, 36340.63659363478, 36936.44595331018, 36954.0, 43150.35274470948, 44359.55640443554, 44960.550394495636, 47174.0, 47614.76192619015, 8413.411061225655, 8608.65565377378, 8737.126287371211, 8751.868721969047, 8887.644494220158, 12339.75320493603, 12738.0, 12773.2336059833, 12905.741885162432, 12911.096223264656, 11696.649100526998, 11733.76532469363, 11864.11019173548, 11912.642620721392, 12288.877111228774, 11289.71775705614, 11374.886251137383, 11642.185047046625, 11650.53397864076, 12006.879931200925, 11667.416629168678, 11783.76432471363, 12007.0, 12239.204451710966, 12271.631851044483, 9989.500524973868, 9993.524283935243, 10245.641402550875, 10337.534810933677, 10360.378377297386, 9401.623935042795, 9544.570494327632, 10388.324758890649, 10401.21990850674, 10438.321509101885], "unit": "ms", "name": "yui.html", "value": 6251.929521275804}], "name": "dromaeo_css", "value": 6808.737439782188}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 112.0, 110.0, 111.0, 125.0, 110.0, 111.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [153.0, 125.0, 152.0, 165.0, 124.0, 152.0, 152.0, 127.0, 177.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 162.0, 165.0, 162.0, 161.0, 163.0, 173.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [72.0, 79.0, 74.0, 73.0, 73.0, 135.0, 73.0, 73.0, 72.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 141.0, 89.0, 92.0, 92.0, 141.0, 90.0, 91.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 113.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [151.0, 148.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 98.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 61.0, 61.0, 63.0, 61.0, 62.0, 67.0, 59.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 61.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 89.0, 85.0, 84.0, 85.0, 85.0, 85.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [119.0, 120.0, 121.0, 121.0, 121.0, 118.0, 138.0, 130.0, 120.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [141.0, 150.0, 144.0, 150.0, 151.0, 141.0, 158.0, 149.0, 155.0, 151.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.0}, {"lowerIsBetter": true, "replicates": [73.0, 68.0, 71.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1517.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.42597187758477], "unit": "score", "name": "Richards", "value": 213.40059000000002}, {"lowerIsBetter": false, "replicates": [194.5903872348706], "unit": "score", "name": "DeltaBlue", "value": 339.780402}, {"lowerIsBetter": false, "replicates": [285.8776443682104], "unit": "score", "name": "Encrypt", "value": 931.1011380000001}, {"lowerIsBetter": false, "replicates": [5065.656565656565], "unit": "score", "name": "Decrypt", "value": 52.54619940179463}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [750.1875468867216], "unit": "score", "name": "Earley", "value": 888.3951789999996}, {"lowerIsBetter": false, "replicates": [11976.190476190477], "unit": "score", "name": "Boyer", "value": 55.648998011928406}, {"lowerIsBetter": false, "replicates": [25948.71794871795], "unit": "score", "name": "RegExp", "value": 35.107129446640336}, {"lowerIsBetter": false, "replicates": [606.7961165048544], "unit": "score", "name": "Splay", "value": 134.29716800000003}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21197.167764677313}]} 22:17:43 INFO - RETURN: dromaeo_css: 6808.74 22:17:43 INFO - RETURN: kraken: 1517.30 22:17:43 INFO - RETURN: v8_7: 21197.17 22:17:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21197.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1517.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6808.74"}}} 22:17:43 INFO - Return code: 0 22:17:43 INFO - # TBPL SUCCESS # 22:17:43 INFO - Running post-action listener: _resource_record_post_action 22:17:43 INFO - Running post-run listener: _resource_record_post_run 22:17:44 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 515010560; Read time: 0; Write time: 691036 22:17:44 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 147206144; Read time: 0; Write time: 219508 22:17:44 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 311492608; Read time: 0; Write time: 371816 22:17:44 INFO - Running post-run listener: _upload_blobber_files 22:17:44 INFO - Blob upload gear active. 22:17:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:17:44 INFO - Copying logs to upload dir... 22:17:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.558902 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-18 22:17:44.826391) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 22:17:44.829541) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009846 build_url: 'https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/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-18 22:17:44.881381) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 22:17:44.881755) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447912091.232240-1810154302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 22:17:44.931014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 22:17:44.931341) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 22:17:44.931645) ========= ========= Total master_lag: 0.23 =========