builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1453432209.79 results: success (0) buildid: 20160121163024 builduid: 08790f546a1649b2bf9651b10a56843d revision: 632c8912c742a43ed6deb4153759a7113f3c051a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:09.792740) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:09.793235) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:09.793568) ========= 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=14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005285 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:09.889425) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:09.889725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:09.903247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:09.903546) ========= 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=14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:09.953182) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:09.953512) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:09.953866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:09.954147) ========= 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=14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 19:10:10-- 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 2016-01-21 19:10:10 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166258 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:10.133230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:10.133542) ========= 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=14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019044 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:10.183111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:10.183468) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 632c8912c742a43ed6deb4153759a7113f3c051a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 632c8912c742a43ed6deb4153759a7113f3c051a --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=14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 19:10:10,432 truncating revision to first 12 chars 2016-01-21 19:10:10,432 Setting DEBUG logging. 2016-01-21 19:10:10,432 attempt 1/10 2016-01-21 19:10:10,432 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/632c8912c742?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 19:10:10,695 unpacking tar archive at: mozilla-inbound-632c8912c742/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568130 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:10.765024) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:10.765370) ========= echo 632c8912c742a43ed6deb4153759a7113f3c051a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'632c8912c742a43ed6deb4153759a7113f3c051a'] 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=14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 632c8912c742a43ed6deb4153759a7113f3c051a program finished with exit code 0 elapsedTime=0.004078 script_repo_revision: '632c8912c742a43ed6deb4153759a7113f3c051a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:10.815237) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:10.815556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 19:10:10.826317) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-21 19:10:10.826643) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:10:11 INFO - MultiFileLogger online at 20160121 19:10:11 in /builds/slave/test-pgo 19:10:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:10:11 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:10:11 INFO - {'append_to_log': False, 19:10:11 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:10:11 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:10:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:10:11 INFO - 'branch': 'Mozilla-Inbound', 19:10:11 INFO - 'buildbot_json_path': 'buildprops.json', 19:10:11 INFO - 'config_files': ('talos/linux_config.py',), 19:10:11 INFO - 'default_actions': ('clobber', 19:10:11 INFO - 'read-buildbot-config', 19:10:11 INFO - 'download-and-extract', 19:10:11 INFO - 'populate-webroot', 19:10:11 INFO - 'create-virtualenv', 19:10:11 INFO - 'install', 19:10:11 INFO - 'run-tests'), 19:10:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:10:11 INFO - 'download_minidump_stackwalk': True, 19:10:11 INFO - 'download_symbols': 'ondemand', 19:10:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:10:11 INFO - 'tooltool.py': '/tools/tooltool.py', 19:10:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:10:11 INFO - '/tools/misc-python/virtualenv.py')}, 19:10:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:10:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:10:11 INFO - 'installer_path': 'installer.exe', 19:10:11 INFO - 'log_level': 'info', 19:10:11 INFO - 'log_name': 'talos', 19:10:11 INFO - 'log_to_console': True, 19:10:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:10:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:10:11 INFO - 'opt_config_files': (), 19:10:11 INFO - 'pip_index': False, 19:10:11 INFO - 'sps_profile': False, 19:10:11 INFO - 'sps_profile_interval': 0, 19:10:11 INFO - 'suite': 'dromaeojs-e10s', 19:10:11 INFO - 'system_bits': '32', 19:10:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:10:11 INFO - 'title': 'talos-linux64-ix-036', 19:10:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:10:11 INFO - 'use_talos_json': True, 19:10:11 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:10:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:10:11 INFO - 'work_dir': 'build'} 19:10:11 INFO - ##### 19:10:11 INFO - ##### Running clobber step. 19:10:11 INFO - ##### 19:10:11 INFO - Running pre-action listener: _resource_record_pre_action 19:10:11 INFO - Running main action method: clobber 19:10:11 INFO - rmtree: /builds/slave/test-pgo/build 19:10:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:10:11 INFO - Running post-action listener: _resource_record_post_action 19:10:11 INFO - ##### 19:10:11 INFO - ##### Running read-buildbot-config step. 19:10:11 INFO - ##### 19:10:11 INFO - Running pre-action listener: _resource_record_pre_action 19:10:11 INFO - Running main action method: read_buildbot_config 19:10:11 INFO - Using buildbot properties: 19:10:11 INFO - { 19:10:11 INFO - "project": "", 19:10:11 INFO - "product": "firefox", 19:10:11 INFO - "script_repo_revision": "production", 19:10:11 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:10:11 INFO - "repository": "", 19:10:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:10:11 INFO - "buildid": "20160121163024", 19:10:11 INFO - "pgo_build": "True", 19:10:11 INFO - "basedir": "/builds/slave/test-pgo", 19:10:11 INFO - "buildnumber": 329, 19:10:11 INFO - "slavename": "talos-linux64-ix-036", 19:10:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:10:11 INFO - "platform": "ubuntu64_hw", 19:10:11 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:10:11 INFO - "branch": "mozilla-inbound", 19:10:11 INFO - "repo_path": "integration/mozilla-inbound", 19:10:11 INFO - "revision": "632c8912c742a43ed6deb4153759a7113f3c051a", 19:10:11 INFO - "stage_platform": "linux64-pgo", 19:10:11 INFO - "builduid": "08790f546a1649b2bf9651b10a56843d", 19:10:11 INFO - "slavebuilddir": "test" 19:10:11 INFO - } 19:10:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:10:11 INFO - Running post-action listener: _resource_record_post_action 19:10:11 INFO - ##### 19:10:11 INFO - ##### Running download-and-extract step. 19:10:11 INFO - ##### 19:10:11 INFO - Running pre-action listener: _resource_record_pre_action 19:10:11 INFO - Running main action method: download_and_extract 19:10:11 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:10: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')]} 19:10:11 INFO - https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:10:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/test_packages.json 19:10:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/test_packages.json 19:10:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:10:12 INFO - Downloaded 1448 bytes. 19:10:12 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:10:12 INFO - Using the following test package requirements: 19:10:12 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:12 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:10:12 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:10:12 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:12 INFO - u'jsshell-linux-x86_64.zip'], 19:10:12 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:10:12 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:12 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:10:12 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:10:12 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:10:12 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:12 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:10:12 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:12 INFO - https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:10:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:10:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:10:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:10:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:10:13 INFO - Downloaded 22486750 bytes. 19:10:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:10:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:10:14 INFO - Return code: 0 19:10:14 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:10: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')]} 19:10:14 INFO - https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:10:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:10:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:10:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:10:15 INFO - Downloaded 22486750 bytes. 19:10:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:10:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:10:17 INFO - Return code: 0 19:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:17 INFO - https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:10:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:10:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:10:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:10:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:10:18 INFO - Downloaded 10705515 bytes. 19:10:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:10:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:10:18 INFO - Return code: 0 19:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:18 INFO - https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:10:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:10:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:10:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:10:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:10:20 INFO - Downloaded 55969773 bytes. 19:10:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:10:20 INFO - mkdir: /builds/slave/test-pgo/properties 19:10:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:10:20 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:10:20 INFO - Contents: 19:10:20 INFO - build_url:https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:10:20 INFO - Running post-action listener: _resource_record_post_action 19:10:20 INFO - Running post-action listener: set_extra_try_arguments 19:10:20 INFO - ##### 19:10:20 INFO - ##### Running populate-webroot step. 19:10:20 INFO - ##### 19:10:20 INFO - Running pre-action listener: _resource_record_pre_action 19:10:20 INFO - Running main action method: populate_webroot 19:10:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:10:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:10:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:10:20 INFO - '--tppagecycles', 19:10:20 INFO - '7'], 19:10:20 INFO - 'tests': ['tsvgm']}}, 19:10:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:10:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:10:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:10:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:10:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:10:20 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:10:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:20 INFO - 'talos_options': ['--e10s'], 19:10:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:20 INFO - 'tests': ['damp', 'tps']}, 19:10:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:20 INFO - 'talos_options': ['--e10s'], 19:10:20 INFO - 'tests': ['damp', 'tps']}, 19:10:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:10:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:10:20 INFO - 'other': {'tests': ['a11yr', 19:10:20 INFO - 'ts_paint', 19:10:20 INFO - 'tpaint', 19:10:20 INFO - 'sessionrestore', 19:10:20 INFO - 'sessionrestore_no_auto_restore']}, 19:10:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:10:20 INFO - 'tests': ['a11yr', 19:10:20 INFO - 'ts_paint', 19:10:20 INFO - 'tpaint', 19:10:20 INFO - 'sessionrestore', 19:10:20 INFO - 'sessionrestore_no_auto_restore']}, 19:10:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:10:20 INFO - 'tests': ['a11yr', 19:10:20 INFO - 'ts_paint', 19:10:20 INFO - 'tpaint', 19:10:20 INFO - 'sessionrestore', 19:10:20 INFO - 'sessionrestore_no_auto_restore']}, 19:10:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:10:20 INFO - 'tests': ['a11yr', 19:10:20 INFO - 'ts_paint', 19:10:20 INFO - 'tpaint', 19:10:20 INFO - 'sessionrestore', 19:10:20 INFO - 'sessionrestore_no_auto_restore']}, 19:10:20 INFO - 'other_l64': {'tests': ['a11yr', 19:10:20 INFO - 'ts_paint', 19:10:20 INFO - 'tpaint', 19:10:20 INFO - 'sessionrestore', 19:10:20 INFO - 'sessionrestore_no_auto_restore']}, 19:10:20 INFO - 'other_nol64': {'tests': ['a11yr', 19:10:20 INFO - 'ts_paint', 19:10:20 INFO - 'tpaint', 19:10:20 INFO - 'sessionrestore', 19:10:20 INFO - 'sessionrestore_no_auto_restore']}, 19:10:20 INFO - 'svgr': {'tests': ['tsvgx', 19:10:20 INFO - 'tsvgr_opacity', 19:10:20 INFO - 'tart', 19:10:20 INFO - 'tscrollx', 19:10:20 INFO - 'cart']}, 19:10:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:10:20 INFO - 'tests': ['tsvgx', 19:10:20 INFO - 'tsvgr_opacity', 19:10:20 INFO - 'tart', 19:10:20 INFO - 'tscrollx', 19:10:20 INFO - 'cart']}, 19:10:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:20 INFO - 'tests': ['tp5o']}, 19:10:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:20 INFO - 'talos_options': ['--e10s'], 19:10:20 INFO - 'tests': ['tp5o']}, 19:10:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:20 INFO - 'talos_options': ['--xperf_path', 19:10:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:20 INFO - 'tests': ['tp5n']}, 19:10:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:20 INFO - 'talos_options': ['--e10s', 19:10:20 INFO - '--xperf_path', 19:10:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:20 INFO - 'tests': ['tp5n']}}, 19:10:20 INFO - 'talos.zip': {'path': '', 19:10:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:10:20 INFO - Running post-action listener: _resource_record_post_action 19:10:20 INFO - ##### 19:10:20 INFO - ##### Running create-virtualenv step. 19:10:20 INFO - ##### 19:10:20 INFO - Running pre-action listener: _resource_record_pre_action 19:10:20 INFO - Running main action method: create_virtualenv 19:10:20 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:10:20 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 19:10:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:10:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:10:20 INFO - Using real prefix '/usr' 19:10:20 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:10:20 INFO - Installing distribute.............................................................................................................................................................................................done. 19:10:22 INFO - Installing pip.................done. 19:10:22 INFO - Return code: 0 19:10:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fa38549ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a07f0>, '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 0x160c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160c760>, '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': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', '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 19:10:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:10:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:10:22 INFO - Using env: {'DISPLAY': ':0', 19:10:22 INFO - 'HOME': '/home/cltbld', 19:10:22 INFO - 'LANG': 'en_US.UTF-8', 19:10:22 INFO - 'LANGUAGE': 'en_US:en', 19:10:22 INFO - 'LOGNAME': 'cltbld', 19:10:22 INFO - 'MAIL': '/var/mail/cltbld', 19:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:22 INFO - 'MOZ_NO_REMOTE': '1', 19:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:22 INFO - 'NO_EM_RESTART': '1', 19:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:10:22 INFO - 'PWD': '/builds/slave/test-pgo', 19:10:22 INFO - 'SHELL': '/bin/bash', 19:10:22 INFO - 'SHLVL': '1', 19:10:22 INFO - 'TERM': 'linux', 19:10:22 INFO - 'TMOUT': '86400', 19:10:22 INFO - 'USER': 'cltbld', 19:10:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', 19:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:22 INFO - '_': '/tools/buildbot/bin/python'} 19:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:22 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 19:10:22 INFO - Cleaning up... 19:10:22 INFO - Return code: 0 19:10:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fa38549ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a07f0>, '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 0x160c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160c760>, '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': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', '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 19:10:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:10:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:10:22 INFO - Using env: {'DISPLAY': ':0', 19:10:22 INFO - 'HOME': '/home/cltbld', 19:10:22 INFO - 'LANG': 'en_US.UTF-8', 19:10:22 INFO - 'LANGUAGE': 'en_US:en', 19:10:22 INFO - 'LOGNAME': 'cltbld', 19:10:22 INFO - 'MAIL': '/var/mail/cltbld', 19:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:22 INFO - 'MOZ_NO_REMOTE': '1', 19:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:22 INFO - 'NO_EM_RESTART': '1', 19:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:10:22 INFO - 'PWD': '/builds/slave/test-pgo', 19:10:22 INFO - 'SHELL': '/bin/bash', 19:10:22 INFO - 'SHLVL': '1', 19:10:22 INFO - 'TERM': 'linux', 19:10:22 INFO - 'TMOUT': '86400', 19:10:22 INFO - 'USER': 'cltbld', 19:10:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', 19:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:22 INFO - '_': '/tools/buildbot/bin/python'} 19:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:23 INFO - Downloading/unpacking psutil>=0.7.1 19:10:23 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 19:10:23 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 19:10:23 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 19:10:23 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 19:10:23 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 19:10:23 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 19:10:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:10:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:24 INFO - Installing collected packages: psutil 19:10:24 INFO - Running setup.py install for psutil 19:10:25 INFO - building 'psutil._psutil_linux' extension 19:10:25 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 19:10:25 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 19:10:25 INFO - building 'psutil._psutil_posix' extension 19:10:25 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 19:10:25 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 19:10:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:25 INFO - Successfully installed psutil 19:10:25 INFO - Cleaning up... 19:10:25 INFO - Return code: 0 19:10:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:10:25 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')]} 19:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:25 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')]} 19:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fa38549ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a07f0>, '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 0x160c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160c760>, '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': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', '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 19:10:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:10:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:10:25 INFO - Using env: {'DISPLAY': ':0', 19:10:25 INFO - 'HOME': '/home/cltbld', 19:10:25 INFO - 'LANG': 'en_US.UTF-8', 19:10:25 INFO - 'LANGUAGE': 'en_US:en', 19:10:25 INFO - 'LOGNAME': 'cltbld', 19:10:25 INFO - 'MAIL': '/var/mail/cltbld', 19:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:25 INFO - 'MOZ_NO_REMOTE': '1', 19:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:25 INFO - 'NO_EM_RESTART': '1', 19:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:10:25 INFO - 'PWD': '/builds/slave/test-pgo', 19:10:25 INFO - 'SHELL': '/bin/bash', 19:10:25 INFO - 'SHLVL': '1', 19:10:25 INFO - 'TERM': 'linux', 19:10:25 INFO - 'TMOUT': '86400', 19:10:25 INFO - 'USER': 'cltbld', 19:10:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', 19:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:25 INFO - '_': '/tools/buildbot/bin/python'} 19:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:10:25 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 19:10:25 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 19:10:25 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 19:10:25 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 19:10:25 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 19:10:25 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 19:10:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:10:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:10:27 INFO - Installing collected packages: mozsystemmonitor 19:10:27 INFO - Running setup.py install for mozsystemmonitor 19:10:27 INFO - Successfully installed mozsystemmonitor 19:10:27 INFO - Cleaning up... 19:10:27 INFO - Return code: 0 19:10:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:10:27 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')]} 19:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:27 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')]} 19:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fa38549ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a07f0>, '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 0x160c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160c760>, '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': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', '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 19:10:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:10:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:10:27 INFO - Using env: {'DISPLAY': ':0', 19:10:27 INFO - 'HOME': '/home/cltbld', 19:10:27 INFO - 'LANG': 'en_US.UTF-8', 19:10:27 INFO - 'LANGUAGE': 'en_US:en', 19:10:27 INFO - 'LOGNAME': 'cltbld', 19:10:27 INFO - 'MAIL': '/var/mail/cltbld', 19:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:27 INFO - 'MOZ_NO_REMOTE': '1', 19:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:27 INFO - 'NO_EM_RESTART': '1', 19:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:10:27 INFO - 'PWD': '/builds/slave/test-pgo', 19:10:27 INFO - 'SHELL': '/bin/bash', 19:10:27 INFO - 'SHLVL': '1', 19:10:27 INFO - 'TERM': 'linux', 19:10:27 INFO - 'TMOUT': '86400', 19:10:27 INFO - 'USER': 'cltbld', 19:10:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', 19:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:27 INFO - '_': '/tools/buildbot/bin/python'} 19:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:27 INFO - Downloading/unpacking blobuploader==1.2.4 19:10:27 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 19:10:27 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 19:10:27 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 19:10:27 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 19:10:27 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 19:10:27 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 19:10:29 INFO - Downloading blobuploader-1.2.4.tar.gz 19:10:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:10:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:10:29 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 19:10:29 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 19:10:29 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 19:10:29 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 19:10:29 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 19:10:29 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 19:10:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:10:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:10:30 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 19:10:30 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 19:10:30 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 19:10:30 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 19:10:30 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 19:10:30 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 19:10:30 INFO - Downloading docopt-0.6.1.tar.gz 19:10:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:10:30 INFO - Installing collected packages: blobuploader, requests, docopt 19:10:30 INFO - Running setup.py install for blobuploader 19:10:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:10:30 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:10:30 INFO - Running setup.py install for requests 19:10:30 INFO - Running setup.py install for docopt 19:10:30 INFO - Successfully installed blobuploader requests docopt 19:10:30 INFO - Cleaning up... 19:10:30 INFO - Return code: 0 19:10:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:10:30 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')]} 19:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:30 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')]} 19:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fa38549ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a07f0>, '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 0x160c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160c760>, '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': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', '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 19:10:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 19:10:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 19:10:30 INFO - Using env: {'DISPLAY': ':0', 19:10:30 INFO - 'HOME': '/home/cltbld', 19:10:30 INFO - 'LANG': 'en_US.UTF-8', 19:10:30 INFO - 'LANGUAGE': 'en_US:en', 19:10:30 INFO - 'LOGNAME': 'cltbld', 19:10:30 INFO - 'MAIL': '/var/mail/cltbld', 19:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:30 INFO - 'MOZ_NO_REMOTE': '1', 19:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:30 INFO - 'NO_EM_RESTART': '1', 19:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:10:30 INFO - 'PWD': '/builds/slave/test-pgo', 19:10:30 INFO - 'SHELL': '/bin/bash', 19:10:30 INFO - 'SHLVL': '1', 19:10:31 INFO - 'TERM': 'linux', 19:10:31 INFO - 'TMOUT': '86400', 19:10:31 INFO - 'USER': 'cltbld', 19:10:31 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', 19:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:31 INFO - '_': '/tools/buildbot/bin/python'} 19:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:10:31 INFO - Running setup.py (path:/tmp/pip-fBRUnN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:10:31 INFO - Running setup.py (path:/tmp/pip-srXtby-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:10:31 INFO - Running setup.py (path:/tmp/pip-g5Ug0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:10:31 INFO - Running setup.py (path:/tmp/pip-j6IK69-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:10:31 INFO - Running setup.py (path:/tmp/pip-jHExn1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:10:31 INFO - Running setup.py (path:/tmp/pip-YQRxll-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:10:31 INFO - Running setup.py (path:/tmp/pip-4ldsXN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:10:31 INFO - Running setup.py (path:/tmp/pip-tMgm1a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:10:31 INFO - Running setup.py (path:/tmp/pip-7YD2Qz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:10:31 INFO - Running setup.py (path:/tmp/pip-lm4nA6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:10:31 INFO - Running setup.py (path:/tmp/pip-nWN2tm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:10:32 INFO - Running setup.py (path:/tmp/pip-wkWcCu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:10:32 INFO - Running setup.py (path:/tmp/pip-5so9Ek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:10:32 INFO - Running setup.py (path:/tmp/pip-mtTVTR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:10:32 INFO - Running setup.py (path:/tmp/pip-kOMymo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:10:32 INFO - Running setup.py (path:/tmp/pip-l_qXeI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:10:32 INFO - Running setup.py (path:/tmp/pip-2TSz2V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:10:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:10:32 INFO - Running setup.py install for manifestparser 19:10:32 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:10:32 INFO - Running setup.py install for mozcrash 19:10:32 INFO - Running setup.py install for mozdebug 19:10:32 INFO - Running setup.py install for mozdevice 19:10:32 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:10:32 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:10:32 INFO - Running setup.py install for mozfile 19:10:32 INFO - Running setup.py install for mozhttpd 19:10:33 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:10:33 INFO - Running setup.py install for mozinfo 19:10:33 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:10:33 INFO - Running setup.py install for mozInstall 19:10:33 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:10:33 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:10:33 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:10:33 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:10:33 INFO - Running setup.py install for mozleak 19:10:33 INFO - Running setup.py install for mozlog 19:10:33 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:10:33 INFO - Running setup.py install for moznetwork 19:10:33 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:10:33 INFO - Running setup.py install for mozprocess 19:10:33 INFO - Running setup.py install for mozprofile 19:10:33 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:10:33 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:10:33 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:10:33 INFO - Running setup.py install for mozrunner 19:10:33 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:10:33 INFO - Running setup.py install for mozscreenshot 19:10:34 INFO - Running setup.py install for moztest 19:10:34 INFO - Running setup.py install for mozversion 19:10:34 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:10:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:10:34 INFO - Cleaning up... 19:10:34 INFO - Return code: 0 19:10:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:10:34 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')]} 19:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:34 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')]} 19:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fa38549ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a07f0>, '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 0x160c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160c760>, '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': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', '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 19:10:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:10:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:10:34 INFO - Using env: {'DISPLAY': ':0', 19:10:34 INFO - 'HOME': '/home/cltbld', 19:10:34 INFO - 'LANG': 'en_US.UTF-8', 19:10:34 INFO - 'LANGUAGE': 'en_US:en', 19:10:34 INFO - 'LOGNAME': 'cltbld', 19:10:34 INFO - 'MAIL': '/var/mail/cltbld', 19:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:34 INFO - 'MOZ_NO_REMOTE': '1', 19:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:34 INFO - 'NO_EM_RESTART': '1', 19:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:10:34 INFO - 'PWD': '/builds/slave/test-pgo', 19:10:34 INFO - 'SHELL': '/bin/bash', 19:10:34 INFO - 'SHLVL': '1', 19:10:34 INFO - 'TERM': 'linux', 19:10:34 INFO - 'TMOUT': '86400', 19:10:34 INFO - 'USER': 'cltbld', 19:10:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', 19:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:34 INFO - '_': '/tools/buildbot/bin/python'} 19:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:10:34 INFO - Running setup.py (path:/tmp/pip-DY1x6A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:10:34 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)) 19:10:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:10:34 INFO - Running setup.py (path:/tmp/pip-SpKdur-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:10:34 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)) 19:10:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:10:34 INFO - Running setup.py (path:/tmp/pip-60W0qg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:10:34 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)) 19:10:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:10:34 INFO - Running setup.py (path:/tmp/pip-YAQUZD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 19:10:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:10:34 INFO - Running setup.py (path:/tmp/pip-k6Ppau-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:10:34 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)) 19:10:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:10:34 INFO - Running setup.py (path:/tmp/pip-X_M0r6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:10:34 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)) 19:10:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:10:34 INFO - Running setup.py (path:/tmp/pip-np1cr3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:10:34 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)) 19:10:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:10:34 INFO - Running setup.py (path:/tmp/pip-zJXorg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:10:35 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)) 19:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:10:35 INFO - Running setup.py (path:/tmp/pip-ZN2A_j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:10:35 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)) 19:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:10:35 INFO - Running setup.py (path:/tmp/pip-CPOMY4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:10:35 INFO - Running setup.py (path:/tmp/pip-Ur9faA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:10:35 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)) 19:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:10:35 INFO - Running setup.py (path:/tmp/pip-4xlAnT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:10:35 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)) 19:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:10:35 INFO - Running setup.py (path:/tmp/pip-N38qrF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 19:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:10:35 INFO - Running setup.py (path:/tmp/pip-hWYUE0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:10:35 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)) 19:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:10:35 INFO - Running setup.py (path:/tmp/pip-H_Tu52-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:10:35 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)) 19:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:10:35 INFO - Running setup.py (path:/tmp/pip-iKaZRc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:10:35 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)) 19:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:10:35 INFO - Running setup.py (path:/tmp/pip-z_dt9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:10:35 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)) 19:10:35 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)) 19:10:35 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)) 19:10:35 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)) 19:10:35 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:35 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:10:35 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 19:10:35 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 19:10:35 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 19:10:35 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 19:10:35 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 19:10:35 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 19:10:37 INFO - Downloading blessings-1.6.tar.gz 19:10:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:10:37 INFO - Installing collected packages: blessings 19:10:37 INFO - Running setup.py install for blessings 19:10:37 INFO - Successfully installed blessings 19:10:37 INFO - Cleaning up... 19:10:37 INFO - Return code: 0 19:10:37 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:10:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:10:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:10:37 INFO - Reading from file tmpfile_stdout 19:10:37 INFO - Current package versions: 19:10:37 INFO - argparse == 1.2.1 19:10:37 INFO - blessings == 1.6 19:10:37 INFO - blobuploader == 1.2.4 19:10:37 INFO - docopt == 0.6.1 19:10:37 INFO - manifestparser == 1.1 19:10:37 INFO - mozInstall == 1.12 19:10:37 INFO - mozcrash == 0.16 19:10:37 INFO - mozdebug == 0.1 19:10:37 INFO - mozdevice == 0.48 19:10:37 INFO - mozfile == 1.2 19:10:37 INFO - mozhttpd == 0.7 19:10:37 INFO - mozinfo == 0.9 19:10:37 INFO - mozleak == 0.1 19:10:37 INFO - mozlog == 3.1 19:10:37 INFO - moznetwork == 0.27 19:10:37 INFO - mozprocess == 0.22 19:10:37 INFO - mozprofile == 0.28 19:10:37 INFO - mozrunner == 6.11 19:10:37 INFO - mozscreenshot == 0.1 19:10:37 INFO - mozsystemmonitor == 0.0 19:10:37 INFO - moztest == 0.7 19:10:37 INFO - mozversion == 1.4 19:10:37 INFO - psutil == 3.1.1 19:10:37 INFO - requests == 1.2.3 19:10:37 INFO - wsgiref == 0.1.2 19:10:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fa38549ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a07f0>, '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 0x160c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160c760>, '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': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', '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 19:10:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:10:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:10:37 INFO - Using env: {'DISPLAY': ':0', 19:10:37 INFO - 'HOME': '/home/cltbld', 19:10:37 INFO - 'LANG': 'en_US.UTF-8', 19:10:37 INFO - 'LANGUAGE': 'en_US:en', 19:10:37 INFO - 'LOGNAME': 'cltbld', 19:10:37 INFO - 'MAIL': '/var/mail/cltbld', 19:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:37 INFO - 'MOZ_NO_REMOTE': '1', 19:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:37 INFO - 'NO_EM_RESTART': '1', 19:10:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:10:37 INFO - 'PWD': '/builds/slave/test-pgo', 19:10:37 INFO - 'SHELL': '/bin/bash', 19:10:37 INFO - 'SHLVL': '1', 19:10:37 INFO - 'TERM': 'linux', 19:10:37 INFO - 'TMOUT': '86400', 19:10:37 INFO - 'USER': 'cltbld', 19:10:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', 19:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:37 INFO - '_': '/tools/buildbot/bin/python'} 19:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 19:10:38 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 2)) 19:10:38 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 3)) 19:10:38 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 4)) 19:10:38 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 5)) 19:10:38 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 6)) 19:10:38 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 7)) 19:10:38 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 8)) 19:10:38 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 9)) 19:10:38 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:10:38 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 4)) 19:10:38 INFO - Cleaning up... 19:10:38 INFO - Return code: 0 19:10:38 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:10: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')]} 19:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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')]} 19:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa38549ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a07f0>, '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 0x160c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160c760>, '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': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', '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 19:10:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test-pgo/build 19:10:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 jsonschema 19:10:38 INFO - Using env: {'DISPLAY': ':0', 19:10:38 INFO - 'HOME': '/home/cltbld', 19:10:38 INFO - 'LANG': 'en_US.UTF-8', 19:10:38 INFO - 'LANGUAGE': 'en_US:en', 19:10:38 INFO - 'LOGNAME': 'cltbld', 19:10:38 INFO - 'MAIL': '/var/mail/cltbld', 19:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:38 INFO - 'MOZ_NO_REMOTE': '1', 19:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:38 INFO - 'NO_EM_RESTART': '1', 19:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:10:38 INFO - 'PWD': '/builds/slave/test-pgo', 19:10:38 INFO - 'SHELL': '/bin/bash', 19:10:38 INFO - 'SHLVL': '1', 19:10:38 INFO - 'TERM': 'linux', 19:10:38 INFO - 'TMOUT': '86400', 19:10:38 INFO - 'USER': 'cltbld', 19:10:38 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', 19:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:38 INFO - '_': '/tools/buildbot/bin/python'} 19:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:38 INFO - Downloading/unpacking jsonschema 19:10:38 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 19:10:38 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 19:10:38 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 19:10:38 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 19:10:38 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 19:10:38 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 19:10:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:10:40 INFO - Downloading/unpacking functools32 (from jsonschema) 19:10:40 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 19:10:40 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 19:10:40 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 19:10:40 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 19:10:40 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 19:10:40 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 19:10:40 INFO - Downloading functools32-3.2.3-2.tar.gz 19:10:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:10:40 INFO - warning: no files found matching '*.txt' 19:10:40 INFO - no previously-included directories found matching 'build' 19:10:40 INFO - no previously-included directories found matching 'dist' 19:10:40 INFO - no previously-included directories found matching '.git*' 19:10:40 INFO - Installing collected packages: jsonschema, functools32 19:10:40 INFO - Running setup.py install for functools32 19:10:40 INFO - warning: no files found matching '*.txt' 19:10:40 INFO - no previously-included directories found matching 'build' 19:10:40 INFO - no previously-included directories found matching 'dist' 19:10:40 INFO - no previously-included directories found matching '.git*' 19:10:40 INFO - Successfully installed jsonschema functools32 19:10:40 INFO - Cleaning up... 19:10:40 INFO - Return code: 0 19:10:40 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa38549ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a07f0>, '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 0x160c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160c760>, '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': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', '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 19:10:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test-pgo/build 19:10:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 flake8 19:10:40 INFO - Using env: {'DISPLAY': ':0', 19:10:40 INFO - 'HOME': '/home/cltbld', 19:10:40 INFO - 'LANG': 'en_US.UTF-8', 19:10:40 INFO - 'LANGUAGE': 'en_US:en', 19:10:40 INFO - 'LOGNAME': 'cltbld', 19:10:40 INFO - 'MAIL': '/var/mail/cltbld', 19:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:40 INFO - 'MOZ_NO_REMOTE': '1', 19:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:40 INFO - 'NO_EM_RESTART': '1', 19:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:10:40 INFO - 'PWD': '/builds/slave/test-pgo', 19:10:40 INFO - 'SHELL': '/bin/bash', 19:10:40 INFO - 'SHLVL': '1', 19:10:40 INFO - 'TERM': 'linux', 19:10:40 INFO - 'TMOUT': '86400', 19:10:40 INFO - 'USER': 'cltbld', 19:10:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', 19:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:40 INFO - '_': '/tools/buildbot/bin/python'} 19:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:40 INFO - Downloading/unpacking flake8 19:10:40 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 19:10:40 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 19:10:40 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 19:10:40 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 19:10:40 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 19:10:40 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 19:10:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:10:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:10:42 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 19:10:42 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 19:10:42 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 19:10:42 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 19:10:42 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 19:10:42 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 19:10:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:10:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:10:42 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 19:10:42 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 19:10:42 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 19:10:42 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 19:10:42 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 19:10:42 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 19:10:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:10:42 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 19:10:42 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 19:10:42 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 19:10:42 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 19:10:42 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 19:10:42 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 19:10:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:10:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:10:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:10:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:10:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:10:43 INFO - no previously-included directories found matching 'docs/_build' 19:10:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:10:43 INFO - Running setup.py install for pep8 19:10:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:10:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:10:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:10:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:10:43 INFO - no previously-included directories found matching 'docs/_build' 19:10:43 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:10:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:10:43 INFO - Cleaning up... 19:10:43 INFO - Return code: 0 19:10:43 INFO - Running post-action listener: _resource_record_post_action 19:10:43 INFO - Running post-action listener: _start_resource_monitoring 19:10:43 INFO - Starting resource monitoring. 19:10:43 INFO - ##### 19:10:43 INFO - ##### Running install step. 19:10:43 INFO - ##### 19:10:43 INFO - Running pre-action listener: _resource_record_pre_action 19:10:43 INFO - Running main action method: install 19:10:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:10:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:10:43 INFO - Reading from file tmpfile_stdout 19:10:43 INFO - Detecting whether we're running mozinstall >=1.0... 19:10:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:10:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:10:43 INFO - Reading from file tmpfile_stdout 19:10:43 INFO - Output received: 19:10:43 INFO - Usage: mozinstall [options] installer 19:10:43 INFO - Options: 19:10:43 INFO - -h, --help show this help message and exit 19:10:43 INFO - -d DEST, --destination=DEST 19:10:43 INFO - Directory to install application into. [default: 19:10:43 INFO - "/builds/slave/test-pgo"] 19:10:43 INFO - --app=APP Application being installed. [default: firefox] 19:10:43 INFO - mkdir: /builds/slave/test-pgo/build/application 19:10:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:10:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:10:59 INFO - Reading from file tmpfile_stdout 19:10:59 INFO - Output received: 19:10:59 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:10:59 INFO - Running post-action listener: _resource_record_post_action 19:10:59 INFO - ##### 19:10:59 INFO - ##### Running run-tests step. 19:10:59 INFO - ##### 19:10:59 INFO - Running pre-action listener: _resource_record_pre_action 19:10:59 INFO - Running main action method: run_tests 19:10:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:10:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:10:59 INFO - Python 2.7.3 19:10:59 INFO - Return code: 0 19:10:59 INFO - grabbing minidump binary from tooltool 19:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:59 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 0x16a07f0>, '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 0x160c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160c760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:10:59 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 19:10:59 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 19:11:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:11:00 INFO - Return code: 0 19:11:00 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:11:00 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:11:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:11:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:11:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:11:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:11:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:11:01 INFO - Return code: 0 19:11:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 19:11:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:11:01 INFO - Using env: {'DISPLAY': ':0', 19:11:01 INFO - 'HOME': '/home/cltbld', 19:11:01 INFO - 'LANG': 'en_US.UTF-8', 19:11:01 INFO - 'LANGUAGE': 'en_US:en', 19:11:01 INFO - 'LOGNAME': 'cltbld', 19:11:01 INFO - 'MAIL': '/var/mail/cltbld', 19:11:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:11:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:01 INFO - 'MOZ_NO_REMOTE': '1', 19:11:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:01 INFO - 'NO_EM_RESTART': '1', 19:11:01 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:11:01 INFO - 'PWD': '/builds/slave/test-pgo', 19:11:01 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:11:01 INFO - 'SHELL': '/bin/bash', 19:11:01 INFO - 'SHLVL': '1', 19:11:01 INFO - 'TERM': 'linux', 19:11:01 INFO - 'TMOUT': '86400', 19:11:01 INFO - 'USER': 'cltbld', 19:11:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121', 19:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:01 INFO - '_': '/tools/buildbot/bin/python'} 19:11:01 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:11:01 INFO - mozversion application_buildid: 20160121163024 19:11:01 INFO - mozversion application_changeset: 632c8912c742a43ed6deb4153759a7113f3c051a 19:11:01 INFO - mozversion application_display_name: Nightly 19:11:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:11:01 INFO - mozversion application_name: Firefox 19:11:01 INFO - mozversion application_remotingname: firefox 19:11:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:11:01 INFO - mozversion application_vendor: Mozilla 19:11:01 INFO - mozversion application_version: 46.0a1 19:11:01 INFO - mozversion platform_buildid: 20160121163024 19:11:01 INFO - mozversion platform_changeset: 632c8912c742a43ed6deb4153759a7113f3c051a 19:11:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:11:01 INFO - mozversion platform_version: 46.0a1 19:11:01 INFO - using testdate: 1453432261 19:11:01 INFO - actual date: 1453432261 19:11:01 INFO - starting webserver on 'localhost:45291' 19:11:01 INFO - SUITE-START | Running 3 tests 19:11:01 INFO - TEST-START | dromaeo_css 19:11:01 INFO - operating with platform_type : linux_ 19:11:01 INFO - Initialising browser for dromaeo_css test... 19:11:01 INFO - TEST-INFO | started process 19539 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwLYq9Q/profile http://localhost:45291/getInfo.html) 19:11:05 INFO - PROCESS | 19539 | 19:11:05 INFO - PROCESS | 19539 | (process:19619): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:11:06 INFO - PROCESS | 19539 | __metrics Screen width/height:1600/1200 19:11:06 INFO - PROCESS | 19539 | colorDepth:24 19:11:06 INFO - PROCESS | 19539 | Browser inner width/height: 1024/697 19:11:06 INFO - PROCESS | 19539 | __metrics 19:11:06 INFO - PROCESS | 19539 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:11:07 INFO - TEST-INFO | 19539: exit 0 19:11:07 INFO - Browser initialized. 19:11:07 INFO - Running cycle 1/1 for dromaeo_css test... 19:11:07 INFO - TEST-INFO | started process 19668 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwLYq9Q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:08 INFO - PROCESS | 19668 | 19:11:08 INFO - PROCESS | 19668 | (process:19728): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:11:18 INFO - PROCESS | 19668 | RSS: Main: 153006080 19:11:18 INFO - PROCESS | 19668 | 19:12:08 INFO - PROCESS | 19668 | 1453432328588 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] 19:14:17 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:45291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45291/tests/dromaeo/cssquery-ext.html) 19:14:18 INFO - PROCESS | 19668 | RSS: Main: 161771520 19:14:18 INFO - PROCESS | 19668 | 19:17:20 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:45291/tests/dromaeo/cssquery-ext.html (next: http://localhost:45291/tests/dromaeo/cssquery-jquery.html) 19:17:21 INFO - PROCESS | 19668 | RSS: Main: 157814784 19:17:21 INFO - PROCESS | 19668 | 19:20:23 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:45291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45291/tests/dromaeo/cssquery-mootools.html) 19:20:23 INFO - PROCESS | 19668 | RSS: Main: 159244288 19:20:23 INFO - PROCESS | 19668 | 19:23:25 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:45291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45291/tests/dromaeo/cssquery-prototype.html) 19:23:25 INFO - PROCESS | 19668 | RSS: Main: 156512256 19:23:25 INFO - PROCESS | 19668 | 19:26:28 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:45291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45291/tests/dromaeo/cssquery-yui.html) 19:26:28 INFO - PROCESS | 19668 | RSS: Main: 156135424 19:26:28 INFO - PROCESS | 19668 | 19:29:31 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:45291/tests/dromaeo/cssquery-yui.html (next: http://localhost:45291/tests/dromaeo/cssquery-dojo.html) 19:29:31 INFO - PROCESS | 19668 | RSS: Main: 159236096 19:29:31 INFO - PROCESS | 19668 | 19:29:31 INFO - PROCESS | 19668 | __start_tp_report 19:29:31 INFO - PROCESS | 19668 | _x_x_mozilla_page_load 19:29:31 INFO - PROCESS | 19668 | _x_x_mozilla_page_load_details 19:29:31 INFO - PROCESS | 19668 | |i|pagename|runs| 19:29:31 INFO - PROCESS | 19668 | |0;dojo.html;3227.467467867802;3227.999320210736;3230.5477233187357;3269.329787393583;3277.737780977522;5167.224916262553;5256.92114618281;5263.263143159956;5265.657732247401;5330.973345133269;5251.5798736101115;5268.841934741954;5312.442193569668;5325.920111198335;5362.812301569436;4840.975795121029;4899.363082799231;4950.133726597849;4966.875828104308;4976.452590215092;4942.752862356886;4958.528939750736;4985.302057711923;4989.75051247438;5025.221090730943;4768.260919557474;4847.491013443573;4866;4893.314935908976;4914.992426552548;4848.612111031109;4852.1508735971065;4876.60987121033;4898.21628539432;4923.556879880828;4842.878928026827;4878.219484882437;4879.902022045047;4897.461279259279;4912.631552633531;5068.467810879842;5124.231365295198;5162.148245539482;5181.093308670967;5251.55361794248;5646.6894320812335;5718.513926316268;5727.2268243787385;5735.569832262597;5748.5975981681295;5775.075987841925;5790.536757059467;5791.942080579182;5799.420057994209;5808.88382232353;5337.11937530307;5357.571394288487;5385.246065550826;5386.865328366822;5437.864053398696;5870;5870.119482077723;5879.676617785977;5896.764129434775;5936.079907614327;5657.094864821609;5658.207850900877;5660.716964151776;5675.517581005578;5684.857878552986;5576.944230557724;5655.293088363955;5743.396943320975;5752.856178595485;5803.448672376117;5691.544676425876;5725.656460612377;5727.31272247333;5738.454846789548;5767.875264323417;5709.800156994568;5714.171445140431;5714.371419143891;5719.084946408638;5742.741576628978;4357.477102747627;4414.624756895636;4420.071784925138;4434.866953991385;4449.9555004450185;3937.2125574885135;3949.3681011038097;3968.8015599219925;3990.082281075369;4002.5797291284;5321.760520776575;5330.253764472977;5366.597505187126;5383.650062745909;5412.07994640912;5626.1842032905;5674.460926212003;5703.686297253691;5708.657480551097;5838.79564215259;5341.839744807662;5378;5390.595705322116;5416.21464887597;5433.103537916279;4951.90096198074;4955.554000140005;4960.925586116211;4961.479044700327;5019.171836646912;5745.339285982165;5868.413158684098;5903.439173278532;5924.170616113662;5939.4357536034;5706.714664266853;5780.855478613068;5783.248177736868;5785.479306862402;5786.797462088806;5964.671943043174;5968.731407086605;5971.28344598651;5974.551908606959;5976.731047102978;5498.80754173602;5639.492445679908;5684.658920464785;5707.1724599933605;5752.453516915886;5724.284464441945;5744.396838331915;5776.480116789509;5777.075667893285;5780.306363236438;5459.044667183148;5611.943880561143;5634.74643641029;5636.943630563642;5649.689267090185;5544.584156188222;5651.180578815966;5677.176809362537;5689.8862022758485;5693.772249109989;5478.753456094565;5491.093969494988;5529.4470552944385;5542.2795036644975;5554.944450555443;5448.45515448452;5504.614676972574;5562.443755624405;5569.053260945568;5635.971820140873;5528.336599608073;5569.05326094573;5570.610057296112;5584.609077364546;5599.076152434803 19:29:31 INFO - PROCESS | 19668 | |1;ext.html;539.3069905171855;543.5352773378761;561.2759540193151;570.39538089625;579.9565032622554;35453.645463545356;35881.64118358816;36219.27561448769;36348;36502.45246321304;40291.19417611646;40616.18767624646;40639;40736;41023.58976410235;8457.53483558404;8558.529280889548;8589.656413743474;8618.43980141292;8640.913590864075;8334.916650833506;8493.405461617689;8522.593772027609;8638.049814520398;8700.782480437976;8739.563021848913;8780.209781119698;8787.824243515126;8827.514486703229;8860;8611.224989750921;8625.654973801009;8658.956705216497;8662.09048049952;8685.131486851296;8440.28257598105;8630.568471576396;8661.480311181349;8669.263112635434;8671.046184919654;39266.60733392658;39427.4085888709;39483.21033579313;39738.20523589541;39819.40270895939;2778.4165325281715;2834.8157369770897;2858;2950.8081974671577;3085.305806193611;29755.256118597208;30022.699773002427;30392.69607303921;30697.386052279053;30765.846170769226;3765;3783.621637836222;3819.1216020315205;3844.807759612036;3916.960830391688;266901;268312;268520;268702;269039;51370.22944655758;53073;57023.71488142533;58525.122123168185;59887;54033.1895021575;54133;54138.72930635322;54263.72868135634;54275.45724542704;14628.926855365868;14771.482998095014;14786.482473113389;14823.407063717546;14844;11098.667039988813;11146.331220126818;11151.498182581803;11207.495662695199;11306.886931130748;19072.684566757973;19357.709634355495;19444.416667499998;19471.513212169808;19560.728552644032;7217.494775365779;7393.51942123771;7409.555426674417;7429.33136017761;7461.328480436679;922.8569571716395;931.5249222896372;997.3567049253336;1038.7039693687414;1062.2458054781036;28393.006244781332;28524.144275671762;28780;28907.855460722563;29118.417631647248;1040.1834559870465;1076.674383331999;1090.7709381030072;1114.7826173896174;1155.2086820527966;14917.776233356508;15011.24943752808;15052.32264548098;15184;15202.239888005555;311101;315314;315955;317132;318161;52097.47902521002;52169.2174617381;52348.47651523436;52528.212076818876;52552.47447525552;1309.4042210794066;1339.7923321885123;1343.5633419138624;1352.6280272925023;1361.0880709924375;27673.723262767115;28599.71400286054;28642.570361444177;29033;29250.268743281587;45556.77221613871;45785.77107114443;45951.54048459473;46066.76966615146;46403;312615;313951;316222;316425;317151;29084.12747617575;29811.55282670805;31110.68889311078;31533.369332613678;31965.200869977507;36389.09027274339;36638.450423244205;37163.442548362334;37329.25341493209;37408;31995;32077.839610801795;32460.188495287806;34397.65602343944;35589.82205088958;32327.35345293128;32595;34379.82810085933;34868.302633947686;35051.474227886094;35182.12044698903;35384;35434.822825885705;35443.11392215215;35443.82278088593;31300.217494562818;31908.202294942814;31966.36067278688;32121.51817722689;32137.184187654522;24190.484736992174;24441.877790611645;24708.752912470645;24723.381915452257;24893.377665557782 19:29:31 INFO - PROCESS | 19668 | |2;jquery.html;362.0785101915625;363.58732838228605;367.14821613855867;368.3958308374267;376.68923138410815;15592.376304947802;16094.356225750971;16625.99999999997;17019.149042547884;17400.303987840503;10121.190304775619;10336.586536538549;14561.490347837827;16533.586660333498;16699.66600667989;4900.166971614825;4917.901641967159;5386.78452861887;5392.622516423852;5396.217548455472;5281.075811732951;5345.33183352081;5383.2732581101445;5394.1908713693065;5394.298741163643;5329.120695085326;5395.919061214085;5422.810201642943;5426.728663566825;5437.8368648940595;4841.346418233528;4937.456879743261;5315.043292207421;5378.650387724805;5403.108487099644;4791.185498465235;4803.543663351976;4810.278458231258;4820.39745031871;4821.300911367867;13001;13365.732685346238;18047.639047219112;19711.408657740292;19722.605547889107;2029.725986991752;2068.586282743442;2081.323569839793;2092.5605622819226;2282.9498430721887;5537.529310008654;9747.756306092333;10200.030997055268;10263.640772572999;13351.399187036606;1787.4101546489628;1793.883397579153;1838.0442170071622;1842.3551756885117;1888.707250376194;49501.75249123731;52002.73998630021;52397.73801131008;52575.47424525782;52988.47011529874;9813.705588832347;10131.64539241123;10256.743581410525;10298.948505257425;10329.328593641389;12687.682807929876;13199.538016169388;13247.072704910564;13601.931990339985;13634.727305454035;7350.301721336465;7515.248475152441;7554;7577.734779282809;7594.544327340377;7138.892916606255;7153.427725781925;7183.173934997438;7234.819129521804;7238.601876896716;4409.933850992237;4455.910881782346;4471.821127154877;4472.0608672179205;4475.7985890634345;1767.8674099442594;1822.261983896524;1865.1140708163514;1870.6071724937644;1893.1764682363216;896.4934811831295;956.3735753081743;999.8650182225452;1012.7265638277771;1072.6353039966448;16301.918490407472;16404.343826246815;16407.261673224733;16709.6658066838;16818.915905420396;900.3157600223877;903.2457897655399;946.8958414574391;965.7971825916636;983.3018556824735;9097.636094556143;9258.398204116711;9591.280653950982;10075.294729368874;10128.797424051478;526271;535011;536558;544839;546980;67325;68098.31901681019;69221;70535;71818.64090679513;1121.5794077221042;1144.7767685301453;1146.7935771561033;1146.850909381775;1158.79141754485;15045.774313385527;15226.695466090838;15233.542993710207;15261.542153735405;15390.84609153894;29373.977576506655;31550.36899262048;32078.518822218153;35126.47310290399;35521;39733;40456.3931541033;42183.78908105563;42455.575444246395;42620.57379426166;7040.5071644984355;7306;7332.523385979895;7415.1101867776215;7539.434542409232;8671.869921951049;10643.254972151875;10698.41158736277;10897.400642964712;11029.283096598696;9406.717798466058;9628.75928101803;9682.612695492102;9706.272029597949;9732.902670973483;9149.725508234764;9213.124753148708;9509.144177024102;9756.268279878896;9981.950090249502;8932.910670893469;9639.469829159463;9696.5151742414;9824.263180261367;9929.3545919515;6834.45324374039;6907.551009184588;6925.896111558432;6955.930440695731;7104.609246491286;3075.86158622858;3111.9688803112585;7597.796638974635;8174.264316211569;9322.627094916128 19:29:31 INFO - PROCESS | 19668 | |3;mootools.html;1464.1654257073467;1470.8896832737546;1619.4655763598007;1745.424010076675;1767.6906541355252;6655.966720166404;6826.863462730742;7620.428467864905;7789.72735954241;7789.805254868631;7294.927050729491;7399.667014984325;7477.14012888518;7485;7506.437017223703;2227.187076716999;2258.672492488588;2269.4780200553882;2277.7038984931937;2289.9885500572473;2266.8526545774553;2285.0288627333316;2286.4855407533255;2288.473651060257;2288.519410923708;2220.3893929169444;2235.541713948645;2240.596692595332;2272.7272727272752;2277.601419751545;2266.614675505152;2269.5347453771938;2270.8069814065825;2271.9091236350528;2283.098176220392;2242.1703969531377;2253.0874995626796;2254.3913143451177;2258.5934531784437;2265.365697604673;7662.1571627120975;7679.539227646359;7698.499597526143;7706.344960678293;7718.189590093071;4708.105459962596;4765.880852978668;4789.137955168068;4809.014152098812;4839.903201935942;2991.685872983349;3030.6666266710645;3049.4968330225706;3071.339661972664;3096.5200393938976;960.812641534901;969.2246203037541;996.227923359395;996.3374356053216;1002.2232769603543;10966.396848173346;10980.231383803137;10984.340939543654;10995.395253261067;11000.339979601169;4346.456692913386;4408.735475871458;4461.219286624828;4491.169133710208;4532.796024178854;9335.393199442015;9342.48616326095;9376.156145946898;9383.108604682544;9428.811423771485;4786.0667169902235;4799.424069111659;4810.903781924412;4841.080194762983;4856.17445034345;4010.498687664042;4135;4179.2477354076555;4413.911721765547;4417.9838637113;3580.8925732228076;3594.5866225383893;3600.459931010317;3600.855965761393;3634.7092232621326;1138.1293310617218;1164.301419148521;1166.416791604198;1167.6263595649311;1168.988310116888;1093.9343639381664;1096.13405409727;1226.9693457495569;1260.1808824264301;1276.2789024201297;7423.294786995227;7438.293362130589;7453.291937265951;7470.738524151629;7567.545947243183;501.34324035512867;506.7567567567588;507.7359772918136;511.4093222328217;512.7410657617879;5623.971880140655;5628.493435590816;5648.915266271009;5676.0918253080135;5703.116017017369;9003.909960900439;9414.764630884283;9460.195883349854;9519.428834269966;9570;9285.164335209864;9342.159205671522;9398.060193980547;9463.621455141854;9480.241580673668;6964.79105626832;7119.394851437686;7186.209516953131;7221.169565499929;7231.5299505531975;7203.387712044325;7229.457790665616;7319;7321.853562928605;7351.963240183765;7906.841863162819;8047.436679432383;8173;8180.918190818254;8343.45767525109;8263.091059983277;8268.049174345027;8277.420580559303;8279.668813247403;8343.833123337377;7074.257202993612;7121.9643901780155;7299.087614048244;7302.196758356683;7316.414686825147;7033.542819716702;7080.362767350963;7138.286171383028;7142.642867856483;7204.279572042754;6784.966075169593;6842.794716158523;6912.965435172993;6998.125234345707;7050.823729406806;6745.628990405575;6830.829229269308;6882;6942.444604431533;7007.7196912122945;6908.378245957888;6941.687624056828;6987.6855541499735;7030.824229394306;7079.8938015930835;6182.536309776695;6201.379862013762;6266.874662506633;6284.528660350584;6284.842878928063;6344.175257216532;6391.744330226925;6422.710978005907;6467.126937863328;6478.5141114415665 19:29:31 INFO - PROCESS | 19668 | |4;prototype.html;341.45196958880996;345.9878904238352;349.500214692989;352.16712474996643;353.48920809430365;6166.753329866806;6216.782412615559;6259.906101408476;6305.9595166797535;6370;6209.472194863442;6238.781642642509;6244.375562443754;6271.4669253113425;6281.874362512747;4768.880777980561;4772.117158325721;4779.402574678165;4784.497627749089;4787.377640906686;4784.952150478485;4793.18515852306;4793.712377257376;4794.9760251198695;4798.4241890973135;4644.72131672099;4708.976455117737;4721.150192965265;4724.322865382791;4743.383360163191;4716.137125835293;4718.457377401608;4718.646101542381;4730.290456431529;4756.405449318835;4086.6117718816663;4102.159057393227;4104.958950410488;4107.466029416187;4116.794160292004;5854.18041474194;5880.235569375996;5899.911501327483;5906.586538942276;5935.881282374328;5407.702576358299;5509.228707980886;5532.225488431623;5533.750981205815;5534.948359811623;6601.405873471411;6604.3725846044545;6610.975298828689;6622.668866556653;6624.93375066248;4522.140793249272;4525.86422407325;4541.568550987651;4547.545245475426;4549.863504094882;6713.295104014057;6856.52004359695;6934.237233904267;6941.201761797458;6944.236134025253;4647.140279048387;4647.721136731807;4681.016986432887;4687.648426368036;4697.271922851964;4716.080364328992;4728.4798672146035;4740.312654665055;4750.358701575243;4751.382320298339;5456.836294911159;5474.343078830566;5479.17812328146;5485.314335708036;5513.062779327524;6535.771248006297;6646.26891041985;6651.600903945779;6655.334466553403;6667.699953502104;1637.1568642149302;1661.3520726916513;1676.3797394963942;1676.5473322203181;1684.3346877983372;1089.9182561307775;1091.612477570467;1103.8178700514325;1108.8336749487642;1117.5473933057124;6159.876802464015;6169.167162433104;6177.444030037318;6189.81430557084;6200.844978875564;6703;6726.058351830748;6730.966345168341;6749.122614060141;6754.0881980931945;6015.54883383748;6098.32918378978;6141.201643786279;6143.539234557336;6149.7847575334645;3632.7820330780237;3663.816809159531;3671.192337685705;3675.650813172744;3681.9631803682155;7070.611116388648;7071.36357727807;7088.362047415654;7104.751333703295;7108.040414544073;6763.154605674291;6869.725210991504;6922.134733158356;6924.203716572558;6938.514303998772;7064.399526040242;7070.434365250768;7072.398846098139;7073.080499535027;7082.3979961703835;6680.231773346128;6690.264070952288;6708.563943343667;6733.091032710521;6775.525713200029;6552.57408268461;6629.337066293332;6631.9388897776125;6670.899936500859;6682.164729408824;6785.796426107225;6794.3545363190415;6815.079964204769;6873.175218973755;6886.449084073362;4646.442426908792;4646.465656449416;4659.301104834167;4660.1145782301255;4680;6658.833529161616;6660.833479162866;6737.191537015589;6764.323567643393;6922.5154239202775;6707.463402927851;6723.966380168068;6732.629705366252;6732.865342693217;6737.494687898526;6672.5329226953645;6694.564853284521;6698.330166983263;6714.395704386433;6724.865502690017;6475.255345635313;6582.473402127914;6584.736610535525;6588.209414870054;6613;6689.966550167218;6713.56361836479;6724.697388617622;6745.527813053235;6756.560823546453;6546.901796472961;6556;6567.310432404529;6570.145881035435;6572.7042283098335 19:29:31 INFO - PROCESS | 19668 | |5;yui.html;775.8215610409609;781.0978320040356;781.3358645151621;849.7875531117221;858.9226969572737;13127.868721312783;13217.93391033046;13285.136466129696;13309.933450332746;13407.463701451954;10353.1717462603;11267.774644507104;11427.885721142786;11525.250858694179;11600.477978490968;798.2735710503443;811.253646645085;811.4482152136545;814.5927036481759;815.2703330519182;806.209914284002;808.6441965535146;810.5541951926447;810.5866008335732;812.6586833529932;844.252836239929;844.7465760271924;845.4546817302836;847.7160151349275;847.8770578266148;844.6494704697543;845.8054647431095;846.0439703135479;847.4025811802665;847.4322204123253;617.0589850478057;621.2265729167216;623.3735096228262;624.3382015064046;624.7063879976404;10882.836757448644;10991.670249892515;11000.944995274973;11002.944985275102;11063.170262230366;10824.079953203987;10905.83641245382;10971.615993440191;11136.276142050741;11258.718532036683;9309.813803723888;9463.101005404476;9523.952380238125;9544.188743956773;9629.951850240774;3417.4532074868152;3440.913977150566;3499.422595271777;3560.501529785832;3580.5524309461316;41063.384049239285;42761;42765.78617106895;46043;46243.53756462426;9732.562034708455;9843.310968232156;9889;9972.501374931224;10206.642767503101;17948.820511794715;18156.909215453838;18169.273229070688;18236.36172733948;18250.269989200548;7254.093238345207;7377.299156580117;7521.962390188123;7789.688412463552;7873.370130389555;4122;4123.175364927027;4158.812853421603;4357.586029327209;4397.934030989538;2952.1881482592457;3007.9548806767916;3016.276093737531;3020.6677265500775;3028.348904985439;555.8165805284247;586.352080950552;608.8203979825962;609.0772479693268;618.8607563298312;594.7353427724621;617.0867116667357;621.3320680268729;643.9356064393523;652.1587152573222;8300.128486508951;8389.538575378412;8462.407631465738;8505.574721264036;8560.101189375151;649.7758273395671;651.5374084400129;653.1737352249409;653.8275121912611;657.2244751193542;3991.1219531702977;4002.8598999034893;4054.39184122384;4135.193637240769;4173.624373806372;54228.577142286245;54378.728106359216;54460;54843;57028.71485642628;48432.515674843504;48458.5154148454;48575.75712121417;48740.26889596659;48905.5109448901;47625.285620715025;48695.269570956465;49171;49269;49741.751291243316;8884.73345799627;8924.375293729376;9066.410683305565;9146.176844084064;9157.633694652139;34016;34353;34481.31037379188;35082;35180.47229291512;47243;47548.28677569908;47701;47732.7613361931;48288;9368.063193680577;9431.858522122036;9771.85342219853;9961.161069095273;11437.19939604253;10368.637097701545;11247.268927520012;12172.939135304267;12299.200551964093;12682.429290682127;10801.297915635458;10876.619318323821;10924.2899211551;11034.724131896766;11239.719007024889;10798.71185156361;10954.835677464685;10971.286866353661;11009.669709908716;11039.116870650489;10661.029594628202;10843.783124337311;10902.127829773757;10930.344179349264;10965.890341096807;8816.647334106563;8972.237359824489;9002.819943601222;9113.36206465541;9329.73847933708;8811.268725312297;9574.808503830023;9684.32209745311;9766.121049105615;9802 19:29:31 INFO - PROCESS | 19668 | __end_tp_report 19:29:31 INFO - PROCESS | 19668 | __start_cc_report 19:29:31 INFO - PROCESS | 19668 | _x_x_mozilla_cycle_collect,299 19:29:31 INFO - PROCESS | 19668 | __end_cc_report 19:29:31 INFO - PROCESS | 19668 | __startTimestamp1453433371414__endTimestamp 19:29:31 INFO - PROCESS | 19668 | 19:29:31 INFO - PROCESS | 19668 | ------- Summary: start ------- 19:29:31 INFO - PROCESS | 19668 | Number of tests: 6 19:29:31 INFO - PROCESS | 19668 | 19:29:31 INFO - PROCESS | 19668 | [#0] dojo.html Cycles:165 Average:5328.26 Median:5529.45 stddev:581.01 (10.5%) stddev-sans-first:558.93 19:29:31 INFO - PROCESS | 19668 | Values: 3227.5 3228.0 3230.5 3269.3 3277.7 5167.2 5256.9 5263.3 5265.7 5331.0 5251.6 5268.8 5312.4 5325.9 5362.8 4841.0 4899.4 4950.1 4966.9 4976.5 4942.8 4958.5 4985.3 4989.8 5025.2 4768.3 4847.5 4866.0 4893.3 4915.0 4848.6 4852.2 4876.6 4898.2 4923.6 4842.9 4878.2 4879.9 4897.5 4912.6 5068.5 5124.2 5162.1 5181.1 5251.6 5646.7 5718.5 5727.2 5735.6 5748.6 5775.1 5790.5 5791.9 5799.4 5808.9 5337.1 5357.6 5385.2 5386.9 5437.9 5870.0 5870.1 5879.7 5896.8 5936.1 5657.1 5658.2 5660.7 5675.5 5684.9 5576.9 5655.3 5743.4 5752.9 5803.4 5691.5 5725.7 5727.3 5738.5 5767.9 5709.8 5714.2 5714.4 5719.1 5742.7 4357.5 4414.6 4420.1 4434.9 4450.0 3937.2 3949.4 3968.8 3990.1 4002.6 5321.8 5330.3 5366.6 5383.7 5412.1 5626.2 5674.5 5703.7 5708.7 5838.8 5341.8 5378.0 5390.6 5416.2 5433.1 4951.9 4955.6 4960.9 4961.5 5019.2 5745.3 5868.4 5903.4 5924.2 5939.4 5706.7 5780.9 5783.2 5785.5 5786.8 5964.7 5968.7 5971.3 5974.6 5976.7 5498.8 5639.5 5684.7 5707.2 5752.5 5724.3 5744.4 5776.5 5777.1 5780.3 5459.0 5611.9 5634.7 5636.9 5649.7 5544.6 5651.2 5677.2 5689.9 5693.8 5478.8 5491.1 5529.4 5542.3 5554.9 5448.5 5504.6 5562.4 5569.1 5636.0 5528.3 5569.1 5570.6 5584.6 5599.1 19:29:31 INFO - PROCESS | 19668 | 19:29:31 INFO - PROCESS | 19668 | [#1] ext.html Cycles:180 Average:46108.48 Median:35116.80 stddev:78618.08 (223.9%) stddev-sans-first:78764.17 19:29:31 INFO - PROCESS | 19668 | Values: 539.3 543.5 561.3 570.4 580.0 35453.6 35881.6 36219.3 36348.0 36502.5 40291.2 40616.2 40639.0 40736.0 41023.6 8457.5 8558.5 8589.7 8618.4 8640.9 8334.9 8493.4 8522.6 8638.0 8700.8 8739.6 8780.2 8787.8 8827.5 8860.0 8611.2 8625.7 8659.0 8662.1 8685.1 8440.3 8630.6 8661.5 8669.3 8671.0 39266.6 39427.4 39483.2 39738.2 39819.4 2778.4 2834.8 2858.0 2950.8 3085.3 29755.3 30022.7 30392.7 30697.4 30765.8 3765.0 3783.6 3819.1 3844.8 3917.0 266901.0 268312.0 268520.0 268702.0 269039.0 51370.2 53073.0 57023.7 58525.1 59887.0 54033.2 54133.0 54138.7 54263.7 54275.5 14628.9 14771.5 14786.5 14823.4 14844.0 11098.7 11146.3 11151.5 11207.5 11306.9 19072.7 19357.7 19444.4 19471.5 19560.7 7217.5 7393.5 7409.6 7429.3 7461.3 922.9 931.5 997.4 1038.7 1062.2 28393.0 28524.1 28780.0 28907.9 29118.4 1040.2 1076.7 1090.8 1114.8 1155.2 14917.8 15011.2 15052.3 15184.0 15202.2 311101.0 315314.0 315955.0 317132.0 318161.0 52097.5 52169.2 52348.5 52528.2 52552.5 1309.4 1339.8 1343.6 1352.6 1361.1 27673.7 28599.7 28642.6 29033.0 29250.3 45556.8 45785.8 45951.5 46066.8 46403.0 312615.0 313951.0 316222.0 316425.0 317151.0 29084.1 29811.6 31110.7 31533.4 31965.2 36389.1 36638.5 37163.4 37329.3 37408.0 31995.0 32077.8 32460.2 34397.7 35589.8 32327.4 32595.0 34379.8 34868.3 35051.5 35182.1 35384.0 35434.8 35443.1 35443.8 31300.2 31908.2 31966.4 32121.5 32137.2 24190.5 24441.9 24708.8 24723.4 24893.4 19:29:31 INFO - PROCESS | 19668 | 19:29:31 INFO - PROCESS | 19668 | [#2] jquery.html Cycles:180 Average:26918.64 Median:4820.85 stddev:87835.92 (1822.0%) stddev-sans-first:88059.69 19:29:31 INFO - PROCESS | 19668 | Values: 362.1 363.6 367.1 368.4 376.7 15592.4 16094.4 16626.0 17019.1 17400.3 10121.2 10336.6 14561.5 16533.6 16699.7 4900.2 4917.9 5386.8 5392.6 5396.2 5281.1 5345.3 5383.3 5394.2 5394.3 5329.1 5395.9 5422.8 5426.7 5437.8 4841.3 4937.5 5315.0 5378.7 5403.1 4791.2 4803.5 4810.3 4820.4 4821.3 13001.0 13365.7 18047.6 19711.4 19722.6 2029.7 2068.6 2081.3 2092.6 2282.9 5537.5 9747.8 10200.0 10263.6 13351.4 1787.4 1793.9 1838.0 1842.4 1888.7 49501.8 52002.7 52397.7 52575.5 52988.5 9813.7 10131.6 10256.7 10298.9 10329.3 12687.7 13199.5 13247.1 13601.9 13634.7 7350.3 7515.2 7554.0 7577.7 7594.5 7138.9 7153.4 7183.2 7234.8 7238.6 4409.9 4455.9 4471.8 4472.1 4475.8 1767.9 1822.3 1865.1 1870.6 1893.2 896.5 956.4 999.9 1012.7 1072.6 16301.9 16404.3 16407.3 16709.7 16818.9 900.3 903.2 946.9 965.8 983.3 9097.6 9258.4 9591.3 10075.3 10128.8 526271.0 535011.0 536558.0 544839.0 546980.0 67325.0 68098.3 69221.0 70535.0 71818.6 1121.6 1144.8 1146.8 1146.9 1158.8 15045.8 15226.7 15233.5 15261.5 15390.8 29374.0 31550.4 32078.5 35126.5 35521.0 39733.0 40456.4 42183.8 42455.6 42620.6 7040.5 7306.0 7332.5 7415.1 7539.4 8671.9 10643.3 10698.4 10897.4 11029.3 9406.7 9628.8 9682.6 9706.3 9732.9 9149.7 9213.1 9509.1 9756.3 9982.0 8932.9 9639.5 9696.5 9824.3 9929.4 6834.5 6907.6 6925.9 6955.9 7104.6 3075.9 3112.0 7597.8 8174.3 9322.6 19:29:31 INFO - PROCESS | 19668 | 19:29:31 INFO - PROCESS | 19668 | [#3] mootools.html Cycles:180 Average:5419.21 Median:6314.51 stddev:2839.23 (45.0%) stddev-sans-first:2831.63 19:29:31 INFO - PROCESS | 19668 | Values: 1464.2 1470.9 1619.5 1745.4 1767.7 6656.0 6826.9 7620.4 7789.7 7789.8 7294.9 7399.7 7477.1 7485.0 7506.4 2227.2 2258.7 2269.5 2277.7 2290.0 2266.9 2285.0 2286.5 2288.5 2288.5 2220.4 2235.5 2240.6 2272.7 2277.6 2266.6 2269.5 2270.8 2271.9 2283.1 2242.2 2253.1 2254.4 2258.6 2265.4 7662.2 7679.5 7698.5 7706.3 7718.2 4708.1 4765.9 4789.1 4809.0 4839.9 2991.7 3030.7 3049.5 3071.3 3096.5 960.8 969.2 996.2 996.3 1002.2 10966.4 10980.2 10984.3 10995.4 11000.3 4346.5 4408.7 4461.2 4491.2 4532.8 9335.4 9342.5 9376.2 9383.1 9428.8 4786.1 4799.4 4810.9 4841.1 4856.2 4010.5 4135.0 4179.2 4413.9 4418.0 3580.9 3594.6 3600.5 3600.9 3634.7 1138.1 1164.3 1166.4 1167.6 1169.0 1093.9 1096.1 1227.0 1260.2 1276.3 7423.3 7438.3 7453.3 7470.7 7567.5 501.3 506.8 507.7 511.4 512.7 5624.0 5628.5 5648.9 5676.1 5703.1 9003.9 9414.8 9460.2 9519.4 9570.0 9285.2 9342.2 9398.1 9463.6 9480.2 6964.8 7119.4 7186.2 7221.2 7231.5 7203.4 7229.5 7319.0 7321.9 7352.0 7906.8 8047.4 8173.0 8180.9 8343.5 8263.1 8268.0 8277.4 8279.7 8343.8 7074.3 7122.0 7299.1 7302.2 7316.4 7033.5 7080.4 7138.3 7142.6 7204.3 6785.0 6842.8 6913.0 6998.1 7050.8 6745.6 6830.8 6882.0 6942.4 7007.7 6908.4 6941.7 6987.7 7030.8 7079.9 6182.5 6201.4 6266.9 6284.5 6284.8 6344.2 6391.7 6422.7 6467.1 6478.5 19:29:31 INFO - PROCESS | 19668 | 19:29:31 INFO - PROCESS | 19668 | [#4] prototype.html Cycles:180 Average:5508.28 Median:6205.16 stddev:1661.90 (26.8%) stddev-sans-first:1620.68 19:29:31 INFO - PROCESS | 19668 | Values: 341.5 346.0 349.5 352.2 353.5 6166.8 6216.8 6259.9 6306.0 6370.0 6209.5 6238.8 6244.4 6271.5 6281.9 4768.9 4772.1 4779.4 4784.5 4787.4 4785.0 4793.2 4793.7 4795.0 4798.4 4644.7 4709.0 4721.2 4724.3 4743.4 4716.1 4718.5 4718.6 4730.3 4756.4 4086.6 4102.2 4105.0 4107.5 4116.8 5854.2 5880.2 5899.9 5906.6 5935.9 5407.7 5509.2 5532.2 5533.8 5534.9 6601.4 6604.4 6611.0 6622.7 6624.9 4522.1 4525.9 4541.6 4547.5 4549.9 6713.3 6856.5 6934.2 6941.2 6944.2 4647.1 4647.7 4681.0 4687.6 4697.3 4716.1 4728.5 4740.3 4750.4 4751.4 5456.8 5474.3 5479.2 5485.3 5513.1 6535.8 6646.3 6651.6 6655.3 6667.7 1637.2 1661.4 1676.4 1676.5 1684.3 1089.9 1091.6 1103.8 1108.8 1117.5 6159.9 6169.2 6177.4 6189.8 6200.8 6703.0 6726.1 6731.0 6749.1 6754.1 6015.5 6098.3 6141.2 6143.5 6149.8 3632.8 3663.8 3671.2 3675.7 3682.0 7070.6 7071.4 7088.4 7104.8 7108.0 6763.2 6869.7 6922.1 6924.2 6938.5 7064.4 7070.4 7072.4 7073.1 7082.4 6680.2 6690.3 6708.6 6733.1 6775.5 6552.6 6629.3 6631.9 6670.9 6682.2 6785.8 6794.4 6815.1 6873.2 6886.4 4646.4 4646.5 4659.3 4660.1 4680.0 6658.8 6660.8 6737.2 6764.3 6922.5 6707.5 6724.0 6732.6 6732.9 6737.5 6672.5 6694.6 6698.3 6714.4 6724.9 6475.3 6582.5 6584.7 6588.2 6613.0 6690.0 6713.6 6724.7 6745.5 6756.6 6546.9 6556.0 6567.3 6570.1 6572.7 19:29:31 INFO - PROCESS | 19668 | 19:29:31 INFO - PROCESS | 19668 | [#5] yui.html Cycles:180 Average:13396.71 Median:49505.38 stddev:15695.43 (31.7%) stddev-sans-first:15710.85 19:29:31 INFO - PROCESS | 19668 | Values: 775.8 781.1 781.3 849.8 858.9 13127.9 13217.9 13285.1 13309.9 13407.5 10353.2 11267.8 11427.9 11525.3 11600.5 798.3 811.3 811.4 814.6 815.3 806.2 808.6 810.6 810.6 812.7 844.3 844.7 845.5 847.7 847.9 844.6 845.8 846.0 847.4 847.4 617.1 621.2 623.4 624.3 624.7 10882.8 10991.7 11000.9 11002.9 11063.2 10824.1 10905.8 10971.6 11136.3 11258.7 9309.8 9463.1 9524.0 9544.2 9630.0 3417.5 3440.9 3499.4 3560.5 3580.6 41063.4 42761.0 42765.8 46043.0 46243.5 9732.6 9843.3 9889.0 9972.5 10206.6 17948.8 18156.9 18169.3 18236.4 18250.3 7254.1 7377.3 7522.0 7789.7 7873.4 4122.0 4123.2 4158.8 4357.6 4397.9 2952.2 3008.0 3016.3 3020.7 3028.3 555.8 586.4 608.8 609.1 618.9 594.7 617.1 621.3 643.9 652.2 8300.1 8389.5 8462.4 8505.6 8560.1 649.8 651.5 653.2 653.8 657.2 3991.1 4002.9 4054.4 4135.2 4173.6 54228.6 54378.7 54460.0 54843.0 57028.7 48432.5 48458.5 48575.8 48740.3 48905.5 47625.3 48695.3 49171.0 49269.0 49741.8 8884.7 8924.4 9066.4 9146.2 9157.6 34016.0 34353.0 34481.3 35082.0 35180.5 47243.0 47548.3 47701.0 47732.8 48288.0 9368.1 9431.9 9771.9 9961.2 11437.2 10368.6 11247.3 12172.9 12299.2 12682.4 10801.3 10876.6 10924.3 11034.7 11239.7 10798.7 10954.8 10971.3 11009.7 11039.1 10661.0 10843.8 10902.1 10930.3 10965.9 8816.6 8972.2 9002.8 9113.4 9329.7 8811.3 9574.8 9684.3 9766.1 9802.0 19:29:31 INFO - PROCESS | 19668 | -------- Summary: end -------- 19:29:31 INFO - PROCESS | 19668 | 19:29:32 INFO - TEST-INFO | 19668: exit 0 19:29:32 INFO - TEST-OK | dromaeo_css | took 1110791ms 19:29:32 INFO - TEST-START | kraken 19:29:32 INFO - operating with platform_type : linux_ 19:29:32 INFO - Initialising browser for kraken test... 19:29:32 INFO - TEST-INFO | started process 19913 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuYIKRY/profile http://localhost:45291/getInfo.html) 19:29:35 INFO - PROCESS | 19913 | 19:29:35 INFO - PROCESS | 19913 | (process:19984): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:29:36 INFO - PROCESS | 19913 | __metrics Screen width/height:1600/1200 19:29:36 INFO - PROCESS | 19913 | colorDepth:24 19:29:36 INFO - PROCESS | 19913 | Browser inner width/height: 1024/697 19:29:36 INFO - PROCESS | 19913 | __metrics 19:29:36 INFO - PROCESS | 19913 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:29:37 INFO - TEST-INFO | 19913: exit 0 19:29:37 INFO - Browser initialized. 19:29:37 INFO - Running cycle 1/1 for kraken test... 19:29:37 INFO - TEST-INFO | started process 20033 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuYIKRY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:38 INFO - PROCESS | 20033 | 19:29:38 INFO - PROCESS | 20033 | (process:20091): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:29:49 INFO - PROCESS | 20033 | RSS: Main: 153116672 19:29:49 INFO - PROCESS | 20033 | 19:29:51 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45291/tests/kraken/driver.html?testName=audio-beat-detection) 19:29:52 INFO - PROCESS | 20033 | RSS: Main: 156270592 19:29:52 INFO - PROCESS | 20033 | 19:29:55 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45291/tests/kraken/driver.html?testName=audio-dft) 19:29:55 INFO - PROCESS | 20033 | RSS: Main: 160137216 19:29:55 INFO - PROCESS | 20033 | 19:29:58 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45291/tests/kraken/driver.html?testName=audio-fft) 19:29:59 INFO - PROCESS | 20033 | RSS: Main: 154103808 19:29:59 INFO - PROCESS | 20033 | 19:30:01 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45291/tests/kraken/driver.html?testName=audio-oscillator) 19:30:02 INFO - PROCESS | 20033 | RSS: Main: 154288128 19:30:02 INFO - PROCESS | 20033 | 19:30:04 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:30:05 INFO - PROCESS | 20033 | RSS: Main: 154464256 19:30:05 INFO - PROCESS | 20033 | 19:30:08 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45291/tests/kraken/driver.html?testName=imaging-darkroom) 19:30:08 INFO - PROCESS | 20033 | RSS: Main: 155086848 19:30:08 INFO - PROCESS | 20033 | 19:30:12 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45291/tests/kraken/driver.html?testName=imaging-desaturate) 19:30:12 INFO - PROCESS | 20033 | RSS: Main: 154861568 19:30:12 INFO - PROCESS | 20033 | 19:30:15 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45291/tests/kraken/driver.html?testName=json-parse-financial) 19:30:15 INFO - PROCESS | 20033 | RSS: Main: 155607040 19:30:16 INFO - PROCESS | 20033 | 19:30:17 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:30:18 INFO - PROCESS | 20033 | RSS: Main: 156446720 19:30:18 INFO - PROCESS | 20033 | 19:30:19 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45291/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:30:20 INFO - PROCESS | 20033 | RSS: Main: 154816512 19:30:20 INFO - PROCESS | 20033 | 19:30:22 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:30:23 INFO - PROCESS | 20033 | RSS: Main: 155136000 19:30:23 INFO - PROCESS | 20033 | 19:30:25 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:30:26 INFO - PROCESS | 20033 | RSS: Main: 155832320 19:30:26 INFO - PROCESS | 20033 | 19:30:28 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:30:29 INFO - PROCESS | 20033 | RSS: Main: 155226112 19:30:29 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | Cycle 1(1): loaded http://localhost:45291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45291/tests/kraken/driver.html?testName=ai-astar) 19:30:31 INFO - PROCESS | 20033 | RSS: Main: 155766784 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | __start_tp_report 19:30:31 INFO - PROCESS | 20033 | _x_x_mozilla_page_load 19:30:31 INFO - PROCESS | 20033 | _x_x_mozilla_page_load_details 19:30:31 INFO - PROCESS | 20033 | |i|pagename|runs| 19:30:31 INFO - PROCESS | 20033 | |0;ai-astar;109;107;110;110;111;124;110;110;111;111 19:30:31 INFO - PROCESS | 20033 | |1;audio-beat-detection;159;137;161;185;129;151;156;130;172;128 19:30:31 INFO - PROCESS | 20033 | |2;audio-dft;164;164;163;163;164;162;163;166;170;164 19:30:31 INFO - PROCESS | 20033 | |3;audio-fft;74;72;73;75;74;153;73;73;77;73 19:30:31 INFO - PROCESS | 20033 | |4;audio-oscillator;96;97;141;95;95;96;151;95;97;139 19:30:31 INFO - PROCESS | 20033 | |5;imaging-gaussian-blur;110;109;109;110;109;110;109;111;110;110 19:30:31 INFO - PROCESS | 20033 | |6;imaging-darkroom;147;147;146;147;147;148;146;146;147;147 19:30:31 INFO - PROCESS | 20033 | |7;imaging-desaturate;96;97;97;98;97;96;97;96;97;96 19:30:31 INFO - PROCESS | 20033 | |8;json-parse-financial;61;61;66;58;58;59;58;60;61;59 19:30:31 INFO - PROCESS | 20033 | |9;json-stringify-tinderbox;68;68;67;69;69;68;68;68;68;68 19:30:31 INFO - PROCESS | 20033 | |10;stanford-crypto-aes;84;85;85;91;83;82;84;84;86;92 19:30:31 INFO - PROCESS | 20033 | |11;stanford-crypto-ccm;117;115;124;128;119;121;124;119;119;115 19:30:31 INFO - PROCESS | 20033 | |12;stanford-crypto-pbkdf2;144;150;149;146;147;133;144;144;147;134 19:30:31 INFO - PROCESS | 20033 | |13;stanford-crypto-sha256-iterative;68;67;71;67;66;66;67;69;70;69 19:30:31 INFO - PROCESS | 20033 | __end_tp_report 19:30:31 INFO - PROCESS | 20033 | __start_cc_report 19:30:31 INFO - PROCESS | 20033 | _x_x_mozilla_cycle_collect,740 19:30:31 INFO - PROCESS | 20033 | __end_cc_report 19:30:31 INFO - PROCESS | 20033 | __startTimestamp1453433431362__endTimestamp 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | ------- Summary: start ------- 19:30:31 INFO - PROCESS | 20033 | Number of tests: 14 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#0] ai-astar Cycles:10 Average:111.30 Median:110.50 stddev:4.62 (4.2%) stddev-sans-first:4.82 19:30:31 INFO - PROCESS | 20033 | Values: 109.0 107.0 110.0 110.0 111.0 124.0 110.0 110.0 111.0 111.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:157.50 stddev:19.54 (12.4%) stddev-sans-first:20.50 19:30:31 INFO - PROCESS | 20033 | Values: 159.0 137.0 161.0 185.0 129.0 151.0 156.0 130.0 172.0 128.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.26 (1.4%) stddev-sans-first:2.40 19:30:31 INFO - PROCESS | 20033 | Values: 164.0 164.0 163.0 163.0 164.0 162.0 163.0 166.0 170.0 164.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#3] audio-fft Cycles:10 Average:81.70 Median:73.50 stddev:25.09 (34.1%) stddev-sans-first:26.46 19:30:31 INFO - PROCESS | 20033 | Values: 74.0 72.0 73.0 75.0 74.0 153.0 73.0 73.0 77.0 73.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:95.50 stddev:23.30 (24.4%) stddev-sans-first:24.14 19:30:31 INFO - PROCESS | 20033 | Values: 96.0 97.0 141.0 95.0 95.0 96.0 151.0 95.0 97.0 139.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 19:30:31 INFO - PROCESS | 20033 | Values: 110.0 109.0 109.0 110.0 109.0 110.0 109.0 111.0 110.0 110.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 19:30:31 INFO - PROCESS | 20033 | Values: 147.0 147.0 146.0 147.0 147.0 148.0 146.0 146.0 147.0 147.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 19:30:31 INFO - PROCESS | 20033 | Values: 96.0 97.0 97.0 98.0 97.0 96.0 97.0 96.0 97.0 96.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:60.50 stddev:2.42 (4.0%) stddev-sans-first:2.55 19:30:31 INFO - PROCESS | 20033 | Values: 61.0 61.0 66.0 58.0 58.0 59.0 58.0 60.0 61.0 59.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 19:30:31 INFO - PROCESS | 20033 | Values: 68.0 68.0 67.0 69.0 69.0 68.0 68.0 68.0 68.0 68.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:3.31 (3.9%) stddev-sans-first:3.46 19:30:31 INFO - PROCESS | 20033 | Values: 84.0 85.0 85.0 91.0 83.0 82.0 84.0 84.0 86.0 92.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:120.00 stddev:4.20 (3.5%) stddev-sans-first:4.30 19:30:31 INFO - PROCESS | 20033 | Values: 117.0 115.0 124.0 128.0 119.0 121.0 124.0 119.0 119.0 115.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.80 Median:146.50 stddev:5.81 (4.0%) stddev-sans-first:6.16 19:30:31 INFO - PROCESS | 20033 | Values: 144.0 150.0 149.0 146.0 147.0 133.0 144.0 144.0 147.0 134.0 19:30:31 INFO - PROCESS | 20033 | 19:30:31 INFO - PROCESS | 20033 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.70 (2.5%) stddev-sans-first:1.80 19:30:31 INFO - PROCESS | 20033 | Values: 68.0 67.0 71.0 67.0 66.0 66.0 67.0 69.0 70.0 69.0 19:30:31 INFO - PROCESS | 20033 | -------- Summary: end -------- 19:30:31 INFO - PROCESS | 20033 | 19:30:32 INFO - TEST-INFO | 20033: exit 0 19:30:32 INFO - TEST-OK | kraken | took 60246ms 19:30:32 INFO - TEST-START | v8_7 19:30:32 INFO - operating with platform_type : linux_ 19:30:32 INFO - Initialising browser for v8_7 test... 19:30:32 INFO - TEST-INFO | started process 20319 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjSOjhY/profile http://localhost:45291/getInfo.html) 19:30:36 INFO - PROCESS | 20319 | 19:30:36 INFO - PROCESS | 20319 | (process:20391): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:30:36 INFO - PROCESS | 20319 | __metrics Screen width/height:1600/1200 19:30:36 INFO - PROCESS | 20319 | colorDepth:24 19:30:36 INFO - PROCESS | 20319 | Browser inner width/height: 1024/697 19:30:36 INFO - PROCESS | 20319 | __metrics 19:30:37 INFO - PROCESS | 20319 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:30:38 INFO - TEST-INFO | 20319: exit 0 19:30:38 INFO - Browser initialized. 19:30:38 INFO - Running cycle 1/1 for v8_7 test... 19:30:38 INFO - TEST-INFO | started process 20440 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjSOjhY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:30:39 INFO - PROCESS | 20440 | 19:30:39 INFO - PROCESS | 20440 | (process:20500): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:30:49 INFO - PROCESS | 20440 | RSS: Main: 153649152 19:30:49 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | Cycle 1(1): loaded http://localhost:45291/tests/v8_7/run.html (next: http://localhost:45291/tests/v8_7/run.html) 19:31:12 INFO - PROCESS | 20440 | RSS: Main: 153792512 19:31:12 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | __start_tp_report 19:31:12 INFO - PROCESS | 20440 | _x_x_mozilla_page_load 19:31:12 INFO - PROCESS | 20440 | _x_x_mozilla_page_load_details 19:31:12 INFO - PROCESS | 20440 | |i|pagename|runs| 19:31:12 INFO - PROCESS | 20440 | |0;Richards;167.22408026755852 19:31:12 INFO - PROCESS | 20440 | |1;DeltaBlue;188.07598269700958 19:31:12 INFO - PROCESS | 20440 | |2;Encrypt;279.2516056967328 19:31:12 INFO - PROCESS | 20440 | |3;Decrypt;5256.544502617801 19:31:12 INFO - PROCESS | 20440 | |4;RayTrace;1075.268817204301 19:31:12 INFO - PROCESS | 20440 | |5;Earley;705.2186177715091 19:31:12 INFO - PROCESS | 20440 | |6;Boyer;12456.79012345679 19:31:12 INFO - PROCESS | 20440 | |7;RegExp;42354.166666666664 19:31:12 INFO - PROCESS | 20440 | |8;Splay;562.6398210290828 19:31:12 INFO - PROCESS | 20440 | |9;NavierStokes;4845.410628019324 19:31:12 INFO - PROCESS | 20440 | __end_tp_report 19:31:12 INFO - PROCESS | 20440 | __startTimestamp1453433472531__endTimestamp 19:31:12 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | ------- Summary: start ------- 19:31:12 INFO - PROCESS | 20440 | Number of tests: 10 19:31:12 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | [#0] Richards Cycles:1 Average:167.22 Median:167.22 stddev:0.00 (0.0%) 19:31:12 INFO - PROCESS | 20440 | Values: 167.2 19:31:12 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | [#1] DeltaBlue Cycles:1 Average:188.08 Median:188.08 stddev:0.00 (0.0%) 19:31:12 INFO - PROCESS | 20440 | Values: 188.1 19:31:12 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 19:31:12 INFO - PROCESS | 20440 | Values: 279.3 19:31:12 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 19:31:12 INFO - PROCESS | 20440 | Values: 5256.5 19:31:12 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 19:31:12 INFO - PROCESS | 20440 | Values: 1075.3 19:31:12 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | [#5] Earley Cycles:1 Average:705.22 Median:705.22 stddev:0.00 (0.0%) 19:31:12 INFO - PROCESS | 20440 | Values: 705.2 19:31:12 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | [#6] Boyer Cycles:1 Average:12456.79 Median:12456.79 stddev:0.00 (0.0%) 19:31:12 INFO - PROCESS | 20440 | Values: 12456.8 19:31:12 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | [#7] RegExp Cycles:1 Average:42354.17 Median:42354.17 stddev:0.00 (0.0%) 19:31:12 INFO - PROCESS | 20440 | Values: 42354.2 19:31:12 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | [#8] Splay Cycles:1 Average:562.64 Median:562.64 stddev:0.00 (0.0%) 19:31:12 INFO - PROCESS | 20440 | Values: 562.6 19:31:12 INFO - PROCESS | 20440 | 19:31:12 INFO - PROCESS | 20440 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 19:31:12 INFO - PROCESS | 20440 | Values: 4845.4 19:31:12 INFO - PROCESS | 20440 | -------- Summary: end -------- 19:31:12 INFO - PROCESS | 20440 | 19:31:13 INFO - TEST-INFO | 20440: exit 0 19:31:13 INFO - TEST-OK | v8_7 | took 41133ms 19:31:13 INFO - SUITE-END | took 1212s 19:31:13 INFO - Completed test suite (00:20:12) 19:31:13 INFO - Working with test: dromaeo_css 19:31:13 INFO - Generating results file: dromaeo_css 19:31:13 INFO - Working with test: kraken 19:31:13 INFO - Generating results file: kraken 19:31:13 INFO - javascript benchmark 19:31:13 INFO - Working with test: v8_7 19:31:13 INFO - Generating results file: v8_7 19:31:13 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:31:13 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 19:31:13 INFO - process_Request line: dromaeo_css 6822.39 graph.html#tests=[[72,63,43]] 19:31:13 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:31:13 INFO - process_Request line: kraken 1517.20 graph.html#tests=[[232,63,43]] 19:31:13 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:31:13 INFO - process_Request line: v8_7 20415.30 graph.html#tests=[[230,63,43]] 19:31:13 INFO - RETURN: dromaeo_css: 6822.39 19:31:13 INFO - RETURN: kraken: 1517.20 19:31:13 INFO - RETURN: v8_7: 20415.30 19:31:13 INFO - javascript benchmark 19:31:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3227.467467867802, 3227.999320210736, 3230.5477233187357, 3269.329787393583, 3277.737780977522, 5167.224916262553, 5256.92114618281, 5263.263143159956, 5265.657732247401, 5330.973345133269, 5251.5798736101115, 5268.841934741954, 5312.442193569668, 5325.920111198335, 5362.812301569436, 4840.975795121029, 4899.363082799231, 4950.133726597849, 4966.875828104308, 4976.452590215092, 4942.752862356886, 4958.528939750736, 4985.302057711923, 4989.75051247438, 5025.221090730943, 4768.260919557474, 4847.491013443573, 4866.0, 4893.314935908976, 4914.992426552548, 4848.612111031109, 4852.1508735971065, 4876.60987121033, 4898.21628539432, 4923.556879880828, 4842.878928026827, 4878.219484882437, 4879.902022045047, 4897.461279259279, 4912.631552633531, 5068.467810879842, 5124.231365295198, 5162.148245539482, 5181.093308670967, 5251.55361794248, 5646.6894320812335, 5718.513926316268, 5727.2268243787385, 5735.569832262597, 5748.5975981681295, 5775.075987841925, 5790.536757059467, 5791.942080579182, 5799.420057994209, 5808.88382232353, 5337.11937530307, 5357.571394288487, 5385.246065550826, 5386.865328366822, 5437.864053398696, 5870.0, 5870.119482077723, 5879.676617785977, 5896.764129434775, 5936.079907614327, 5657.094864821609, 5658.207850900877, 5660.716964151776, 5675.517581005578, 5684.857878552986, 5576.944230557724, 5655.293088363955, 5743.396943320975, 5752.856178595485, 5803.448672376117, 5691.544676425876, 5725.656460612377, 5727.31272247333, 5738.454846789548, 5767.875264323417, 5709.800156994568, 5714.171445140431, 5714.371419143891, 5719.084946408638, 5742.741576628978, 4357.477102747627, 4414.624756895636, 4420.071784925138, 4434.866953991385, 4449.9555004450185, 3937.2125574885135, 3949.3681011038097, 3968.8015599219925, 3990.082281075369, 4002.5797291284, 5321.760520776575, 5330.253764472977, 5366.597505187126, 5383.650062745909, 5412.07994640912, 5626.1842032905, 5674.460926212003, 5703.686297253691, 5708.657480551097, 5838.79564215259, 5341.839744807662, 5378.0, 5390.595705322116, 5416.21464887597, 5433.103537916279, 4951.90096198074, 4955.554000140005, 4960.925586116211, 4961.479044700327, 5019.171836646912, 5745.339285982165, 5868.413158684098, 5903.439173278532, 5924.170616113662, 5939.4357536034, 5706.714664266853, 5780.855478613068, 5783.248177736868, 5785.479306862402, 5786.797462088806, 5964.671943043174, 5968.731407086605, 5971.28344598651, 5974.551908606959, 5976.731047102978, 5498.80754173602, 5639.492445679908, 5684.658920464785, 5707.1724599933605, 5752.453516915886, 5724.284464441945, 5744.396838331915, 5776.480116789509, 5777.075667893285, 5780.306363236438, 5459.044667183148, 5611.943880561143, 5634.74643641029, 5636.943630563642, 5649.689267090185, 5544.584156188222, 5651.180578815966, 5677.176809362537, 5689.8862022758485, 5693.772249109989, 5478.753456094565, 5491.093969494988, 5529.4470552944385, 5542.2795036644975, 5554.944450555443, 5448.45515448452, 5504.614676972574, 5562.443755624405, 5569.053260945568, 5635.971820140873, 5528.336599608073, 5569.05326094573, 5570.610057296112, 5584.609077364546, 5599.076152434803], "unit": "score", "name": "dojo.html", "value": 5291.363442492957}, {"lowerIsBetter": false, "replicates": [539.3069905171855, 543.5352773378761, 561.2759540193151, 570.39538089625, 579.9565032622554, 35453.645463545356, 35881.64118358816, 36219.27561448769, 36348.0, 36502.45246321304, 40291.19417611646, 40616.18767624646, 40639.0, 40736.0, 41023.58976410235, 8457.53483558404, 8558.529280889548, 8589.656413743474, 8618.43980141292, 8640.913590864075, 8334.916650833506, 8493.405461617689, 8522.593772027609, 8638.049814520398, 8700.782480437976, 8739.563021848913, 8780.209781119698, 8787.824243515126, 8827.514486703229, 8860.0, 8611.224989750921, 8625.654973801009, 8658.956705216497, 8662.09048049952, 8685.131486851296, 8440.28257598105, 8630.568471576396, 8661.480311181349, 8669.263112635434, 8671.046184919654, 39266.60733392658, 39427.4085888709, 39483.21033579313, 39738.20523589541, 39819.40270895939, 2778.4165325281715, 2834.8157369770897, 2858.0, 2950.8081974671577, 3085.305806193611, 29755.256118597208, 30022.699773002427, 30392.69607303921, 30697.386052279053, 30765.846170769226, 3765.0, 3783.621637836222, 3819.1216020315205, 3844.807759612036, 3916.960830391688, 266901.0, 268312.0, 268520.0, 268702.0, 269039.0, 51370.22944655758, 53073.0, 57023.71488142533, 58525.122123168185, 59887.0, 54033.1895021575, 54133.0, 54138.72930635322, 54263.72868135634, 54275.45724542704, 14628.926855365868, 14771.482998095014, 14786.482473113389, 14823.407063717546, 14844.0, 11098.667039988813, 11146.331220126818, 11151.498182581803, 11207.495662695199, 11306.886931130748, 19072.684566757973, 19357.709634355495, 19444.416667499998, 19471.513212169808, 19560.728552644032, 7217.494775365779, 7393.51942123771, 7409.555426674417, 7429.33136017761, 7461.328480436679, 922.8569571716395, 931.5249222896372, 997.3567049253336, 1038.7039693687414, 1062.2458054781036, 28393.006244781332, 28524.144275671762, 28780.0, 28907.855460722563, 29118.417631647248, 1040.1834559870465, 1076.674383331999, 1090.7709381030072, 1114.7826173896174, 1155.2086820527966, 14917.776233356508, 15011.24943752808, 15052.32264548098, 15184.0, 15202.239888005555, 311101.0, 315314.0, 315955.0, 317132.0, 318161.0, 52097.47902521002, 52169.2174617381, 52348.47651523436, 52528.212076818876, 52552.47447525552, 1309.4042210794066, 1339.7923321885123, 1343.5633419138624, 1352.6280272925023, 1361.0880709924375, 27673.723262767115, 28599.71400286054, 28642.570361444177, 29033.0, 29250.268743281587, 45556.77221613871, 45785.77107114443, 45951.54048459473, 46066.76966615146, 46403.0, 312615.0, 313951.0, 316222.0, 316425.0, 317151.0, 29084.12747617575, 29811.55282670805, 31110.68889311078, 31533.369332613678, 31965.200869977507, 36389.09027274339, 36638.450423244205, 37163.442548362334, 37329.25341493209, 37408.0, 31995.0, 32077.839610801795, 32460.188495287806, 34397.65602343944, 35589.82205088958, 32327.35345293128, 32595.0, 34379.82810085933, 34868.302633947686, 35051.474227886094, 35182.12044698903, 35384.0, 35434.822825885705, 35443.11392215215, 35443.82278088593, 31300.217494562818, 31908.202294942814, 31966.36067278688, 32121.51817722689, 32137.184187654522, 24190.484736992174, 24441.877790611645, 24708.752912470645, 24723.381915452257, 24893.377665557782], "unit": "score", "name": "ext.html", "value": 18001.301854120127}, {"lowerIsBetter": false, "replicates": [362.0785101915625, 363.58732838228605, 367.14821613855867, 368.3958308374267, 376.68923138410815, 15592.376304947802, 16094.356225750971, 16625.99999999997, 17019.149042547884, 17400.303987840503, 10121.190304775619, 10336.586536538549, 14561.490347837827, 16533.586660333498, 16699.66600667989, 4900.166971614825, 4917.901641967159, 5386.78452861887, 5392.622516423852, 5396.217548455472, 5281.075811732951, 5345.33183352081, 5383.2732581101445, 5394.1908713693065, 5394.298741163643, 5329.120695085326, 5395.919061214085, 5422.810201642943, 5426.728663566825, 5437.8368648940595, 4841.346418233528, 4937.456879743261, 5315.043292207421, 5378.650387724805, 5403.108487099644, 4791.185498465235, 4803.543663351976, 4810.278458231258, 4820.39745031871, 4821.300911367867, 13001.0, 13365.732685346238, 18047.639047219112, 19711.408657740292, 19722.605547889107, 2029.725986991752, 2068.586282743442, 2081.323569839793, 2092.5605622819226, 2282.9498430721887, 5537.529310008654, 9747.756306092333, 10200.030997055268, 10263.640772572999, 13351.399187036606, 1787.4101546489628, 1793.883397579153, 1838.0442170071622, 1842.3551756885117, 1888.707250376194, 49501.75249123731, 52002.73998630021, 52397.73801131008, 52575.47424525782, 52988.47011529874, 9813.705588832347, 10131.64539241123, 10256.743581410525, 10298.948505257425, 10329.328593641389, 12687.682807929876, 13199.538016169388, 13247.072704910564, 13601.931990339985, 13634.727305454035, 7350.301721336465, 7515.248475152441, 7554.0, 7577.734779282809, 7594.544327340377, 7138.892916606255, 7153.427725781925, 7183.173934997438, 7234.819129521804, 7238.601876896716, 4409.933850992237, 4455.910881782346, 4471.821127154877, 4472.0608672179205, 4475.7985890634345, 1767.8674099442594, 1822.261983896524, 1865.1140708163514, 1870.6071724937644, 1893.1764682363216, 896.4934811831295, 956.3735753081743, 999.8650182225452, 1012.7265638277771, 1072.6353039966448, 16301.918490407472, 16404.343826246815, 16407.261673224733, 16709.6658066838, 16818.915905420396, 900.3157600223877, 903.2457897655399, 946.8958414574391, 965.7971825916636, 983.3018556824735, 9097.636094556143, 9258.398204116711, 9591.280653950982, 10075.294729368874, 10128.797424051478, 526271.0, 535011.0, 536558.0, 544839.0, 546980.0, 67325.0, 68098.31901681019, 69221.0, 70535.0, 71818.64090679513, 1121.5794077221042, 1144.7767685301453, 1146.7935771561033, 1146.850909381775, 1158.79141754485, 15045.774313385527, 15226.695466090838, 15233.542993710207, 15261.542153735405, 15390.84609153894, 29373.977576506655, 31550.36899262048, 32078.518822218153, 35126.47310290399, 35521.0, 39733.0, 40456.3931541033, 42183.78908105563, 42455.575444246395, 42620.57379426166, 7040.5071644984355, 7306.0, 7332.523385979895, 7415.1101867776215, 7539.434542409232, 8671.869921951049, 10643.254972151875, 10698.41158736277, 10897.400642964712, 11029.283096598696, 9406.717798466058, 9628.75928101803, 9682.612695492102, 9706.272029597949, 9732.902670973483, 9149.725508234764, 9213.124753148708, 9509.144177024102, 9756.268279878896, 9981.950090249502, 8932.910670893469, 9639.469829159463, 9696.5151742414, 9824.263180261367, 9929.3545919515, 6834.45324374039, 6907.551009184588, 6925.896111558432, 6955.930440695731, 7104.609246491286, 3075.86158622858, 3111.9688803112585, 7597.796638974635, 8174.264316211569, 9322.627094916128], "unit": "score", "name": "jquery.html", "value": 7928.979608952181}, {"lowerIsBetter": false, "replicates": [1464.1654257073467, 1470.8896832737546, 1619.4655763598007, 1745.424010076675, 1767.6906541355252, 6655.966720166404, 6826.863462730742, 7620.428467864905, 7789.72735954241, 7789.805254868631, 7294.927050729491, 7399.667014984325, 7477.14012888518, 7485.0, 7506.437017223703, 2227.187076716999, 2258.672492488588, 2269.4780200553882, 2277.7038984931937, 2289.9885500572473, 2266.8526545774553, 2285.0288627333316, 2286.4855407533255, 2288.473651060257, 2288.519410923708, 2220.3893929169444, 2235.541713948645, 2240.596692595332, 2272.7272727272752, 2277.601419751545, 2266.614675505152, 2269.5347453771938, 2270.8069814065825, 2271.9091236350528, 2283.098176220392, 2242.1703969531377, 2253.0874995626796, 2254.3913143451177, 2258.5934531784437, 2265.365697604673, 7662.1571627120975, 7679.539227646359, 7698.499597526143, 7706.344960678293, 7718.189590093071, 4708.105459962596, 4765.880852978668, 4789.137955168068, 4809.014152098812, 4839.903201935942, 2991.685872983349, 3030.6666266710645, 3049.4968330225706, 3071.339661972664, 3096.5200393938976, 960.812641534901, 969.2246203037541, 996.227923359395, 996.3374356053216, 1002.2232769603543, 10966.396848173346, 10980.231383803137, 10984.340939543654, 10995.395253261067, 11000.339979601169, 4346.456692913386, 4408.735475871458, 4461.219286624828, 4491.169133710208, 4532.796024178854, 9335.393199442015, 9342.48616326095, 9376.156145946898, 9383.108604682544, 9428.811423771485, 4786.0667169902235, 4799.424069111659, 4810.903781924412, 4841.080194762983, 4856.17445034345, 4010.498687664042, 4135.0, 4179.2477354076555, 4413.911721765547, 4417.9838637113, 3580.8925732228076, 3594.5866225383893, 3600.459931010317, 3600.855965761393, 3634.7092232621326, 1138.1293310617218, 1164.301419148521, 1166.416791604198, 1167.6263595649311, 1168.988310116888, 1093.9343639381664, 1096.13405409727, 1226.9693457495569, 1260.1808824264301, 1276.2789024201297, 7423.294786995227, 7438.293362130589, 7453.291937265951, 7470.738524151629, 7567.545947243183, 501.34324035512867, 506.7567567567588, 507.7359772918136, 511.4093222328217, 512.7410657617879, 5623.971880140655, 5628.493435590816, 5648.915266271009, 5676.0918253080135, 5703.116017017369, 9003.909960900439, 9414.764630884283, 9460.195883349854, 9519.428834269966, 9570.0, 9285.164335209864, 9342.159205671522, 9398.060193980547, 9463.621455141854, 9480.241580673668, 6964.79105626832, 7119.394851437686, 7186.209516953131, 7221.169565499929, 7231.5299505531975, 7203.387712044325, 7229.457790665616, 7319.0, 7321.853562928605, 7351.963240183765, 7906.841863162819, 8047.436679432383, 8173.0, 8180.918190818254, 8343.45767525109, 8263.091059983277, 8268.049174345027, 8277.420580559303, 8279.668813247403, 8343.833123337377, 7074.257202993612, 7121.9643901780155, 7299.087614048244, 7302.196758356683, 7316.414686825147, 7033.542819716702, 7080.362767350963, 7138.286171383028, 7142.642867856483, 7204.279572042754, 6784.966075169593, 6842.794716158523, 6912.965435172993, 6998.125234345707, 7050.823729406806, 6745.628990405575, 6830.829229269308, 6882.0, 6942.444604431533, 7007.7196912122945, 6908.378245957888, 6941.687624056828, 6987.6855541499735, 7030.824229394306, 7079.8938015930835, 6182.536309776695, 6201.379862013762, 6266.874662506633, 6284.528660350584, 6284.842878928063, 6344.175257216532, 6391.744330226925, 6422.710978005907, 6467.126937863328, 6478.5141114415665], "unit": "score", "name": "mootools.html", "value": 4379.259706653017}, {"lowerIsBetter": false, "replicates": [341.45196958880996, 345.9878904238352, 349.500214692989, 352.16712474996643, 353.48920809430365, 6166.753329866806, 6216.782412615559, 6259.906101408476, 6305.9595166797535, 6370.0, 6209.472194863442, 6238.781642642509, 6244.375562443754, 6271.4669253113425, 6281.874362512747, 4768.880777980561, 4772.117158325721, 4779.402574678165, 4784.497627749089, 4787.377640906686, 4784.952150478485, 4793.18515852306, 4793.712377257376, 4794.9760251198695, 4798.4241890973135, 4644.72131672099, 4708.976455117737, 4721.150192965265, 4724.322865382791, 4743.383360163191, 4716.137125835293, 4718.457377401608, 4718.646101542381, 4730.290456431529, 4756.405449318835, 4086.6117718816663, 4102.159057393227, 4104.958950410488, 4107.466029416187, 4116.794160292004, 5854.18041474194, 5880.235569375996, 5899.911501327483, 5906.586538942276, 5935.881282374328, 5407.702576358299, 5509.228707980886, 5532.225488431623, 5533.750981205815, 5534.948359811623, 6601.405873471411, 6604.3725846044545, 6610.975298828689, 6622.668866556653, 6624.93375066248, 4522.140793249272, 4525.86422407325, 4541.568550987651, 4547.545245475426, 4549.863504094882, 6713.295104014057, 6856.52004359695, 6934.237233904267, 6941.201761797458, 6944.236134025253, 4647.140279048387, 4647.721136731807, 4681.016986432887, 4687.648426368036, 4697.271922851964, 4716.080364328992, 4728.4798672146035, 4740.312654665055, 4750.358701575243, 4751.382320298339, 5456.836294911159, 5474.343078830566, 5479.17812328146, 5485.314335708036, 5513.062779327524, 6535.771248006297, 6646.26891041985, 6651.600903945779, 6655.334466553403, 6667.699953502104, 1637.1568642149302, 1661.3520726916513, 1676.3797394963942, 1676.5473322203181, 1684.3346877983372, 1089.9182561307775, 1091.612477570467, 1103.8178700514325, 1108.8336749487642, 1117.5473933057124, 6159.876802464015, 6169.167162433104, 6177.444030037318, 6189.81430557084, 6200.844978875564, 6703.0, 6726.058351830748, 6730.966345168341, 6749.122614060141, 6754.0881980931945, 6015.54883383748, 6098.32918378978, 6141.201643786279, 6143.539234557336, 6149.7847575334645, 3632.7820330780237, 3663.816809159531, 3671.192337685705, 3675.650813172744, 3681.9631803682155, 7070.611116388648, 7071.36357727807, 7088.362047415654, 7104.751333703295, 7108.040414544073, 6763.154605674291, 6869.725210991504, 6922.134733158356, 6924.203716572558, 6938.514303998772, 7064.399526040242, 7070.434365250768, 7072.398846098139, 7073.080499535027, 7082.3979961703835, 6680.231773346128, 6690.264070952288, 6708.563943343667, 6733.091032710521, 6775.525713200029, 6552.57408268461, 6629.337066293332, 6631.9388897776125, 6670.899936500859, 6682.164729408824, 6785.796426107225, 6794.3545363190415, 6815.079964204769, 6873.175218973755, 6886.449084073362, 4646.442426908792, 4646.465656449416, 4659.301104834167, 4660.1145782301255, 4680.0, 6658.833529161616, 6660.833479162866, 6737.191537015589, 6764.323567643393, 6922.5154239202775, 6707.463402927851, 6723.966380168068, 6732.629705366252, 6732.865342693217, 6737.494687898526, 6672.5329226953645, 6694.564853284521, 6698.330166983263, 6714.395704386433, 6724.865502690017, 6475.255345635313, 6582.473402127914, 6584.736610535525, 6588.209414870054, 6613.0, 6689.966550167218, 6713.56361836479, 6724.697388617622, 6745.527813053235, 6756.560823546453, 6546.901796472961, 6556.0, 6567.310432404529, 6570.145881035435, 6572.7042283098335], "unit": "score", "name": "prototype.html", "value": 4966.175079086626}, {"lowerIsBetter": false, "replicates": [775.8215610409609, 781.0978320040356, 781.3358645151621, 849.7875531117221, 858.9226969572737, 13127.868721312783, 13217.93391033046, 13285.136466129696, 13309.933450332746, 13407.463701451954, 10353.1717462603, 11267.774644507104, 11427.885721142786, 11525.250858694179, 11600.477978490968, 798.2735710503443, 811.253646645085, 811.4482152136545, 814.5927036481759, 815.2703330519182, 806.209914284002, 808.6441965535146, 810.5541951926447, 810.5866008335732, 812.6586833529932, 844.252836239929, 844.7465760271924, 845.4546817302836, 847.7160151349275, 847.8770578266148, 844.6494704697543, 845.8054647431095, 846.0439703135479, 847.4025811802665, 847.4322204123253, 617.0589850478057, 621.2265729167216, 623.3735096228262, 624.3382015064046, 624.7063879976404, 10882.836757448644, 10991.670249892515, 11000.944995274973, 11002.944985275102, 11063.170262230366, 10824.079953203987, 10905.83641245382, 10971.615993440191, 11136.276142050741, 11258.718532036683, 9309.813803723888, 9463.101005404476, 9523.952380238125, 9544.188743956773, 9629.951850240774, 3417.4532074868152, 3440.913977150566, 3499.422595271777, 3560.501529785832, 3580.5524309461316, 41063.384049239285, 42761.0, 42765.78617106895, 46043.0, 46243.53756462426, 9732.562034708455, 9843.310968232156, 9889.0, 9972.501374931224, 10206.642767503101, 17948.820511794715, 18156.909215453838, 18169.273229070688, 18236.36172733948, 18250.269989200548, 7254.093238345207, 7377.299156580117, 7521.962390188123, 7789.688412463552, 7873.370130389555, 4122.0, 4123.175364927027, 4158.812853421603, 4357.586029327209, 4397.934030989538, 2952.1881482592457, 3007.9548806767916, 3016.276093737531, 3020.6677265500775, 3028.348904985439, 555.8165805284247, 586.352080950552, 608.8203979825962, 609.0772479693268, 618.8607563298312, 594.7353427724621, 617.0867116667357, 621.3320680268729, 643.9356064393523, 652.1587152573222, 8300.128486508951, 8389.538575378412, 8462.407631465738, 8505.574721264036, 8560.101189375151, 649.7758273395671, 651.5374084400129, 653.1737352249409, 653.8275121912611, 657.2244751193542, 3991.1219531702977, 4002.8598999034893, 4054.39184122384, 4135.193637240769, 4173.624373806372, 54228.577142286245, 54378.728106359216, 54460.0, 54843.0, 57028.71485642628, 48432.515674843504, 48458.5154148454, 48575.75712121417, 48740.26889596659, 48905.5109448901, 47625.285620715025, 48695.269570956465, 49171.0, 49269.0, 49741.751291243316, 8884.73345799627, 8924.375293729376, 9066.410683305565, 9146.176844084064, 9157.633694652139, 34016.0, 34353.0, 34481.31037379188, 35082.0, 35180.47229291512, 47243.0, 47548.28677569908, 47701.0, 47732.7613361931, 48288.0, 9368.063193680577, 9431.858522122036, 9771.85342219853, 9961.161069095273, 11437.19939604253, 10368.637097701545, 11247.268927520012, 12172.939135304267, 12299.200551964093, 12682.429290682127, 10801.297915635458, 10876.619318323821, 10924.2899211551, 11034.724131896766, 11239.719007024889, 10798.71185156361, 10954.835677464685, 10971.286866353661, 11009.669709908716, 11039.116870650489, 10661.029594628202, 10843.783124337311, 10902.127829773757, 10930.344179349264, 10965.890341096807, 8816.647334106563, 8972.237359824489, 9002.819943601222, 9113.36206465541, 9329.73847933708, 8811.268725312297, 9574.808503830023, 9684.32209745311, 9766.121049105615, 9802.0], "unit": "score", "name": "yui.html", "value": 6138.617602304597}], "name": "dromaeo_css", "value": 6822.388046637434}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 107.0, 110.0, 110.0, 111.0, 124.0, 110.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [159.0, 137.0, 161.0, 185.0, 129.0, 151.0, 156.0, 130.0, 172.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 150.8}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 163.0, 163.0, 164.0, 162.0, 163.0, 166.0, 170.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 73.0, 75.0, 74.0, 153.0, 73.0, 73.0, 77.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 141.0, 95.0, 95.0, 96.0, 151.0, 95.0, 97.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 98.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 66.0, 58.0, 58.0, 59.0, 58.0, 60.0, 61.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 91.0, 83.0, 82.0, 84.0, 84.0, 86.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [117.0, 115.0, 124.0, 128.0, 119.0, 121.0, 124.0, 119.0, 119.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.1}, {"lowerIsBetter": true, "replicates": [144.0, 150.0, 149.0, 146.0, 147.0, 133.0, 144.0, 144.0, 147.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.8}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 71.0, 67.0, 66.0, 66.0, 67.0, 69.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1517.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.22408026755852], "unit": "score", "name": "Richards", "value": 211.10596}, {"lowerIsBetter": false, "replicates": [188.07598269700958], "unit": "score", "name": "DeltaBlue", "value": 351.549406}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [705.2186177715091], "unit": "score", "name": "Earley", "value": 945.0445340000002}, {"lowerIsBetter": false, "replicates": [12456.79012345679], "unit": "score", "name": "Boyer", "value": 53.501985133795806}, {"lowerIsBetter": false, "replicates": [42354.166666666664], "unit": "score", "name": "RegExp", "value": 21.508745696015737}, {"lowerIsBetter": false, "replicates": [562.6398210290828], "unit": "score", "name": "Splay", "value": 144.8368866799205}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20415.304189964663}]} 19:31:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20415.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1517.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6822.39"}}} 19:31:13 INFO - Return code: 0 19:31:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:31:13 INFO - # TBPL SUCCESS # 19:31:13 INFO - Running post-action listener: _resource_record_post_action 19:31:13 INFO - Running post-run listener: _resource_record_post_run 19:31:14 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 8192; Write bytes: 555257856; Read time: 116; Write time: 601612 19:31:14 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 243523584; Read time: 104; Write time: 281656 19:31:14 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311734272; Read time: 12; Write time: 319956 19:31:14 INFO - Running post-run listener: _upload_blobber_files 19:31:14 INFO - Blob upload gear active. 19:31:14 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:31:14 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:31:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:31:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:31:15 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:31:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:31:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:16 INFO - (blobuploader) - INFO - Done attempting. 19:31:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:31:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:31:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:17 INFO - (blobuploader) - INFO - Done attempting. 19:31:17 INFO - (blobuploader) - INFO - Iteration through files over. 19:31:17 INFO - Return code: 0 19:31:17 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:31:17 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:31:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd54eecc64f751274b8d40d7866a4c129216c9af54f20fd34a19ce75ac0e4e4ed4468a80304d0ca651995f2005d8cf1dad6ed28ceb48784e54b2f7f4457a89c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ca2d9ad884d399135fc525f50ced78e0d41ae1bd11b188e2cdea176be76dd9739db4a57b2cb5b71674690bc893c85d0047262e8068d8e71c66a9062498552be"} 19:31:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:31:17 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:31:17 INFO - Contents: 19:31:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd54eecc64f751274b8d40d7866a4c129216c9af54f20fd34a19ce75ac0e4e4ed4468a80304d0ca651995f2005d8cf1dad6ed28ceb48784e54b2f7f4457a89c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ca2d9ad884d399135fc525f50ced78e0d41ae1bd11b188e2cdea176be76dd9739db4a57b2cb5b71674690bc893c85d0047262e8068d8e71c66a9062498552be"} 19:31:17 INFO - Running post-run listener: copy_logs_to_upload_dir 19:31:17 INFO - Copying logs to upload dir... 19:31:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:31:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.139787 ========= master_lag: 17.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-21 19:31:34.001968) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 19:31:34.005601) ========= 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=14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd54eecc64f751274b8d40d7866a4c129216c9af54f20fd34a19ce75ac0e4e4ed4468a80304d0ca651995f2005d8cf1dad6ed28ceb48784e54b2f7f4457a89c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ca2d9ad884d399135fc525f50ced78e0d41ae1bd11b188e2cdea176be76dd9739db4a57b2cb5b71674690bc893c85d0047262e8068d8e71c66a9062498552be"} build_url:https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/MuyOV_6oSk6qAxQAEhcvYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd54eecc64f751274b8d40d7866a4c129216c9af54f20fd34a19ce75ac0e4e4ed4468a80304d0ca651995f2005d8cf1dad6ed28ceb48784e54b2f7f4457a89c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ca2d9ad884d399135fc525f50ced78e0d41ae1bd11b188e2cdea176be76dd9739db4a57b2cb5b71674690bc893c85d0047262e8068d8e71c66a9062498552be"}' ========= master_lag: 0.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 19:31:34.471651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 19:31:34.472005) ========= 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=14ef55db36f7623abb31b9cf000001d5-1453432202.932731-2012887121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 19:31:34.488425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 19:31:34.488747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 19:31:34.489060) ========= ========= Total master_lag: 17.74 =========