builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1453506638.29 results: success (0) buildid: 20160122133007 builduid: 4b7149eab4184a5db9e4cc9b16c043ec revision: 86d2d6d0500e9dcfec41b65b2cc1eac85e0abce9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.289256) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.289714) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.290040) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006493 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.327509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.327881) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.386210) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.386565) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.448481) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.448814) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.449234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.449552) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 15:50:38-- 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% 78.2M=0s 2016-01-22 15:50:38 (78.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165454 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.636017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.636406) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017690 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.696110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:38.696476) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 86d2d6d0500e9dcfec41b65b2cc1eac85e0abce9 --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 86d2d6d0500e9dcfec41b65b2cc1eac85e0abce9 --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=8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 15:50:38,994 truncating revision to first 12 chars 2016-01-22 15:50:38,994 Setting DEBUG logging. 2016-01-22 15:50:38,994 attempt 1/10 2016-01-22 15:50:38,994 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/86d2d6d0500e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 15:50:39,549 unpacking tar archive at: mozilla-inbound-86d2d6d0500e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.864050 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:39.588162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:39.588507) ========= echo 86d2d6d0500e9dcfec41b65b2cc1eac85e0abce9 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'86d2d6d0500e9dcfec41b65b2cc1eac85e0abce9'] 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=8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 86d2d6d0500e9dcfec41b65b2cc1eac85e0abce9 program finished with exit code 0 elapsedTime=0.004281 script_repo_revision: '86d2d6d0500e9dcfec41b65b2cc1eac85e0abce9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:39.638381) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:39.638725) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 15:50:39.655998) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-22 15:50:39.656325) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:40 INFO - MultiFileLogger online at 20160122 15:50:40 in /builds/slave/test-pgo 15:50:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:50:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:50:40 INFO - {'append_to_log': False, 15:50:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:50:40 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:50:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:50:40 INFO - 'branch': 'Mozilla-Inbound', 15:50:40 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:40 INFO - 'config_files': ('talos/linux_config.py',), 15:50:40 INFO - 'default_actions': ('clobber', 15:50:40 INFO - 'read-buildbot-config', 15:50:40 INFO - 'download-and-extract', 15:50:40 INFO - 'populate-webroot', 15:50:40 INFO - 'create-virtualenv', 15:50:40 INFO - 'install', 15:50:40 INFO - 'run-tests'), 15:50:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:40 INFO - 'download_minidump_stackwalk': True, 15:50:40 INFO - 'download_symbols': 'ondemand', 15:50:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:40 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:40 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:40 INFO - 'installer_path': 'installer.exe', 15:50:40 INFO - 'log_level': 'info', 15:50:40 INFO - 'log_name': 'talos', 15:50:40 INFO - 'log_to_console': True, 15:50:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:40 INFO - 'opt_config_files': (), 15:50:40 INFO - 'pip_index': False, 15:50:40 INFO - 'sps_profile': False, 15:50:40 INFO - 'sps_profile_interval': 0, 15:50:40 INFO - 'suite': 'dromaeojs', 15:50:40 INFO - 'system_bits': '32', 15:50:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:40 INFO - 'title': 'talos-linux64-ix-001', 15:50:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:40 INFO - 'use_talos_json': True, 15:50:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:50:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:40 INFO - 'work_dir': 'build'} 15:50:40 INFO - ##### 15:50:40 INFO - ##### Running clobber step. 15:50:40 INFO - ##### 15:50:40 INFO - Running pre-action listener: _resource_record_pre_action 15:50:40 INFO - Running main action method: clobber 15:50:40 INFO - rmtree: /builds/slave/test-pgo/build 15:50:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:50:40 INFO - Running post-action listener: _resource_record_post_action 15:50:40 INFO - ##### 15:50:40 INFO - ##### Running read-buildbot-config step. 15:50:40 INFO - ##### 15:50:40 INFO - Running pre-action listener: _resource_record_pre_action 15:50:40 INFO - Running main action method: read_buildbot_config 15:50:40 INFO - Using buildbot properties: 15:50:40 INFO - { 15:50:40 INFO - "project": "", 15:50:40 INFO - "product": "firefox", 15:50:40 INFO - "script_repo_revision": "production", 15:50:40 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:50:40 INFO - "repository": "", 15:50:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:50:40 INFO - "buildid": "20160122133007", 15:50:40 INFO - "pgo_build": "True", 15:50:40 INFO - "basedir": "/builds/slave/test-pgo", 15:50:40 INFO - "buildnumber": 1456, 15:50:40 INFO - "slavename": "talos-linux64-ix-001", 15:50:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:50:40 INFO - "platform": "ubuntu64_hw", 15:50:40 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:50:40 INFO - "branch": "mozilla-inbound", 15:50:40 INFO - "repo_path": "integration/mozilla-inbound", 15:50:40 INFO - "revision": "86d2d6d0500e9dcfec41b65b2cc1eac85e0abce9", 15:50:40 INFO - "stage_platform": "linux64-pgo", 15:50:40 INFO - "builduid": "4b7149eab4184a5db9e4cc9b16c043ec", 15:50:40 INFO - "slavebuilddir": "test" 15:50:40 INFO - } 15:50:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:50:40 INFO - Running post-action listener: _resource_record_post_action 15:50:40 INFO - ##### 15:50:40 INFO - ##### Running download-and-extract step. 15:50:40 INFO - ##### 15:50:40 INFO - Running pre-action listener: _resource_record_pre_action 15:50:40 INFO - Running main action method: download_and_extract 15:50:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:50: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')]} 15:50:40 INFO - https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:50:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/test_packages.json 15:50:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/test_packages.json 15:50:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:50:43 INFO - Downloaded 1448 bytes. 15:50:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:50:43 INFO - Using the following test package requirements: 15:50:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:50:43 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:50:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:43 INFO - u'jsshell-linux-x86_64.zip'], 15:50:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:50:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:50:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:50:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:50:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:50:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:50:43 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')]} 15:50:43 INFO - https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/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 15:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/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 15:50:46 INFO - Downloaded 22490283 bytes. 15:50:46 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'] 15:50:46 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 15:50:47 INFO - Return code: 0 15:50:47 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 15:50:47 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')]} 15:50:47 INFO - https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:50:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:50:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/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 15:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/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 15:50:49 INFO - Downloaded 22490283 bytes. 15:50:49 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'] 15:50:49 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 15:50:50 INFO - Return code: 0 15:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:50 INFO - https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:50:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:50:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:50:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/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 15:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/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 15:50:52 INFO - Downloaded 10706572 bytes. 15:50:52 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'] 15:50:52 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 15:50:52 INFO - Return code: 0 15:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:52 INFO - https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:50:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:50:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:50:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/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 15:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/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 15:50:53 INFO - Downloaded 55937876 bytes. 15:50:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:50:53 INFO - mkdir: /builds/slave/test-pgo/properties 15:50:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:50:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:50:53 INFO - Contents: 15:50:53 INFO - build_url:https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:50:53 INFO - Running post-action listener: _resource_record_post_action 15:50:53 INFO - Running post-action listener: set_extra_try_arguments 15:50:53 INFO - ##### 15:50:53 INFO - ##### Running populate-webroot step. 15:50:53 INFO - ##### 15:50:53 INFO - Running pre-action listener: _resource_record_pre_action 15:50:53 INFO - Running main action method: populate_webroot 15:50:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:50:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:50:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:50:53 INFO - '--tppagecycles', 15:50:53 INFO - '7'], 15:50:53 INFO - 'tests': ['tsvgm']}}, 15:50:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:50:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:50:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:50:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:50:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:50:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:50:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:53 INFO - 'talos_options': ['--e10s'], 15:50:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:53 INFO - 'tests': ['damp', 'tps']}, 15:50:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:53 INFO - 'talos_options': ['--e10s'], 15:50:53 INFO - 'tests': ['damp', 'tps']}, 15:50:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:50:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:50:53 INFO - 'other': {'tests': ['a11yr', 15:50:53 INFO - 'ts_paint', 15:50:53 INFO - 'tpaint', 15:50:53 INFO - 'sessionrestore', 15:50:53 INFO - 'sessionrestore_no_auto_restore']}, 15:50:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:50:53 INFO - 'tests': ['a11yr', 15:50:53 INFO - 'ts_paint', 15:50:53 INFO - 'tpaint', 15:50:53 INFO - 'sessionrestore', 15:50:53 INFO - 'sessionrestore_no_auto_restore']}, 15:50:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:50:53 INFO - 'tests': ['a11yr', 15:50:53 INFO - 'ts_paint', 15:50:53 INFO - 'tpaint', 15:50:53 INFO - 'sessionrestore', 15:50:53 INFO - 'sessionrestore_no_auto_restore']}, 15:50:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:50:53 INFO - 'tests': ['a11yr', 15:50:53 INFO - 'ts_paint', 15:50:53 INFO - 'tpaint', 15:50:53 INFO - 'sessionrestore', 15:50:53 INFO - 'sessionrestore_no_auto_restore']}, 15:50:53 INFO - 'other_l64': {'tests': ['a11yr', 15:50:53 INFO - 'ts_paint', 15:50:53 INFO - 'tpaint', 15:50:53 INFO - 'sessionrestore', 15:50:53 INFO - 'sessionrestore_no_auto_restore']}, 15:50:53 INFO - 'other_nol64': {'tests': ['a11yr', 15:50:53 INFO - 'ts_paint', 15:50:53 INFO - 'tpaint', 15:50:53 INFO - 'sessionrestore', 15:50:53 INFO - 'sessionrestore_no_auto_restore']}, 15:50:53 INFO - 'svgr': {'tests': ['tsvgx', 15:50:53 INFO - 'tsvgr_opacity', 15:50:53 INFO - 'tart', 15:50:53 INFO - 'tscrollx', 15:50:53 INFO - 'cart']}, 15:50:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:50:53 INFO - 'tests': ['tsvgx', 15:50:53 INFO - 'tsvgr_opacity', 15:50:53 INFO - 'tart', 15:50:53 INFO - 'tscrollx', 15:50:53 INFO - 'cart']}, 15:50:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:53 INFO - 'tests': ['tp5o']}, 15:50:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:53 INFO - 'talos_options': ['--e10s'], 15:50:53 INFO - 'tests': ['tp5o']}, 15:50:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:53 INFO - 'talos_options': ['--xperf_path', 15:50:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:53 INFO - 'tests': ['tp5n']}, 15:50:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:53 INFO - 'talos_options': ['--e10s', 15:50:53 INFO - '--xperf_path', 15:50:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:53 INFO - 'tests': ['tp5n']}}, 15:50:53 INFO - 'talos.zip': {'path': '', 15:50:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:50:53 INFO - Running post-action listener: _resource_record_post_action 15:50:53 INFO - ##### 15:50:53 INFO - ##### Running create-virtualenv step. 15:50:53 INFO - ##### 15:50:53 INFO - Running pre-action listener: _resource_record_pre_action 15:50:53 INFO - Running main action method: create_virtualenv 15:50:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:50:53 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 15:50:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:50:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:50:53 INFO - Using real prefix '/usr' 15:50:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:50:54 INFO - Installing distribute.............................................................................................................................................................................................done. 15:50:56 INFO - Installing pip.................done. 15:50:56 INFO - Return code: 0 15:50:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:56 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 0x7f187e3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb07f0>, '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 0x2c1c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c760>, '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': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', '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 15:50:56 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 15:50:56 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 15:50:56 INFO - Using env: {'DISPLAY': ':0', 15:50:56 INFO - 'HOME': '/home/cltbld', 15:50:56 INFO - 'LANG': 'en_US.UTF-8', 15:50:56 INFO - 'LANGUAGE': 'en_US:en', 15:50:56 INFO - 'LOGNAME': 'cltbld', 15:50:56 INFO - 'MAIL': '/var/mail/cltbld', 15:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:56 INFO - 'MOZ_NO_REMOTE': '1', 15:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:56 INFO - 'NO_EM_RESTART': '1', 15:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:50:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:50:56 INFO - 'SHELL': '/bin/bash', 15:50:56 INFO - 'SHLVL': '1', 15:50:56 INFO - 'TERM': 'linux', 15:50:56 INFO - 'TMOUT': '86400', 15:50:56 INFO - 'USER': 'cltbld', 15:50:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', 15:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:56 INFO - '_': '/tools/buildbot/bin/python'} 15:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:56 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 15:50:56 INFO - Cleaning up... 15:50:56 INFO - Return code: 0 15:50:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:56 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 0x7f187e3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb07f0>, '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 0x2c1c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c760>, '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': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', '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 15:50:56 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 15:50:56 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 15:50:56 INFO - Using env: {'DISPLAY': ':0', 15:50:56 INFO - 'HOME': '/home/cltbld', 15:50:56 INFO - 'LANG': 'en_US.UTF-8', 15:50:56 INFO - 'LANGUAGE': 'en_US:en', 15:50:56 INFO - 'LOGNAME': 'cltbld', 15:50:56 INFO - 'MAIL': '/var/mail/cltbld', 15:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:56 INFO - 'MOZ_NO_REMOTE': '1', 15:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:56 INFO - 'NO_EM_RESTART': '1', 15:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:50:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:50:56 INFO - 'SHELL': '/bin/bash', 15:50:56 INFO - 'SHLVL': '1', 15:50:56 INFO - 'TERM': 'linux', 15:50:56 INFO - 'TMOUT': '86400', 15:50:56 INFO - 'USER': 'cltbld', 15:50:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', 15:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:56 INFO - '_': '/tools/buildbot/bin/python'} 15:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:56 INFO - Downloading/unpacking psutil>=0.7.1 15:50:56 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 15:50:56 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 15:50:56 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 15:50:56 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 15:50:56 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 15:50:56 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 15:50:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:50:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:58 INFO - Installing collected packages: psutil 15:50:58 INFO - Running setup.py install for psutil 15:50:58 INFO - building 'psutil._psutil_linux' extension 15:50:58 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 15:50:58 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 15:50:58 INFO - building 'psutil._psutil_posix' extension 15:50:58 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 15:50:59 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 15:50:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:59 INFO - Successfully installed psutil 15:50:59 INFO - Cleaning up... 15:50:59 INFO - Return code: 0 15:50:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:50: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')]} 15:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:59 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 0x7f187e3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb07f0>, '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 0x2c1c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c760>, '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': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', '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 15:50:59 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 15:50:59 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 15:50:59 INFO - Using env: {'DISPLAY': ':0', 15:50:59 INFO - 'HOME': '/home/cltbld', 15:50:59 INFO - 'LANG': 'en_US.UTF-8', 15:50:59 INFO - 'LANGUAGE': 'en_US:en', 15:50:59 INFO - 'LOGNAME': 'cltbld', 15:50:59 INFO - 'MAIL': '/var/mail/cltbld', 15:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:59 INFO - 'MOZ_NO_REMOTE': '1', 15:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:59 INFO - 'NO_EM_RESTART': '1', 15:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:50:59 INFO - 'PWD': '/builds/slave/test-pgo', 15:50:59 INFO - 'SHELL': '/bin/bash', 15:50:59 INFO - 'SHLVL': '1', 15:50:59 INFO - 'TERM': 'linux', 15:50:59 INFO - 'TMOUT': '86400', 15:50:59 INFO - 'USER': 'cltbld', 15:50:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', 15:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:59 INFO - '_': '/tools/buildbot/bin/python'} 15:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:50:59 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 15:50:59 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 15:50:59 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 15:50:59 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 15:50:59 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 15:50:59 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 15:51:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:51:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:51:01 INFO - Installing collected packages: mozsystemmonitor 15:51:01 INFO - Running setup.py install for mozsystemmonitor 15:51:01 INFO - Successfully installed mozsystemmonitor 15:51:01 INFO - Cleaning up... 15:51:01 INFO - Return code: 0 15:51:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:01 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 0x7f187e3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb07f0>, '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 0x2c1c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c760>, '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': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', '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 15:51:01 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 15:51:01 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 15:51:01 INFO - Using env: {'DISPLAY': ':0', 15:51:01 INFO - 'HOME': '/home/cltbld', 15:51:01 INFO - 'LANG': 'en_US.UTF-8', 15:51:01 INFO - 'LANGUAGE': 'en_US:en', 15:51:01 INFO - 'LOGNAME': 'cltbld', 15:51:01 INFO - 'MAIL': '/var/mail/cltbld', 15:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:01 INFO - 'MOZ_NO_REMOTE': '1', 15:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:01 INFO - 'NO_EM_RESTART': '1', 15:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:01 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:01 INFO - 'SHELL': '/bin/bash', 15:51:01 INFO - 'SHLVL': '1', 15:51:01 INFO - 'TERM': 'linux', 15:51:01 INFO - 'TMOUT': '86400', 15:51:01 INFO - 'USER': 'cltbld', 15:51:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', 15:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:01 INFO - '_': '/tools/buildbot/bin/python'} 15:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:01 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:01 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 15:51:01 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 15:51:01 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 15:51:01 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 15:51:01 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 15:51:01 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 15:51:03 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:51:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:04 INFO - Downloading docopt-0.6.1.tar.gz 15:51:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:04 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:04 INFO - Running setup.py install for blobuploader 15:51:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:51:04 INFO - Running setup.py install for requests 15:51:04 INFO - Running setup.py install for docopt 15:51:04 INFO - Successfully installed blobuploader requests docopt 15:51:04 INFO - Cleaning up... 15:51:04 INFO - Return code: 0 15:51:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:04 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 0x7f187e3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb07f0>, '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 0x2c1c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c760>, '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': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', '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 15:51:04 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 15:51:04 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 15:51:04 INFO - Using env: {'DISPLAY': ':0', 15:51:04 INFO - 'HOME': '/home/cltbld', 15:51:04 INFO - 'LANG': 'en_US.UTF-8', 15:51:04 INFO - 'LANGUAGE': 'en_US:en', 15:51:04 INFO - 'LOGNAME': 'cltbld', 15:51:04 INFO - 'MAIL': '/var/mail/cltbld', 15:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:04 INFO - 'MOZ_NO_REMOTE': '1', 15:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:04 INFO - 'NO_EM_RESTART': '1', 15:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:04 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:04 INFO - 'SHELL': '/bin/bash', 15:51:04 INFO - 'SHLVL': '1', 15:51:04 INFO - 'TERM': 'linux', 15:51:04 INFO - 'TMOUT': '86400', 15:51:04 INFO - 'USER': 'cltbld', 15:51:04 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', 15:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:04 INFO - '_': '/tools/buildbot/bin/python'} 15:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:51:04 INFO - Running setup.py (path:/tmp/pip-AOnjSt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:51:05 INFO - Running setup.py (path:/tmp/pip-WzYSKg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:51:05 INFO - Running setup.py (path:/tmp/pip-oboPaw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:51:05 INFO - Running setup.py (path:/tmp/pip-vWLaIM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:51:05 INFO - Running setup.py (path:/tmp/pip-v1YWdG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:51:05 INFO - Running setup.py (path:/tmp/pip-kgkBof-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:51:05 INFO - Running setup.py (path:/tmp/pip-M4oduu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:51:05 INFO - Running setup.py (path:/tmp/pip-GjRmRO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:51:05 INFO - Running setup.py (path:/tmp/pip-slLl2O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:51:05 INFO - Running setup.py (path:/tmp/pip-yNBrZT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:51:05 INFO - Running setup.py (path:/tmp/pip-1HKkQP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:51:05 INFO - Running setup.py (path:/tmp/pip-wSmSq2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:51:05 INFO - Running setup.py (path:/tmp/pip-1F1Hi2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:51:05 INFO - Running setup.py (path:/tmp/pip-t4Ml8K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:51:05 INFO - Running setup.py (path:/tmp/pip-JRTLWw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:51:06 INFO - Running setup.py (path:/tmp/pip-InEb0X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:51:06 INFO - Running setup.py (path:/tmp/pip-8fcjYg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:51:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:06 INFO - Running setup.py install for manifestparser 15:51:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:51:06 INFO - Running setup.py install for mozcrash 15:51:06 INFO - Running setup.py install for mozdebug 15:51:06 INFO - Running setup.py install for mozdevice 15:51:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:51:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:51:06 INFO - Running setup.py install for mozfile 15:51:06 INFO - Running setup.py install for mozhttpd 15:51:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:51:06 INFO - Running setup.py install for mozinfo 15:51:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:51:06 INFO - Running setup.py install for mozInstall 15:51:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:51:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:51:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:51:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:51:06 INFO - Running setup.py install for mozleak 15:51:07 INFO - Running setup.py install for mozlog 15:51:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:51:07 INFO - Running setup.py install for moznetwork 15:51:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:51:07 INFO - Running setup.py install for mozprocess 15:51:07 INFO - Running setup.py install for mozprofile 15:51:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:51:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:51:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:51:07 INFO - Running setup.py install for mozrunner 15:51:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:51:07 INFO - Running setup.py install for mozscreenshot 15:51:07 INFO - Running setup.py install for moztest 15:51:07 INFO - Running setup.py install for mozversion 15:51:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:51:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:07 INFO - Cleaning up... 15:51:07 INFO - Return code: 0 15:51:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:07 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 0x7f187e3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb07f0>, '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 0x2c1c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c760>, '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': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', '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 15:51:07 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 15:51:07 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 15:51:07 INFO - Using env: {'DISPLAY': ':0', 15:51:07 INFO - 'HOME': '/home/cltbld', 15:51:07 INFO - 'LANG': 'en_US.UTF-8', 15:51:07 INFO - 'LANGUAGE': 'en_US:en', 15:51:07 INFO - 'LOGNAME': 'cltbld', 15:51:07 INFO - 'MAIL': '/var/mail/cltbld', 15:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:07 INFO - 'MOZ_NO_REMOTE': '1', 15:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:07 INFO - 'NO_EM_RESTART': '1', 15:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:07 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:07 INFO - 'SHELL': '/bin/bash', 15:51:07 INFO - 'SHLVL': '1', 15:51:07 INFO - 'TERM': 'linux', 15:51:07 INFO - 'TMOUT': '86400', 15:51:07 INFO - 'USER': 'cltbld', 15:51:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', 15:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:07 INFO - '_': '/tools/buildbot/bin/python'} 15:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:51:08 INFO - Running setup.py (path:/tmp/pip-3w1dJI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:51:08 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)) 15:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:51:08 INFO - Running setup.py (path:/tmp/pip-Hh1UmU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:51:08 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)) 15:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:51:08 INFO - Running setup.py (path:/tmp/pip-xOQkqQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:51:08 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)) 15:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:51:08 INFO - Running setup.py (path:/tmp/pip-H7RoM2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:51:08 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)) 15:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:51:08 INFO - Running setup.py (path:/tmp/pip-eWwjRb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:51:08 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)) 15:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:51:08 INFO - Running setup.py (path:/tmp/pip-TltseD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:51:08 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)) 15:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:51:08 INFO - Running setup.py (path:/tmp/pip-dm526F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:51:08 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)) 15:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:51:08 INFO - Running setup.py (path:/tmp/pip-DZ_bBY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:51:08 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)) 15:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:51:08 INFO - Running setup.py (path:/tmp/pip-v1TuJg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:51:08 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)) 15:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:51:08 INFO - Running setup.py (path:/tmp/pip-pITATO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:51:08 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)) 15:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:51:08 INFO - Running setup.py (path:/tmp/pip-jm6POQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:51:08 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)) 15:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:51:08 INFO - Running setup.py (path:/tmp/pip-mWtL6r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:51:09 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)) 15:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:51:09 INFO - Running setup.py (path:/tmp/pip-9mQI2x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:51:09 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)) 15:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:51:09 INFO - Running setup.py (path:/tmp/pip-422fzt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:51:09 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)) 15:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:51:09 INFO - Running setup.py (path:/tmp/pip-EwuYrS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:51:09 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)) 15:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:51:09 INFO - Running setup.py (path:/tmp/pip-hpSBvA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:51:09 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)) 15:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:51:09 INFO - Running setup.py (path:/tmp/pip-YY1wJB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:51:09 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)) 15:51:09 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)) 15:51:09 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)) 15:51:09 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)) 15:51:09 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)) 15:51:09 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)) 15:51:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:11 INFO - Downloading blessings-1.6.tar.gz 15:51:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:11 INFO - Installing collected packages: blessings 15:51:11 INFO - Running setup.py install for blessings 15:51:11 INFO - Successfully installed blessings 15:51:11 INFO - Cleaning up... 15:51:11 INFO - Return code: 0 15:51:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:51:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:51:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:51:11 INFO - Reading from file tmpfile_stdout 15:51:11 INFO - Current package versions: 15:51:11 INFO - argparse == 1.2.1 15:51:11 INFO - blessings == 1.6 15:51:11 INFO - blobuploader == 1.2.4 15:51:11 INFO - docopt == 0.6.1 15:51:11 INFO - manifestparser == 1.1 15:51:11 INFO - mozInstall == 1.12 15:51:11 INFO - mozcrash == 0.16 15:51:11 INFO - mozdebug == 0.1 15:51:11 INFO - mozdevice == 0.48 15:51:11 INFO - mozfile == 1.2 15:51:11 INFO - mozhttpd == 0.7 15:51:11 INFO - mozinfo == 0.9 15:51:11 INFO - mozleak == 0.1 15:51:11 INFO - mozlog == 3.1 15:51:11 INFO - moznetwork == 0.27 15:51:11 INFO - mozprocess == 0.22 15:51:11 INFO - mozprofile == 0.28 15:51:11 INFO - mozrunner == 6.11 15:51:11 INFO - mozscreenshot == 0.1 15:51:11 INFO - mozsystemmonitor == 0.0 15:51:11 INFO - moztest == 0.7 15:51:11 INFO - mozversion == 1.4 15:51:11 INFO - psutil == 3.1.1 15:51:11 INFO - requests == 1.2.3 15:51:11 INFO - wsgiref == 0.1.2 15:51:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:51: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')]} 15:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:11 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 0x7f187e3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb07f0>, '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 0x2c1c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c760>, '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': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', '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 15:51:11 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 15:51:11 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 15:51:11 INFO - Using env: {'DISPLAY': ':0', 15:51:11 INFO - 'HOME': '/home/cltbld', 15:51:11 INFO - 'LANG': 'en_US.UTF-8', 15:51:11 INFO - 'LANGUAGE': 'en_US:en', 15:51:11 INFO - 'LOGNAME': 'cltbld', 15:51:11 INFO - 'MAIL': '/var/mail/cltbld', 15:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:11 INFO - 'MOZ_NO_REMOTE': '1', 15:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:11 INFO - 'NO_EM_RESTART': '1', 15:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:11 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:11 INFO - 'SHELL': '/bin/bash', 15:51:11 INFO - 'SHLVL': '1', 15:51:11 INFO - 'TERM': 'linux', 15:51:11 INFO - 'TMOUT': '86400', 15:51:11 INFO - 'USER': 'cltbld', 15:51:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', 15:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:11 INFO - '_': '/tools/buildbot/bin/python'} 15:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:11 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)) 15:51:11 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)) 15:51:11 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)) 15:51:11 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)) 15:51:11 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)) 15:51:11 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)) 15:51:11 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)) 15:51:11 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)) 15:51:11 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)) 15:51:11 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)) 15:51:11 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)) 15:51:11 INFO - Cleaning up... 15:51:11 INFO - Return code: 0 15:51:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:51: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')]} 15:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:11 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 0x7f187e3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb07f0>, '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 0x2c1c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c760>, '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': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', '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 15:51:11 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 15:51:11 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 15:51:11 INFO - Using env: {'DISPLAY': ':0', 15:51:11 INFO - 'HOME': '/home/cltbld', 15:51:11 INFO - 'LANG': 'en_US.UTF-8', 15:51:11 INFO - 'LANGUAGE': 'en_US:en', 15:51:11 INFO - 'LOGNAME': 'cltbld', 15:51:11 INFO - 'MAIL': '/var/mail/cltbld', 15:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:11 INFO - 'MOZ_NO_REMOTE': '1', 15:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:11 INFO - 'NO_EM_RESTART': '1', 15:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:11 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:11 INFO - 'SHELL': '/bin/bash', 15:51:11 INFO - 'SHLVL': '1', 15:51:11 INFO - 'TERM': 'linux', 15:51:11 INFO - 'TMOUT': '86400', 15:51:11 INFO - 'USER': 'cltbld', 15:51:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', 15:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:11 INFO - '_': '/tools/buildbot/bin/python'} 15:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:12 INFO - Downloading/unpacking jsonschema 15:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:13 INFO - Downloading/unpacking functools32 (from jsonschema) 15:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:14 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:14 INFO - warning: no files found matching '*.txt' 15:51:14 INFO - no previously-included directories found matching 'build' 15:51:14 INFO - no previously-included directories found matching 'dist' 15:51:14 INFO - no previously-included directories found matching '.git*' 15:51:14 INFO - Installing collected packages: jsonschema, functools32 15:51:14 INFO - Running setup.py install for functools32 15:51:14 INFO - warning: no files found matching '*.txt' 15:51:14 INFO - no previously-included directories found matching 'build' 15:51:14 INFO - no previously-included directories found matching 'dist' 15:51:14 INFO - no previously-included directories found matching '.git*' 15:51:14 INFO - Successfully installed jsonschema functools32 15:51:14 INFO - Cleaning up... 15:51:14 INFO - Return code: 0 15:51:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:51: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')]} 15:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:14 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 0x7f187e3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb07f0>, '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 0x2c1c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c760>, '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': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', '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 15:51:14 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 15:51:14 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 15:51:14 INFO - Using env: {'DISPLAY': ':0', 15:51:14 INFO - 'HOME': '/home/cltbld', 15:51:14 INFO - 'LANG': 'en_US.UTF-8', 15:51:14 INFO - 'LANGUAGE': 'en_US:en', 15:51:14 INFO - 'LOGNAME': 'cltbld', 15:51:14 INFO - 'MAIL': '/var/mail/cltbld', 15:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:14 INFO - 'MOZ_NO_REMOTE': '1', 15:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:14 INFO - 'NO_EM_RESTART': '1', 15:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:14 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:14 INFO - 'SHELL': '/bin/bash', 15:51:14 INFO - 'SHLVL': '1', 15:51:14 INFO - 'TERM': 'linux', 15:51:14 INFO - 'TMOUT': '86400', 15:51:14 INFO - 'USER': 'cltbld', 15:51:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', 15:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:14 INFO - '_': '/tools/buildbot/bin/python'} 15:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:14 INFO - Downloading/unpacking flake8 15:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:51:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:51:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:16 INFO - no previously-included directories found matching 'docs/_build' 15:51:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:51:17 INFO - Running setup.py install for pep8 15:51:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:17 INFO - no previously-included directories found matching 'docs/_build' 15:51:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:51:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:51:17 INFO - Cleaning up... 15:51:17 INFO - Return code: 0 15:51:17 INFO - Running post-action listener: _resource_record_post_action 15:51:17 INFO - Running post-action listener: _start_resource_monitoring 15:51:17 INFO - Starting resource monitoring. 15:51:17 INFO - ##### 15:51:17 INFO - ##### Running install step. 15:51:17 INFO - ##### 15:51:17 INFO - Running pre-action listener: _resource_record_pre_action 15:51:17 INFO - Running main action method: install 15:51:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:51:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:51:17 INFO - Reading from file tmpfile_stdout 15:51:17 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:51:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:51:17 INFO - Reading from file tmpfile_stdout 15:51:17 INFO - Output received: 15:51:17 INFO - Usage: mozinstall [options] installer 15:51:17 INFO - Options: 15:51:17 INFO - -h, --help show this help message and exit 15:51:17 INFO - -d DEST, --destination=DEST 15:51:17 INFO - Directory to install application into. [default: 15:51:17 INFO - "/builds/slave/test-pgo"] 15:51:17 INFO - --app=APP Application being installed. [default: firefox] 15:51:17 INFO - mkdir: /builds/slave/test-pgo/build/application 15:51:17 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'] 15:51:17 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 15:51:33 INFO - Reading from file tmpfile_stdout 15:51:33 INFO - Output received: 15:51:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:51:33 INFO - Running post-action listener: _resource_record_post_action 15:51:33 INFO - ##### 15:51:33 INFO - ##### Running run-tests step. 15:51:33 INFO - ##### 15:51:33 INFO - Running pre-action listener: _resource_record_pre_action 15:51:33 INFO - Running main action method: run_tests 15:51:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:51:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:51:33 INFO - Python 2.7.3 15:51:33 INFO - Return code: 0 15:51:33 INFO - grabbing minidump binary from tooltool 15:51:33 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')]} 15:51:33 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 0x2cb07f0>, '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 0x2c1c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:51:33 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 15:51:33 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 15:51:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:33 INFO - Return code: 0 15:51:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:51:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:51:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:51:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:51:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:51:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:51:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:51:34 INFO - Return code: 0 15:51:34 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 15:51:34 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 15:51:34 INFO - Using env: {'DISPLAY': ':0', 15:51:34 INFO - 'HOME': '/home/cltbld', 15:51:34 INFO - 'LANG': 'en_US.UTF-8', 15:51:34 INFO - 'LANGUAGE': 'en_US:en', 15:51:34 INFO - 'LOGNAME': 'cltbld', 15:51:34 INFO - 'MAIL': '/var/mail/cltbld', 15:51:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:51:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:34 INFO - 'MOZ_NO_REMOTE': '1', 15:51:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:34 INFO - 'NO_EM_RESTART': '1', 15:51:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:34 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:51:34 INFO - 'SHELL': '/bin/bash', 15:51:34 INFO - 'SHLVL': '1', 15:51:34 INFO - 'TERM': 'linux', 15:51:34 INFO - 'TMOUT': '86400', 15:51:34 INFO - 'USER': 'cltbld', 15:51:34 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458', 15:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:34 INFO - '_': '/tools/buildbot/bin/python'} 15:51:34 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:51:34 INFO - mozversion application_buildid: 20160122133007 15:51:34 INFO - mozversion application_changeset: 86d2d6d0500e9dcfec41b65b2cc1eac85e0abce9 15:51:34 INFO - mozversion application_display_name: Nightly 15:51:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:34 INFO - mozversion application_name: Firefox 15:51:34 INFO - mozversion application_remotingname: firefox 15:51:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:51:34 INFO - mozversion application_vendor: Mozilla 15:51:34 INFO - mozversion application_version: 46.0a1 15:51:34 INFO - mozversion platform_buildid: 20160122133007 15:51:34 INFO - mozversion platform_changeset: 86d2d6d0500e9dcfec41b65b2cc1eac85e0abce9 15:51:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:51:34 INFO - mozversion platform_version: 46.0a1 15:51:34 INFO - using testdate: 1453506694 15:51:34 INFO - actual date: 1453506694 15:51:34 INFO - starting webserver on 'localhost:46902' 15:51:34 INFO - SUITE-START | Running 3 tests 15:51:34 INFO - TEST-START | dromaeo_css 15:51:34 INFO - operating with platform_type : linux_ 15:51:34 INFO - Initialising browser for dromaeo_css test... 15:51:34 INFO - TEST-INFO | started process 7341 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGI36JT/profile http://localhost:46902/getInfo.html) 15:51:38 INFO - PROCESS | 7341 | __metrics Screen width/height:1600/1200 15:51:38 INFO - PROCESS | 7341 | colorDepth:24 15:51:38 INFO - PROCESS | 7341 | Browser inner width/height: 1024/697 15:51:38 INFO - PROCESS | 7341 | __metrics 15:51:39 INFO - PROCESS | 7341 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:51:39 INFO - PROCESS | 7341 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:51:40 INFO - TEST-INFO | 7341: exit 0 15:51:40 INFO - Browser initialized. 15:51:40 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:40 INFO - TEST-INFO | started process 7432 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGI36JT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:51 INFO - PROCESS | 7432 | RSS: Main: 148271104 15:51:51 INFO - PROCESS | 7432 | 15:52:43 INFO - PROCESS | 7432 | 1453506763551 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] 15:54:51 INFO - PROCESS | 7432 | Cycle 1(1): loaded http://localhost:46902/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46902/tests/dromaeo/cssquery-ext.html) 15:54:52 INFO - PROCESS | 7432 | RSS: Main: 229654528 15:54:52 INFO - PROCESS | 7432 | 15:57:55 INFO - PROCESS | 7432 | Cycle 1(1): loaded http://localhost:46902/tests/dromaeo/cssquery-ext.html (next: http://localhost:46902/tests/dromaeo/cssquery-jquery.html) 15:57:55 INFO - PROCESS | 7432 | RSS: Main: 239316992 15:57:55 INFO - PROCESS | 7432 | 16:00:57 INFO - PROCESS | 7432 | Cycle 1(1): loaded http://localhost:46902/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46902/tests/dromaeo/cssquery-mootools.html) 16:00:58 INFO - PROCESS | 7432 | RSS: Main: 226660352 16:00:58 INFO - PROCESS | 7432 | 16:04:00 INFO - PROCESS | 7432 | Cycle 1(1): loaded http://localhost:46902/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46902/tests/dromaeo/cssquery-prototype.html) 16:04:00 INFO - PROCESS | 7432 | RSS: Main: 212398080 16:04:00 INFO - PROCESS | 7432 | 16:07:03 INFO - PROCESS | 7432 | Cycle 1(1): loaded http://localhost:46902/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46902/tests/dromaeo/cssquery-yui.html) 16:07:03 INFO - PROCESS | 7432 | RSS: Main: 214908928 16:07:03 INFO - PROCESS | 7432 | 16:10:06 INFO - PROCESS | 7432 | Cycle 1(1): loaded http://localhost:46902/tests/dromaeo/cssquery-yui.html (next: http://localhost:46902/tests/dromaeo/cssquery-dojo.html) 16:10:06 INFO - PROCESS | 7432 | RSS: Main: 259579904 16:10:06 INFO - PROCESS | 7432 | 16:10:06 INFO - PROCESS | 7432 | __start_tp_report 16:10:06 INFO - PROCESS | 7432 | _x_x_mozilla_page_load 16:10:06 INFO - PROCESS | 7432 | _x_x_mozilla_page_load_details 16:10:06 INFO - PROCESS | 7432 | |i|pagename|runs| 16:10:06 INFO - PROCESS | 7432 | |0;dojo.html;3173.4129186100567;3173.5874336336274;3211.16509707476;3211.309568442786;3244.3673483670677;5067.4425813160615;5120.692758434492;5129.153689641214;5130.127878260695;5178.974105129474;5191.5846732261425;5203.869903252421;5240.554552863011;5244.711540865251;5290.100682883909;4656.301554766796;4689.460712018111;4693.20215563355;4752.500987396308;4836.97581512092;4801.495842936493;4824.155772739774;4853.126437241295;4864.318995340655;4885.902281954376;4648.581627653511;4699.342092107107;4736.7394793286185;4738.573528382462;4770.403699537558;4717.386739723848;4726.905461890778;4736.052789442126;4739.881502962419;4751.097291514601;4691.366665500148;4699.483056863743;4713.575778179946;4728.929066064012;4768.690035147704;4971.801127954914;4997.800087996476;5003.249512573107;5036.370453693288;5051.1413059779925;5457.126859702428;5462.8361149165585;5467.043267428224;5471.644343117685;5473.945260547383;5537.695426751527;5539.113741801333;5586.078297080977;5596.356419011825;5600.747966341524;5295.0468915595175;5300.549453296474;5310.389305229871;5319.175527793198;5354.598405119632;5765.106408506688;5766.654000759968;5774.740136693859;5780.479756821822;5792.189093526909;5437.429069947599;5511.779528818803;5551.250581171571;5564.944350556523;5584.972075139598;5566.387697353288;5576.944230557724;5582.330120385498;5582.804601838916;5609.5792815539;5546.611737178358;5554.555635549146;5564.721763911869;5566.276384070045;5566.610337276352;5503.477169668875;5518.420565840529;5543.417941116206;5590.24531688225;5658;4346.391505189276;4347.804348804311;4352.608265256079;4359.17175736609;4381.78091095444;3872.6127387261613;3884.6209595593723;3894.0264933766557;3920.745151565139;3924.9803750981064;5100.948990510122;5170.5346518813485;5177.145770947752;5229.111051121243;5255.474452554714;5530.474604912527;5536.501714845603;5538.418466061086;5557.916631250535;5567.8886422272135;5133;5133.178691409356;5136.640435169502;5139.408967968731;5177.378714554277;4694.647901407408;4732.503087175797;4750.239961606127;4754.9286760698615;4759.357486739246;5721.971390143022;5733.168690539848;5733.541316694655;5743.59794814359;5792.594518383757;5523.944760552343;5570.86072848182;5575.442455754554;5579.553635709215;5584.106542953108;5593.720313984366;5671.971640141773;5741.1388291756575;5757.222774925499;5777.075667893117;5483.314585676791;5506.394296627448;5507.972460137674;5526.806561770319;5536.2249285099315;5573.16402539606;5593.244911936999;5594.13290939905;5607.327120745536;5611.1302748072485;5307.071262529119;5414.404415514212;5442.374126975448;5472.097103977799;5517.751701173376;5435.048866448435;5450.2369668247275;5464.781408743765;5465.152901300305;5469.398366179637;5359.758810853443;5359.973200133974;5371.677699338053;5389.407165211902;5417.349918009864;5445.564354851523;5489;5493.725313734218;5523.475269849358;5560.5829562783765;5361.731913404236;5383.353997520323;5384.6769193848495;5388.973055134699;5390.245365648734 16:10:06 INFO - PROCESS | 7432 | |1;ext.html;514.8249595137653;519.2885746527259;531.9202119682049;532.6431291035007;563.0596903171703;28208.43583128336;28586.714132858666;28654.570181447296;28668.283292917688;35045.82477087611;38362.61637383625;38812.80593597028;38850;38911.610883891226;38925.41611875817;8285.58572071397;8480.067192608809;8486.74539763808;8501.362397820158;8506.44708093975;8140.104588495261;8248.587570621476;8261.339092872586;8273.793155171108;8278.958605206966;8234.588270586446;8497.320214382866;8514.106018868022;8515.872261916076;8516.659333626678;8423.410361274713;8489.702860399919;8491.278241349493;8495.150484951455;8497.575121243945;8210.507369557845;8545.914540854574;8546.974363076408;8548.957255213683;8557.914420855774;38720.419193712114;39095.80452097721;39120.60879391198;39233.60766392328;39235;3156.542301366289;3159.7314228290393;3183.0450864740487;3541.203229273419;3728.3475391806596;28722.13833584996;29374;29426.85286573575;29477.557836632466;29899.10302690901;3914.3345631242473;4025.798710064485;4126.8761937141935;4143.958560414388;4162.458880345566;256373.79888212282;256549;257103;257103;269479;39851.40222896659;55536;56009.71995139998;56280;56398;54894.451055489735;54935.45064549383;55314.17028744572;55484.72257638686;55514.72242638761;14100.365483553265;14273.214973176367;14276.286185690675;14302.642433939234;14328.283585820667;8813.074627164184;8976.237019853255;10593.52329145175;10818.837717434244;10904.454777261106;18071.909640451715;18169;18239.27042918295;18252;18282.725759113622;6695.866082678319;6902.551334163263;6935;6935.549189302679;7026.929730702627;935.5836652689624;991.8115558043949;1005.6128390569537;1019.6431249062917;1041.1930753665818;27305.31736706598;27890;28347.858260708563;28417.147485575464;28482.715172848006;1076.1659713721772;1076.609925964358;1101.515333253366;1104.4643347976225;1198.3768440410938;14730.705385892437;15266.236688165547;15281.847181528043;15282.617934551725;15300.234988250542;364218;372515.5116468566;372771;374231;374556;53796.73101634467;54192.18711719327;54201.45798542043;54209;54244.72877635666;1282.6921538830613;1282.8139919711589;1292.173009274084;1302.2902518127644;1314.4610709609015;23872;27501.449971000868;28009.218755468566;28452.85773571119;28921.710782891903;43670;44007;44238;44334;44378;218213;219019;219096;219366;219590;27252.727472725812;31167;31494.37011259716;31752.841235793672;31933.36133277275;35553.644463555036;36528.45207321946;36558.60695136889;36892.81553592322;36991.260174796895;30228.546571801002;31939.680603193672;37971.43042854415;38626.42060369153;39541.20917581575;33847.66152338445;35865.46201806923;36540.45189322109;36706.26587468289;36832.44751328679;34810;35009.64990350064;35324;35377;35555;30637.540436893018;32147.678523215403;32823.343533128726;32854.178645534055;32879.83560082184;24400.26799196027;24726;25075;25084.74915250824;25438.364040899127 16:10:06 INFO - PROCESS | 7432 | |2;jquery.html;346.0155856588007;351.5271959214856;353.43780490233166;355.1618181092621;361.4379639660327;13487.662808429794;13908.652283692887;15251;15724.60688482787;16857.91571042146;15419.768703469457;15576.299066542004;16844.578885527837;16856.915715421437;16861.156942152906;5083.593312534988;5454.7272636368225;5457.945420545783;5458.836234912959;5461.453854614547;3931;4154.543000269968;5376.435474275204;5658.292713410824;6019.699015049252;5750.482456578907;5930.377310382412;5967.552433567478;5980.73086711099;6013;5930.762769489237;5954.077118046666;5954.672493012882;5981.252343457046;5984.88030239395;5065.670731402484;5292.364916210041;5306.310179676618;5309.309789727311;5315.7873685052555;19237.13432895523;19541.12064957066;19943;20578.279760208472;20581.176752929863;2108.8312934965165;2136.4231657452556;2152.8385371097074;2185.617516934546;2231.7545070042283;11851.94074029633;12861.614151575373;12883.694384475968;12953.417096230598;13340.933295333462;1790.2928343304452;1795.9910200449044;1842.990785046066;1843.824836640517;1851.5741379482795;48848;49652.503474965146;52837.2074418884;54666.180007299925;55165.72417137929;14569.271536423137;14871.70256594862;14910.179940103399;14962.925185374004;15046.699066018618;23396.64905026426;23416.882915585313;23701.762982369957;23818.40453988664;23821.404464888168;8506.064332923374;8518.105598912149;8522.531260780717;8551.615177317035;8625.353098517637;7117.323854233943;7174.748883789042;7189.784306470814;7223.638818059076;7232.20445750967;6800.455963522906;7534.472586918863;7558.697652093854;7566.924330756732;7570.507916985378;2655.4290827472187;2942.396808654221;2947.1539640768574;2992.177151283371;3029.363833594926;826.5164878546118;863.4344504349662;944.8535477001076;980.3823591137681;1024.359775140537;13236.338183091;14690.853091469162;15071.623209419853;15336.923315383352;15785.447509337118;920.1672486399818;920.3281604428671;966.3090890013674;966.6375109334;978.7846673731767;8989.561670132747;9142.908570914338;9173.44959302444;9193.264538836876;9341.299402544837;336469;338031;343704;424117;432535;43497;52954.735226323624;54251.72874135683;67810;68341.65829170922;1058.6665200461985;1081.561967403203;1091.5688303120223;1095.3044816541553;1103.9668809935874;14156.221407822668;14232;14672.926635366755;14822.184779836782;15216.315265812844;29753;30083.84958075283;30145.547816782328;30196;30471.238219043815;34802.477962831086;35812.82093589516;36116;36408.27183456369;38107.42838857475;6703.932960670526;6846;6869.450443964571;7272.163701174432;7423.740169094056;9340.626374944926;9469.573869176042;9893.307468477138;10267.383956962607;10271.537780799732;8476.194761497647;8847.911520884709;8883.866741998745;8927.508987005776;9124.863127052966;8731.607077681392;8918.86621700662;9013.459192448474;9296.349255552046;9409.623615055321;8799.252063574668;9182.770430739285;9228.815423691623;9297.07029297065;9640.903590964;7211.783646490614;7224.638768061471;7234.204237533761;7282.053333066668;7336.046313979148;7518.699252029857;9178.954105229432;9280.95359523198;9481.431114133175;9500.144986951207 16:10:06 INFO - PROCESS | 7432 | |3;mootools.html;1297.0920355750977;1460.4961288355516;1477.9778303325452;1626.7885174927264;1755.3680674957004;6825.6928438220275;7454.403647708184;7593.392528597713;7597.734079307225;7610.124835643903;7651.579163146025;7803.843923121534;7817.452778305521;7819.413543984209;7820.413468989835;1872.0733237047612;1916.8945707986056;1926.8458523318102;2327.17385328209;2351.31811774586;2328.3480625424822;2399.520095980802;2399.9280021599293;2401.9759802401927;2404.7475015123423;2305.262316058862;2305.8962346694357;2332.8950197241165;2356.599378105726;2359.4573248152933;2266.5580211858696;2272.9545409091893;2273.068042102738;2275.294658655822;2358.8820558971984;2302.1597117052324;2309.364924645719;2311.5954707926044;2314.6412306092584;2329.615613423783;8015.519068855829;8017.438779285452;8074.6770129194765;8101.311388531982;8112.918870811275;4877.195262781637;4980.078685443168;5013.498650134994;5019.171836646949;5025.422076461181;3195.2650890295363;3214.1964508872784;3247.155739507745;3311.6688331166692;3329.334133173351;980.9742880950885;1013.9594416223342;1018.332991890313;1025.3027941000116;1035.9326643768206;11087.168462365275;11100.278481898651;11129.220954533186;11150.442477876155;11156.497957591928;4469.217886869785;4515.480719717275;4559.065391594715;4581.381513495702;4586;9390.483523406141;9431.764205894908;9434.764130896783;9442.433453992782;9452.52737363129;4893.388326459192;4934.802607895644;4935;4941.678790878654;4944.505549445099;4442.755648439367;4445.911081778347;4451.532589078165;4454.844080457168;4455.554444555519;3444.8277586120594;3510.0347404463464;3683.37382644951;3830.597787232356;3932.2135572885536;1221.2123180548674;1232.6240496648609;1255.140228943177;1256.5664845628244;1265.1080987903506;1060.4432672846663;1069.005824583145;1082.285691443659;1220.7558488302375;1323.8874695650784;7295.306945840137;7407.333339999426;7410.333070023616;7420.220876807965;7444.032275804111;1090.7436752363187;1105.4086063955745;1115.9497822598003;1121.7027487715761;1128.4357821089454;5823.79616713413;5976.342602313742;5976.73104710289;5979.9402005980255;5986.3714309997695;9465.66870159541;9515.714528564155;9656.95171524152;9699.660511882192;9841.065098815601;9679.032096790264;9681.225501959827;9712.5143742814;9712.805743885225;9721.805563888682;7209.6034718091005;7353.816154596071;7415.369693575999;7420.814479637944;7573.772786816405;7352.5220860643885;7415.3326200642205;7502.699892004477;7511.436642251743;7519.1728909818785;8478.448900821428;8506.78733031679;8550;8657.480551166951;8683.69607063775;8718.302535797247;8819.206271435345;8840.98328692183;8968.865467018131;8969.372143950122;7224.241454647186;7277.053982982178;7326.7069317226715;7333.083364579427;7345.669444874887;6498.122753428227;6594.208694956636;6697.263301036979;7091;7732.613369331623;7029.894551581628;7085.82285442868;7124.536905101152;7212.531185472927;7239.457040722073;6892.620905850226;6933.82665433348;6971;7102;7102.112235970504;7126.35862772353;7170.749023784142;7175.748848790267;7179.282071792779;7183.425325973805;6366.93633063682;6614.768483103068;6620.04009418622;6630.46956243509;6635.668216589248;6591.077249185022;6620.5034622402545;6624.735010599522;6626.734930602722;6638.0374845648075 16:10:06 INFO - PROCESS | 7432 | |4;prototype.html;348.6234866344348;349.4129861832124;354.58690625421383;354.90062782420915;358.0493788990231;5626.352969408509;5782.797602083922;5786.045302525084;5795.913061304083;5837.8832423351505;5591.440855914407;5745.166950792132;5778.30660320761;5785.652860828353;5822.155787410834;4492.258777301741;4514.187446259672;4515.638748900096;4522.954770452303;4523.954760452402;4321.222180007598;4385.079133381978;4444.28891377378;4500.8874778130485;4541.727496350213;4499.887502812423;4506.278995360743;4510.052888893337;4522.706024108439;4541.977290113561;4501.392312037866;4506.729596224204;4519.796609152596;4522.9321560176295;4526.140033393661;4025.496812898388;4035.858744943913;4037.3338399164104;4038.1318016626565;4043.413705012786;5371.355437347504;5520.696361700105;5522.91715624266;5531.976584331912;5557.5831812614215;5178.689278643294;5180.585553155776;5186.170212765977;5194.11700010999;5196.558292545138;5811.82564523065;6144.692765361714;6154.292256390528;6159.599626024339;6162.383761623847;4190.455240818705;4212.53662097169;4331.7184383015;4335.56644335567;4338.132373525307;6249.843753906143;6370.617762934193;6373.362663733589;6378.872422551523;6382.553221274513;4406.876246557107;4408.919814645433;4409.647228221735;4410.426644536254;4414.757188354607;4348.326009468537;4463.732176069446;4469.687121901501;4469.843555475542;4505.6846020778885;5157.406898206679;5160.122779127557;5161.509656582693;5162.483751624883;5164.7346400131455;6146.416090471487;6172.259328880563;6184.134221209034;6190.690465476709;6190.876182476325;1565.5225156327429;1588.849059339384;1590.0698091616302;1590.90454572726;1591.6020994751311;1064.302881612545;1071.1002757683584;1078.7249251440833;1083.06315037492;1098.5880294889416;5869.706514674249;5873.647581145145;5875.882482350329;5878.5297176225795;5882.823515294548;6313.747450101944;6337.6197428154455;6344.555881088279;6344.777932772331;6350;5820.563457740686;5864.296284445893;5869.031609784423;5874.882502350015;5881.647101173858;3294.5387645729616;3416.4533674611944;3416.8633254669535;3418.6239513653477;3420.486926960976;6543.411093001652;6583.045458408504;6590.703418346186;6593.241777195588;6599.406053455212;6438.581492202992;6456.160699109179;6456.51576131792;6468.06213099098;6473.935260647428;6350.5554611177695;6558.245801732862;6613.008048792623;6613.437857782143;6626.271110177973;6130.570860039755;6285.057241413824;6363.3636636336;6375.553711240169;6379.457746091449;6152.892479353581;6319;6319.46284565817;6321.841953951188;6330.778422755181;6561.081448597296;6598.1422415085735;6609.933900660932;6613.404793568409;6625.436837868835;4439.844605438794;4447.888027993002;4474.948387129087;4475.597196252353;4475.9328610071525;6290.968545157245;6292.1505596743855;6301.369863013662;6301.558890877594;6309.274433440213;6150.04674275488;6180.949238629354;6197.845053873689;6199.907001395073;6212.099245609452;6040.697965101639;6168.444839964424;6181.258249010148;6182.969085154546;6192.195014648067;6139.109829074849;6147.323794382525;6150.10823430609;6150.323464419;6153.29237137717;6251.4061164189325;6288.119663247057;6290.2451705793765;6292.716827742855;6292.905606415999;5923.822285331447;6114.938850611437;6142.692865356625;6153.538484613761;6153.6923153841235 16:10:06 INFO - PROCESS | 7432 | |5;yui.html;836.5022811427199;851.506126446661;854.1031916487689;855.850226210413;878.4553576782392;11911.7617647647;11980.880191198085;11981.580644677439;12003.579874704386;12057.216280941733;10760.623378181765;10761.677149685522;10762.73093172671;10773.5690572377;10780.19148563857;658.3416583416583;671.2750229751881;800.403699244064;820.5404973215019;824.2746383182791;811.4319976016783;820.8071103290722;823.9988414076895;825.014108140772;825.3397282174267;677.156939610186;855.7518319687283;856.2080075929771;856.4689892266804;858.0732808566733;684.5995092870677;685.0990946904805;686.2245662401505;686.2691233835949;826.6197549127409;626.3266987987931;627.2598333965964;627.8210709947643;627.9246490421133;628.2555172121006;11702.53189872404;11725.237859539187;11741.412929353499;11750.882491175149;11760.353180575064;12384.504619815196;12628.68428289291;12642.367881605884;12658.683532911658;12897.355132243445;10512.789744205149;10588.205884558613;10592.205584581186;10697.572097116106;10717.839232411443;3591.3535563598543;3660.4143337065943;3722.013666378412;3756.4740936268945;3770.754900931458;47069.76465117687;47494.5250547497;48087.519124808656;48139.51860481386;48342.51657483415;10003.043016277661;10150.949245253727;10172;10295.639652612272;10307.330023548446;16801.91599041997;16962.23669934856;16966.660666786844;17000.404985825684;17017;7273.709051637875;7351.595662238521;7454.2545745426105;7569.848603027908;7660.387169026464;4213.915721685549;4406.5593440655675;4410.33844923264;4411.757353345597;4417.116576684676;3235.6602556731204;3255.2675647979017;3273.4107860585323;3275.836208189581;3275.836208189581;594.5511139090046;606.4117805728437;614.9046897730859;621.8445388652837;636.6848410037061;618.7555915413386;632.250782822357;635.726647459326;662.9005649152666;674.8920172772333;8089.959550202211;8904.554772261361;8915.108489151162;8932.732018039469;9034.774130646787;550.758784552901;582.5747204540625;583.439897698206;613.4938675592654;643.6363454648109;3951.980240098781;4041.4544036555276;4068.6541643960004;4150.418941348214;4238.703290769617;56284.43715562792;56385.436145638836;56412.153817692764;56415.43584564184;58512.12231816526;49529.752351238014;49561.50438495569;49865;50845.23732144021;51015;43572.564274357486;44213;44656.10687786226;44974;45568.54431455643;8285.875711864206;8369.66521339164;8464;8589.184027517376;8626.008009079036;32936.505952411215;33843.66156338504;34118.31763364768;34624.82687586546;34647.30705385929;40928.59071409367;41837;44393.55606443894;44765;45223.773881130386;10554.525046373084;10743.570257189625;10827;10903;11036;11692.415379231175;11990.280583165038;12126.939365303117;12651.557195498113;12660.240385576895;10809.459527023775;10996.23026388145;11591.6522504325;11926.522939082339;11964.461599227881;11289.37908415045;11578.536858525564;11708.648740537797;11900.068351345839;11964.76070478603;7224.819379515554;9399.295052870926;10777.676669699922;10839.891601083888;10855.348679079281;9330.160285574331;9422.670206543013;9601.663941762004;9646.324757266924;9900.455474948947;9671.323007389416;9982.750431239278;10037.799244015225;10065.798684026426;10091.091801737879 16:10:06 INFO - PROCESS | 7432 | __end_tp_report 16:10:06 INFO - PROCESS | 7432 | __start_cc_report 16:10:06 INFO - PROCESS | 7432 | _x_x_mozilla_cycle_collect,895 16:10:06 INFO - PROCESS | 7432 | __end_cc_report 16:10:06 INFO - PROCESS | 7432 | __startTimestamp1453507806822__endTimestamp 16:10:06 INFO - PROCESS | 7432 | 16:10:06 INFO - PROCESS | 7432 | ------- Summary: start ------- 16:10:06 INFO - PROCESS | 7432 | Number of tests: 6 16:10:06 INFO - PROCESS | 7432 | 16:10:06 INFO - PROCESS | 7432 | [#0] dojo.html Cycles:165 Average:5176.88 Median:5388.97 stddev:555.14 (10.3%) stddev-sans-first:534.13 16:10:06 INFO - PROCESS | 7432 | Values: 3173.4 3173.6 3211.2 3211.3 3244.4 5067.4 5120.7 5129.2 5130.1 5179.0 5191.6 5203.9 5240.6 5244.7 5290.1 4656.3 4689.5 4693.2 4752.5 4837.0 4801.5 4824.2 4853.1 4864.3 4885.9 4648.6 4699.3 4736.7 4738.6 4770.4 4717.4 4726.9 4736.1 4739.9 4751.1 4691.4 4699.5 4713.6 4728.9 4768.7 4971.8 4997.8 5003.2 5036.4 5051.1 5457.1 5462.8 5467.0 5471.6 5473.9 5537.7 5539.1 5586.1 5596.4 5600.7 5295.0 5300.5 5310.4 5319.2 5354.6 5765.1 5766.7 5774.7 5780.5 5792.2 5437.4 5511.8 5551.3 5564.9 5585.0 5566.4 5576.9 5582.3 5582.8 5609.6 5546.6 5554.6 5564.7 5566.3 5566.6 5503.5 5518.4 5543.4 5590.2 5658.0 4346.4 4347.8 4352.6 4359.2 4381.8 3872.6 3884.6 3894.0 3920.7 3925.0 5100.9 5170.5 5177.1 5229.1 5255.5 5530.5 5536.5 5538.4 5557.9 5567.9 5133.0 5133.2 5136.6 5139.4 5177.4 4694.6 4732.5 4750.2 4754.9 4759.4 5722.0 5733.2 5733.5 5743.6 5792.6 5523.9 5570.9 5575.4 5579.6 5584.1 5593.7 5672.0 5741.1 5757.2 5777.1 5483.3 5506.4 5508.0 5526.8 5536.2 5573.2 5593.2 5594.1 5607.3 5611.1 5307.1 5414.4 5442.4 5472.1 5517.8 5435.0 5450.2 5464.8 5465.2 5469.4 5359.8 5360.0 5371.7 5389.4 5417.3 5445.6 5489.0 5493.7 5523.5 5560.6 5361.7 5383.4 5384.7 5389.0 5390.2 16:10:06 INFO - PROCESS | 7432 | 16:10:06 INFO - PROCESS | 7432 | [#1] ext.html Cycles:180 Average:44392.83 Median:200373.23 stddev:76336.05 (38.1%) stddev-sans-first:76479.10 16:10:06 INFO - PROCESS | 7432 | Values: 514.8 519.3 531.9 532.6 563.1 28208.4 28586.7 28654.6 28668.3 35045.8 38362.6 38812.8 38850.0 38911.6 38925.4 8285.6 8480.1 8486.7 8501.4 8506.4 8140.1 8248.6 8261.3 8273.8 8279.0 8234.6 8497.3 8514.1 8515.9 8516.7 8423.4 8489.7 8491.3 8495.2 8497.6 8210.5 8545.9 8547.0 8549.0 8557.9 38720.4 39095.8 39120.6 39233.6 39235.0 3156.5 3159.7 3183.0 3541.2 3728.3 28722.1 29374.0 29426.9 29477.6 29899.1 3914.3 4025.8 4126.9 4144.0 4162.5 256373.8 256549.0 257103.0 257103.0 269479.0 39851.4 55536.0 56009.7 56280.0 56398.0 54894.5 54935.5 55314.2 55484.7 55514.7 14100.4 14273.2 14276.3 14302.6 14328.3 8813.1 8976.2 10593.5 10818.8 10904.5 18071.9 18169.0 18239.3 18252.0 18282.7 6695.9 6902.6 6935.0 6935.5 7026.9 935.6 991.8 1005.6 1019.6 1041.2 27305.3 27890.0 28347.9 28417.1 28482.7 1076.2 1076.6 1101.5 1104.5 1198.4 14730.7 15266.2 15281.8 15282.6 15300.2 364218.0 372515.5 372771.0 374231.0 374556.0 53796.7 54192.2 54201.5 54209.0 54244.7 1282.7 1282.8 1292.2 1302.3 1314.5 23872.0 27501.4 28009.2 28452.9 28921.7 43670.0 44007.0 44238.0 44334.0 44378.0 218213.0 219019.0 219096.0 219366.0 219590.0 27252.7 31167.0 31494.4 31752.8 31933.4 35553.6 36528.5 36558.6 36892.8 36991.3 30228.5 31939.7 37971.4 38626.4 39541.2 33847.7 35865.5 36540.5 36706.3 36832.4 34810.0 35009.6 35324.0 35377.0 35555.0 30637.5 32147.7 32823.3 32854.2 32879.8 24400.3 24726.0 25075.0 25084.7 25438.4 16:10:06 INFO - PROCESS | 7432 | 16:10:06 INFO - PROCESS | 7432 | [#2] jquery.html Cycles:180 Average:22593.80 Median:29064.79 stddev:61569.59 (211.8%) stddev-sans-first:61719.65 16:10:06 INFO - PROCESS | 7432 | Values: 346.0 351.5 353.4 355.2 361.4 13487.7 13908.7 15251.0 15724.6 16857.9 15419.8 15576.3 16844.6 16856.9 16861.2 5083.6 5454.7 5457.9 5458.8 5461.5 3931.0 4154.5 5376.4 5658.3 6019.7 5750.5 5930.4 5967.6 5980.7 6013.0 5930.8 5954.1 5954.7 5981.3 5984.9 5065.7 5292.4 5306.3 5309.3 5315.8 19237.1 19541.1 19943.0 20578.3 20581.2 2108.8 2136.4 2152.8 2185.6 2231.8 11851.9 12861.6 12883.7 12953.4 13340.9 1790.3 1796.0 1843.0 1843.8 1851.6 48848.0 49652.5 52837.2 54666.2 55165.7 14569.3 14871.7 14910.2 14962.9 15046.7 23396.6 23416.9 23701.8 23818.4 23821.4 8506.1 8518.1 8522.5 8551.6 8625.4 7117.3 7174.7 7189.8 7223.6 7232.2 6800.5 7534.5 7558.7 7566.9 7570.5 2655.4 2942.4 2947.2 2992.2 3029.4 826.5 863.4 944.9 980.4 1024.4 13236.3 14690.9 15071.6 15336.9 15785.4 920.2 920.3 966.3 966.6 978.8 8989.6 9142.9 9173.4 9193.3 9341.3 336469.0 338031.0 343704.0 424117.0 432535.0 43497.0 52954.7 54251.7 67810.0 68341.7 1058.7 1081.6 1091.6 1095.3 1104.0 14156.2 14232.0 14672.9 14822.2 15216.3 29753.0 30083.8 30145.5 30196.0 30471.2 34802.5 35812.8 36116.0 36408.3 38107.4 6703.9 6846.0 6869.5 7272.2 7423.7 9340.6 9469.6 9893.3 10267.4 10271.5 8476.2 8847.9 8883.9 8927.5 9124.9 8731.6 8918.9 9013.5 9296.3 9409.6 8799.3 9182.8 9228.8 9297.1 9640.9 7211.8 7224.6 7234.2 7282.1 7336.0 7518.7 9179.0 9281.0 9481.4 9500.1 16:10:06 INFO - PROCESS | 7432 | 16:10:06 INFO - PROCESS | 7432 | [#3] mootools.html Cycles:180 Average:5578.08 Median:6544.60 stddev:2894.83 (44.2%) stddev-sans-first:2885.06 16:10:06 INFO - PROCESS | 7432 | Values: 1297.1 1460.5 1478.0 1626.8 1755.4 6825.7 7454.4 7593.4 7597.7 7610.1 7651.6 7803.8 7817.5 7819.4 7820.4 1872.1 1916.9 1926.8 2327.2 2351.3 2328.3 2399.5 2399.9 2402.0 2404.7 2305.3 2305.9 2332.9 2356.6 2359.5 2266.6 2273.0 2273.1 2275.3 2358.9 2302.2 2309.4 2311.6 2314.6 2329.6 8015.5 8017.4 8074.7 8101.3 8112.9 4877.2 4980.1 5013.5 5019.2 5025.4 3195.3 3214.2 3247.2 3311.7 3329.3 981.0 1014.0 1018.3 1025.3 1035.9 11087.2 11100.3 11129.2 11150.4 11156.5 4469.2 4515.5 4559.1 4581.4 4586.0 9390.5 9431.8 9434.8 9442.4 9452.5 4893.4 4934.8 4935.0 4941.7 4944.5 4442.8 4445.9 4451.5 4454.8 4455.6 3444.8 3510.0 3683.4 3830.6 3932.2 1221.2 1232.6 1255.1 1256.6 1265.1 1060.4 1069.0 1082.3 1220.8 1323.9 7295.3 7407.3 7410.3 7420.2 7444.0 1090.7 1105.4 1115.9 1121.7 1128.4 5823.8 5976.3 5976.7 5979.9 5986.4 9465.7 9515.7 9657.0 9699.7 9841.1 9679.0 9681.2 9712.5 9712.8 9721.8 7209.6 7353.8 7415.4 7420.8 7573.8 7352.5 7415.3 7502.7 7511.4 7519.2 8478.4 8506.8 8550.0 8657.5 8683.7 8718.3 8819.2 8841.0 8968.9 8969.4 7224.2 7277.1 7326.7 7333.1 7345.7 6498.1 6594.2 6697.3 7091.0 7732.6 7029.9 7085.8 7124.5 7212.5 7239.5 6892.6 6933.8 6971.0 7102.0 7102.1 7126.4 7170.7 7175.7 7179.3 7183.4 6366.9 6614.8 6620.0 6630.5 6635.7 6591.1 6620.5 6624.7 6626.7 6638.0 16:10:06 INFO - PROCESS | 7432 | 16:10:06 INFO - PROCESS | 7432 | [#4] prototype.html Cycles:180 Average:5167.97 Median:5830.02 stddev:1535.47 (26.3%) stddev-sans-first:1496.56 16:10:06 INFO - PROCESS | 7432 | Values: 348.6 349.4 354.6 354.9 358.0 5626.4 5782.8 5786.0 5795.9 5837.9 5591.4 5745.2 5778.3 5785.7 5822.2 4492.3 4514.2 4515.6 4523.0 4524.0 4321.2 4385.1 4444.3 4500.9 4541.7 4499.9 4506.3 4510.1 4522.7 4542.0 4501.4 4506.7 4519.8 4522.9 4526.1 4025.5 4035.9 4037.3 4038.1 4043.4 5371.4 5520.7 5522.9 5532.0 5557.6 5178.7 5180.6 5186.2 5194.1 5196.6 5811.8 6144.7 6154.3 6159.6 6162.4 4190.5 4212.5 4331.7 4335.6 4338.1 6249.8 6370.6 6373.4 6378.9 6382.6 4406.9 4408.9 4409.6 4410.4 4414.8 4348.3 4463.7 4469.7 4469.8 4505.7 5157.4 5160.1 5161.5 5162.5 5164.7 6146.4 6172.3 6184.1 6190.7 6190.9 1565.5 1588.8 1590.1 1590.9 1591.6 1064.3 1071.1 1078.7 1083.1 1098.6 5869.7 5873.6 5875.9 5878.5 5882.8 6313.7 6337.6 6344.6 6344.8 6350.0 5820.6 5864.3 5869.0 5874.9 5881.6 3294.5 3416.5 3416.9 3418.6 3420.5 6543.4 6583.0 6590.7 6593.2 6599.4 6438.6 6456.2 6456.5 6468.1 6473.9 6350.6 6558.2 6613.0 6613.4 6626.3 6130.6 6285.1 6363.4 6375.6 6379.5 6152.9 6319.0 6319.5 6321.8 6330.8 6561.1 6598.1 6609.9 6613.4 6625.4 4439.8 4447.9 4474.9 4475.6 4475.9 6291.0 6292.2 6301.4 6301.6 6309.3 6150.0 6180.9 6197.8 6199.9 6212.1 6040.7 6168.4 6181.3 6183.0 6192.2 6139.1 6147.3 6150.1 6150.3 6153.3 6251.4 6288.1 6290.2 6292.7 6292.9 5923.8 6114.9 6142.7 6153.5 6153.7 16:10:06 INFO - PROCESS | 7432 | 16:10:06 INFO - PROCESS | 7432 | [#5] yui.html Cycles:180 Average:13440.93 Median:44524.83 stddev:15606.82 (35.1%) stddev-sans-first:15621.90 16:10:06 INFO - PROCESS | 7432 | Values: 836.5 851.5 854.1 855.9 878.5 11911.8 11980.9 11981.6 12003.6 12057.2 10760.6 10761.7 10762.7 10773.6 10780.2 658.3 671.3 800.4 820.5 824.3 811.4 820.8 824.0 825.0 825.3 677.2 855.8 856.2 856.5 858.1 684.6 685.1 686.2 686.3 826.6 626.3 627.3 627.8 627.9 628.3 11702.5 11725.2 11741.4 11750.9 11760.4 12384.5 12628.7 12642.4 12658.7 12897.4 10512.8 10588.2 10592.2 10697.6 10717.8 3591.4 3660.4 3722.0 3756.5 3770.8 47069.8 47494.5 48087.5 48139.5 48342.5 10003.0 10150.9 10172.0 10295.6 10307.3 16801.9 16962.2 16966.7 17000.4 17017.0 7273.7 7351.6 7454.3 7569.8 7660.4 4213.9 4406.6 4410.3 4411.8 4417.1 3235.7 3255.3 3273.4 3275.8 3275.8 594.6 606.4 614.9 621.8 636.7 618.8 632.3 635.7 662.9 674.9 8090.0 8904.6 8915.1 8932.7 9034.8 550.8 582.6 583.4 613.5 643.6 3952.0 4041.5 4068.7 4150.4 4238.7 56284.4 56385.4 56412.2 56415.4 58512.1 49529.8 49561.5 49865.0 50845.2 51015.0 43572.6 44213.0 44656.1 44974.0 45568.5 8285.9 8369.7 8464.0 8589.2 8626.0 32936.5 33843.7 34118.3 34624.8 34647.3 40928.6 41837.0 44393.6 44765.0 45223.8 10554.5 10743.6 10827.0 10903.0 11036.0 11692.4 11990.3 12126.9 12651.6 12660.2 10809.5 10996.2 11591.7 11926.5 11964.5 11289.4 11578.5 11708.6 11900.1 11964.8 7224.8 9399.3 10777.7 10839.9 10855.3 9330.2 9422.7 9601.7 9646.3 9900.5 9671.3 9982.8 10037.8 10065.8 10091.1 16:10:06 INFO - PROCESS | 7432 | -------- Summary: end -------- 16:10:06 INFO - PROCESS | 7432 | 16:10:07 INFO - TEST-INFO | 7432: exit 0 16:10:07 INFO - TEST-OK | dromaeo_css | took 1112583ms 16:10:07 INFO - TEST-START | kraken 16:10:07 INFO - operating with platform_type : linux_ 16:10:07 INFO - Initialising browser for kraken test... 16:10:07 INFO - TEST-INFO | started process 7633 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprsYxU2/profile http://localhost:46902/getInfo.html) 16:10:11 INFO - PROCESS | 7633 | __metrics Screen width/height:1600/1200 16:10:11 INFO - PROCESS | 7633 | colorDepth:24 16:10:11 INFO - PROCESS | 7633 | Browser inner width/height: 1024/697 16:10:11 INFO - PROCESS | 7633 | __metrics 16:10:11 INFO - PROCESS | 7633 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:10:11 INFO - PROCESS | 7633 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:10:12 INFO - TEST-INFO | 7633: exit 0 16:10:12 INFO - Browser initialized. 16:10:12 INFO - Running cycle 1/1 for kraken test... 16:10:12 INFO - TEST-INFO | started process 7715 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprsYxU2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:24 INFO - PROCESS | 7715 | RSS: Main: 148402176 16:10:24 INFO - PROCESS | 7715 | 16:10:26 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46902/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:27 INFO - PROCESS | 7715 | RSS: Main: 185647104 16:10:27 INFO - PROCESS | 7715 | 16:10:30 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46902/tests/kraken/driver.html?testName=audio-dft) 16:10:30 INFO - PROCESS | 7715 | RSS: Main: 177602560 16:10:30 INFO - PROCESS | 7715 | 16:10:33 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46902/tests/kraken/driver.html?testName=audio-fft) 16:10:34 INFO - PROCESS | 7715 | RSS: Main: 162447360 16:10:34 INFO - PROCESS | 7715 | 16:10:36 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46902/tests/kraken/driver.html?testName=audio-oscillator) 16:10:36 INFO - PROCESS | 7715 | RSS: Main: 164610048 16:10:36 INFO - PROCESS | 7715 | 16:10:39 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46902/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:39 INFO - PROCESS | 7715 | RSS: Main: 166354944 16:10:39 INFO - PROCESS | 7715 | 16:10:42 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46902/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:43 INFO - PROCESS | 7715 | RSS: Main: 166539264 16:10:43 INFO - PROCESS | 7715 | 16:10:46 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46902/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:47 INFO - PROCESS | 7715 | RSS: Main: 166498304 16:10:47 INFO - PROCESS | 7715 | 16:10:49 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46902/tests/kraken/driver.html?testName=json-parse-financial) 16:10:50 INFO - PROCESS | 7715 | RSS: Main: 168144896 16:10:50 INFO - PROCESS | 7715 | 16:10:52 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46902/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:10:52 INFO - PROCESS | 7715 | RSS: Main: 179118080 16:10:52 INFO - PROCESS | 7715 | 16:10:54 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46902/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:10:55 INFO - PROCESS | 7715 | RSS: Main: 175923200 16:10:55 INFO - PROCESS | 7715 | 16:10:57 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46902/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:10:57 INFO - PROCESS | 7715 | RSS: Main: 186916864 16:10:57 INFO - PROCESS | 7715 | 16:11:00 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:00 INFO - PROCESS | 7715 | RSS: Main: 194019328 16:11:00 INFO - PROCESS | 7715 | 16:11:03 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:03 INFO - PROCESS | 7715 | RSS: Main: 191782912 16:11:03 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | Cycle 1(1): loaded http://localhost:46902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46902/tests/kraken/driver.html?testName=ai-astar) 16:11:05 INFO - PROCESS | 7715 | RSS: Main: 253169664 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | __start_tp_report 16:11:05 INFO - PROCESS | 7715 | _x_x_mozilla_page_load 16:11:05 INFO - PROCESS | 7715 | _x_x_mozilla_page_load_details 16:11:05 INFO - PROCESS | 7715 | |i|pagename|runs| 16:11:05 INFO - PROCESS | 7715 | |0;ai-astar;111;111;108;112;112;111;109;110;104;111 16:11:05 INFO - PROCESS | 7715 | |1;audio-beat-detection;157;127;154;170;127;163;159;129;162;126 16:11:05 INFO - PROCESS | 7715 | |2;audio-dft;161;160;161;162;161;162;160;160;161;163 16:11:05 INFO - PROCESS | 7715 | |3;audio-fft;76;73;95;95;76;73;75;104;102;73 16:11:05 INFO - PROCESS | 7715 | |4;audio-oscillator;96;96;142;95;97;96;140;95;96;139 16:11:05 INFO - PROCESS | 7715 | |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;109;109 16:11:05 INFO - PROCESS | 7715 | |6;imaging-darkroom;145;145;146;145;145;145;146;145;145;145 16:11:05 INFO - PROCESS | 7715 | |7;imaging-desaturate;96;96;96;96;95;96;96;95;96;95 16:11:05 INFO - PROCESS | 7715 | |8;json-parse-financial;55;55;55;56;54;61;55;58;55;53 16:11:05 INFO - PROCESS | 7715 | |9;json-stringify-tinderbox;68;69;67;67;68;73;68;67;68;68 16:11:05 INFO - PROCESS | 7715 | |10;stanford-crypto-aes;82;82;82;81;82;83;83;83;83;82 16:11:05 INFO - PROCESS | 7715 | |11;stanford-crypto-ccm;115;112;113;117;120;115;120;119;120;114 16:11:05 INFO - PROCESS | 7715 | |12;stanford-crypto-pbkdf2;143;143;143;141;141;129;153;143;142;140 16:11:05 INFO - PROCESS | 7715 | |13;stanford-crypto-sha256-iterative;70;68;70;69;66;67;67;67;66;66 16:11:05 INFO - PROCESS | 7715 | __end_tp_report 16:11:05 INFO - PROCESS | 7715 | __start_cc_report 16:11:05 INFO - PROCESS | 7715 | _x_x_mozilla_cycle_collect,975 16:11:05 INFO - PROCESS | 7715 | __end_cc_report 16:11:05 INFO - PROCESS | 7715 | __startTimestamp1453507865753__endTimestamp 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | ------- Summary: start ------- 16:11:05 INFO - PROCESS | 7715 | Number of tests: 14 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.42 (2.2%) stddev-sans-first:2.54 16:11:05 INFO - PROCESS | 7715 | Values: 111.0 111.0 108.0 112.0 112.0 111.0 109.0 110.0 104.0 111.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:158.00 stddev:17.85 (11.3%) stddev-sans-first:18.59 16:11:05 INFO - PROCESS | 7715 | Values: 157.0 127.0 154.0 170.0 127.0 163.0 159.0 129.0 162.0 126.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 16:11:05 INFO - PROCESS | 7715 | Values: 161.0 160.0 161.0 162.0 161.0 162.0 160.0 160.0 161.0 163.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#3] audio-fft Cycles:10 Average:84.20 Median:75.50 stddev:13.07 (17.3%) stddev-sans-first:13.52 16:11:05 INFO - PROCESS | 7715 | Values: 76.0 73.0 95.0 95.0 76.0 73.0 75.0 104.0 102.0 73.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:96.00 stddev:21.50 (22.4%) stddev-sans-first:22.27 16:11:05 INFO - PROCESS | 7715 | Values: 96.0 96.0 142.0 95.0 97.0 96.0 140.0 95.0 96.0 139.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:11:05 INFO - PROCESS | 7715 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:11:05 INFO - PROCESS | 7715 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:11:05 INFO - PROCESS | 7715 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:2.26 (4.1%) stddev-sans-first:2.39 16:11:05 INFO - PROCESS | 7715 | Values: 55.0 55.0 55.0 56.0 54.0 61.0 55.0 58.0 55.0 53.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:1.77 (2.6%) stddev-sans-first:1.87 16:11:05 INFO - PROCESS | 7715 | Values: 68.0 69.0 67.0 67.0 68.0 73.0 68.0 67.0 68.0 68.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:0.67 (0.8%) stddev-sans-first:0.71 16:11:05 INFO - PROCESS | 7715 | Values: 82.0 82.0 82.0 81.0 82.0 83.0 83.0 83.0 83.0 82.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#11] stanford-crypto-ccm Cycles:10 Average:116.50 Median:118.00 stddev:3.10 (2.6%) stddev-sans-first:3.24 16:11:05 INFO - PROCESS | 7715 | Values: 115.0 112.0 113.0 117.0 120.0 115.0 120.0 119.0 120.0 114.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:143.00 stddev:5.77 (4.0%) stddev-sans-first:6.10 16:11:05 INFO - PROCESS | 7715 | Values: 143.0 143.0 143.0 141.0 141.0 129.0 153.0 143.0 142.0 140.0 16:11:05 INFO - PROCESS | 7715 | 16:11:05 INFO - PROCESS | 7715 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.58 (2.3%) stddev-sans-first:1.41 16:11:05 INFO - PROCESS | 7715 | Values: 70.0 68.0 70.0 69.0 66.0 67.0 67.0 67.0 66.0 66.0 16:11:05 INFO - PROCESS | 7715 | -------- Summary: end -------- 16:11:05 INFO - PROCESS | 7715 | 16:11:06 INFO - TEST-INFO | 7715: exit 0 16:11:06 INFO - TEST-OK | kraken | took 59189ms 16:11:06 INFO - TEST-START | v8_7 16:11:06 INFO - operating with platform_type : linux_ 16:11:06 INFO - Initialising browser for v8_7 test... 16:11:06 INFO - TEST-INFO | started process 7963 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUgcgSs/profile http://localhost:46902/getInfo.html) 16:11:10 INFO - PROCESS | 7963 | __metrics Screen width/height:1600/1200 16:11:10 INFO - PROCESS | 7963 | colorDepth:24 16:11:10 INFO - PROCESS | 7963 | Browser inner width/height: 1024/697 16:11:10 INFO - PROCESS | 7963 | __metrics 16:11:10 INFO - PROCESS | 7963 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:11:10 INFO - PROCESS | 7963 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:11:11 INFO - TEST-INFO | 7963: exit 0 16:11:11 INFO - Browser initialized. 16:11:11 INFO - Running cycle 1/1 for v8_7 test... 16:11:11 INFO - TEST-INFO | started process 8048 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUgcgSs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:23 INFO - PROCESS | 8048 | RSS: Main: 147947520 16:11:23 INFO - PROCESS | 8048 | 16:11:45 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:46902/tests/v8_7/run.html (next: http://localhost:46902/tests/v8_7/run.html) 16:11:46 INFO - PROCESS | 8048 | RSS: Main: 522752000 16:11:46 INFO - PROCESS | 8048 | 16:11:46 INFO - PROCESS | 8048 | __start_tp_report 16:11:46 INFO - PROCESS | 8048 | _x_x_mozilla_page_load 16:11:46 INFO - PROCESS | 8048 | _x_x_mozilla_page_load_details 16:11:46 INFO - PROCESS | 8048 | |i|pagename|runs| 16:11:46 INFO - PROCESS | 8048 | |0;Richards;167.84155756965424 16:11:46 INFO - PROCESS | 8048 | |1;DeltaBlue;190.3311762466692 16:11:46 INFO - PROCESS | 8048 | |2;Encrypt;280.50490883590464 16:11:46 INFO - PROCESS | 8048 | |3;Decrypt;5256.544502617801 16:11:46 INFO - PROCESS | 8048 | |4;RayTrace;1106.1946902654868 16:11:46 INFO - PROCESS | 8048 | |5;Earley;789.8894154818325 16:11:46 INFO - PROCESS | 8048 | |6;Boyer;12243.90243902439 16:11:46 INFO - PROCESS | 8048 | |7;RegExp;42833.333333333336 16:11:46 INFO - PROCESS | 8048 | |8;Splay;568.8282138794084 16:11:46 INFO - PROCESS | 8048 | |9;NavierStokes;4812.5 16:11:46 INFO - PROCESS | 8048 | __end_tp_report 16:11:46 INFO - PROCESS | 8048 | __startTimestamp1453507906239__endTimestamp 16:11:46 INFO - PROCESS | 8048 | 16:11:46 INFO - PROCESS | 8048 | ------- Summary: start ------- 16:11:46 INFO - PROCESS | 8048 | Number of tests: 10 16:11:46 INFO - PROCESS | 8048 | 16:11:46 INFO - PROCESS | 8048 | [#0] Richards Cycles:1 Average:167.84 Median:167.84 stddev:0.00 (0.0%) 16:11:46 INFO - PROCESS | 8048 | Values: 167.8 16:11:46 INFO - PROCESS | 8048 | 16:11:46 INFO - PROCESS | 8048 | [#1] DeltaBlue Cycles:1 Average:190.33 Median:190.33 stddev:0.00 (0.0%) 16:11:46 INFO - PROCESS | 8048 | Values: 190.3 16:11:46 INFO - PROCESS | 8048 | 16:11:46 INFO - PROCESS | 8048 | [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 16:11:46 INFO - PROCESS | 8048 | Values: 280.5 16:11:46 INFO - PROCESS | 8048 | 16:11:46 INFO - PROCESS | 8048 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 16:11:46 INFO - PROCESS | 8048 | Values: 5256.5 16:11:46 INFO - PROCESS | 8048 | 16:11:46 INFO - PROCESS | 8048 | [#4] RayTrace Cycles:1 Average:1106.19 Median:1106.19 stddev:0.00 (0.0%) 16:11:46 INFO - PROCESS | 8048 | Values: 1106.2 16:11:46 INFO - PROCESS | 8048 | 16:11:46 INFO - PROCESS | 8048 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 16:11:46 INFO - PROCESS | 8048 | Values: 789.9 16:11:46 INFO - PROCESS | 8048 | 16:11:46 INFO - PROCESS | 8048 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 16:11:46 INFO - PROCESS | 8048 | Values: 12243.9 16:11:46 INFO - PROCESS | 8048 | 16:11:46 INFO - PROCESS | 8048 | [#7] RegExp Cycles:1 Average:42833.33 Median:42833.33 stddev:0.00 (0.0%) 16:11:46 INFO - PROCESS | 8048 | Values: 42833.3 16:11:46 INFO - PROCESS | 8048 | 16:11:46 INFO - PROCESS | 8048 | [#8] Splay Cycles:1 Average:568.83 Median:568.83 stddev:0.00 (0.0%) 16:11:46 INFO - PROCESS | 8048 | Values: 568.8 16:11:46 INFO - PROCESS | 8048 | 16:11:46 INFO - PROCESS | 8048 | [#9] NavierStokes Cycles:1 Average:4812.50 Median:4812.50 stddev:0.00 (0.0%) 16:11:46 INFO - PROCESS | 8048 | Values: 4812.5 16:11:46 INFO - PROCESS | 8048 | -------- Summary: end -------- 16:11:46 INFO - PROCESS | 8048 | 16:11:47 INFO - TEST-INFO | 8048: exit 0 16:11:47 INFO - TEST-OK | v8_7 | took 40394ms 16:11:47 INFO - SUITE-END | took 1212s 16:11:47 INFO - Completed test suite (00:20:12) 16:11:47 INFO - Working with test: dromaeo_css 16:11:47 INFO - Generating results file: dromaeo_css 16:11:47 INFO - Working with test: kraken 16:11:47 INFO - Generating results file: kraken 16:11:47 INFO - javascript benchmark 16:11:47 INFO - Working with test: v8_7 16:11:47 INFO - Generating results file: v8_7 16:11:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:11:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 16:11:47 INFO - process_Request line: dromaeo_css 6816.29 graph.html#tests=[[72,63,35]] 16:11:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:11:47 INFO - process_Request line: kraken 1494.00 graph.html#tests=[[232,63,35]] 16:11:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:11:47 INFO - process_Request line: v8_7 20090.70 graph.html#tests=[[230,63,35]] 16:11:47 INFO - RETURN: dromaeo_css: 6816.29 16:11:47 INFO - RETURN: kraken: 1494.00 16:11:47 INFO - RETURN: v8_7: 20090.70 16:11:47 INFO - javascript benchmark 16:11:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3173.4129186100567, 3173.5874336336274, 3211.16509707476, 3211.309568442786, 3244.3673483670677, 5067.4425813160615, 5120.692758434492, 5129.153689641214, 5130.127878260695, 5178.974105129474, 5191.5846732261425, 5203.869903252421, 5240.554552863011, 5244.711540865251, 5290.100682883909, 4656.301554766796, 4689.460712018111, 4693.20215563355, 4752.500987396308, 4836.97581512092, 4801.495842936493, 4824.155772739774, 4853.126437241295, 4864.318995340655, 4885.902281954376, 4648.581627653511, 4699.342092107107, 4736.7394793286185, 4738.573528382462, 4770.403699537558, 4717.386739723848, 4726.905461890778, 4736.052789442126, 4739.881502962419, 4751.097291514601, 4691.366665500148, 4699.483056863743, 4713.575778179946, 4728.929066064012, 4768.690035147704, 4971.801127954914, 4997.800087996476, 5003.249512573107, 5036.370453693288, 5051.1413059779925, 5457.126859702428, 5462.8361149165585, 5467.043267428224, 5471.644343117685, 5473.945260547383, 5537.695426751527, 5539.113741801333, 5586.078297080977, 5596.356419011825, 5600.747966341524, 5295.0468915595175, 5300.549453296474, 5310.389305229871, 5319.175527793198, 5354.598405119632, 5765.106408506688, 5766.654000759968, 5774.740136693859, 5780.479756821822, 5792.189093526909, 5437.429069947599, 5511.779528818803, 5551.250581171571, 5564.944350556523, 5584.972075139598, 5566.387697353288, 5576.944230557724, 5582.330120385498, 5582.804601838916, 5609.5792815539, 5546.611737178358, 5554.555635549146, 5564.721763911869, 5566.276384070045, 5566.610337276352, 5503.477169668875, 5518.420565840529, 5543.417941116206, 5590.24531688225, 5658.0, 4346.391505189276, 4347.804348804311, 4352.608265256079, 4359.17175736609, 4381.78091095444, 3872.6127387261613, 3884.6209595593723, 3894.0264933766557, 3920.745151565139, 3924.9803750981064, 5100.948990510122, 5170.5346518813485, 5177.145770947752, 5229.111051121243, 5255.474452554714, 5530.474604912527, 5536.501714845603, 5538.418466061086, 5557.916631250535, 5567.8886422272135, 5133.0, 5133.178691409356, 5136.640435169502, 5139.408967968731, 5177.378714554277, 4694.647901407408, 4732.503087175797, 4750.239961606127, 4754.9286760698615, 4759.357486739246, 5721.971390143022, 5733.168690539848, 5733.541316694655, 5743.59794814359, 5792.594518383757, 5523.944760552343, 5570.86072848182, 5575.442455754554, 5579.553635709215, 5584.106542953108, 5593.720313984366, 5671.971640141773, 5741.1388291756575, 5757.222774925499, 5777.075667893117, 5483.314585676791, 5506.394296627448, 5507.972460137674, 5526.806561770319, 5536.2249285099315, 5573.16402539606, 5593.244911936999, 5594.13290939905, 5607.327120745536, 5611.1302748072485, 5307.071262529119, 5414.404415514212, 5442.374126975448, 5472.097103977799, 5517.751701173376, 5435.048866448435, 5450.2369668247275, 5464.781408743765, 5465.152901300305, 5469.398366179637, 5359.758810853443, 5359.973200133974, 5371.677699338053, 5389.407165211902, 5417.349918009864, 5445.564354851523, 5489.0, 5493.725313734218, 5523.475269849358, 5560.5829562783765, 5361.731913404236, 5383.353997520323, 5384.6769193848495, 5388.973055134699, 5390.245365648734], "unit": "score", "name": "dojo.html", "value": 5142.441585866031}, {"lowerIsBetter": false, "replicates": [514.8249595137653, 519.2885746527259, 531.9202119682049, 532.6431291035007, 563.0596903171703, 28208.43583128336, 28586.714132858666, 28654.570181447296, 28668.283292917688, 35045.82477087611, 38362.61637383625, 38812.80593597028, 38850.0, 38911.610883891226, 38925.41611875817, 8285.58572071397, 8480.067192608809, 8486.74539763808, 8501.362397820158, 8506.44708093975, 8140.104588495261, 8248.587570621476, 8261.339092872586, 8273.793155171108, 8278.958605206966, 8234.588270586446, 8497.320214382866, 8514.106018868022, 8515.872261916076, 8516.659333626678, 8423.410361274713, 8489.702860399919, 8491.278241349493, 8495.150484951455, 8497.575121243945, 8210.507369557845, 8545.914540854574, 8546.974363076408, 8548.957255213683, 8557.914420855774, 38720.419193712114, 39095.80452097721, 39120.60879391198, 39233.60766392328, 39235.0, 3156.542301366289, 3159.7314228290393, 3183.0450864740487, 3541.203229273419, 3728.3475391806596, 28722.13833584996, 29374.0, 29426.85286573575, 29477.557836632466, 29899.10302690901, 3914.3345631242473, 4025.798710064485, 4126.8761937141935, 4143.958560414388, 4162.458880345566, 256373.79888212282, 256549.0, 257103.0, 257103.0, 269479.0, 39851.40222896659, 55536.0, 56009.71995139998, 56280.0, 56398.0, 54894.451055489735, 54935.45064549383, 55314.17028744572, 55484.72257638686, 55514.72242638761, 14100.365483553265, 14273.214973176367, 14276.286185690675, 14302.642433939234, 14328.283585820667, 8813.074627164184, 8976.237019853255, 10593.52329145175, 10818.837717434244, 10904.454777261106, 18071.909640451715, 18169.0, 18239.27042918295, 18252.0, 18282.725759113622, 6695.866082678319, 6902.551334163263, 6935.0, 6935.549189302679, 7026.929730702627, 935.5836652689624, 991.8115558043949, 1005.6128390569537, 1019.6431249062917, 1041.1930753665818, 27305.31736706598, 27890.0, 28347.858260708563, 28417.147485575464, 28482.715172848006, 1076.1659713721772, 1076.609925964358, 1101.515333253366, 1104.4643347976225, 1198.3768440410938, 14730.705385892437, 15266.236688165547, 15281.847181528043, 15282.617934551725, 15300.234988250542, 364218.0, 372515.5116468566, 372771.0, 374231.0, 374556.0, 53796.73101634467, 54192.18711719327, 54201.45798542043, 54209.0, 54244.72877635666, 1282.6921538830613, 1282.8139919711589, 1292.173009274084, 1302.2902518127644, 1314.4610709609015, 23872.0, 27501.449971000868, 28009.218755468566, 28452.85773571119, 28921.710782891903, 43670.0, 44007.0, 44238.0, 44334.0, 44378.0, 218213.0, 219019.0, 219096.0, 219366.0, 219590.0, 27252.727472725812, 31167.0, 31494.37011259716, 31752.841235793672, 31933.36133277275, 35553.644463555036, 36528.45207321946, 36558.60695136889, 36892.81553592322, 36991.260174796895, 30228.546571801002, 31939.680603193672, 37971.43042854415, 38626.42060369153, 39541.20917581575, 33847.66152338445, 35865.46201806923, 36540.45189322109, 36706.26587468289, 36832.44751328679, 34810.0, 35009.64990350064, 35324.0, 35377.0, 35555.0, 30637.540436893018, 32147.678523215403, 32823.343533128726, 32854.178645534055, 32879.83560082184, 24400.26799196027, 24726.0, 25075.0, 25084.74915250824, 25438.364040899127], "unit": "score", "name": "ext.html", "value": 17635.349130195238}, {"lowerIsBetter": false, "replicates": [346.0155856588007, 351.5271959214856, 353.43780490233166, 355.1618181092621, 361.4379639660327, 13487.662808429794, 13908.652283692887, 15251.0, 15724.60688482787, 16857.91571042146, 15419.768703469457, 15576.299066542004, 16844.578885527837, 16856.915715421437, 16861.156942152906, 5083.593312534988, 5454.7272636368225, 5457.945420545783, 5458.836234912959, 5461.453854614547, 3931.0, 4154.543000269968, 5376.435474275204, 5658.292713410824, 6019.699015049252, 5750.482456578907, 5930.377310382412, 5967.552433567478, 5980.73086711099, 6013.0, 5930.762769489237, 5954.077118046666, 5954.672493012882, 5981.252343457046, 5984.88030239395, 5065.670731402484, 5292.364916210041, 5306.310179676618, 5309.309789727311, 5315.7873685052555, 19237.13432895523, 19541.12064957066, 19943.0, 20578.279760208472, 20581.176752929863, 2108.8312934965165, 2136.4231657452556, 2152.8385371097074, 2185.617516934546, 2231.7545070042283, 11851.94074029633, 12861.614151575373, 12883.694384475968, 12953.417096230598, 13340.933295333462, 1790.2928343304452, 1795.9910200449044, 1842.990785046066, 1843.824836640517, 1851.5741379482795, 48848.0, 49652.503474965146, 52837.2074418884, 54666.180007299925, 55165.72417137929, 14569.271536423137, 14871.70256594862, 14910.179940103399, 14962.925185374004, 15046.699066018618, 23396.64905026426, 23416.882915585313, 23701.762982369957, 23818.40453988664, 23821.404464888168, 8506.064332923374, 8518.105598912149, 8522.531260780717, 8551.615177317035, 8625.353098517637, 7117.323854233943, 7174.748883789042, 7189.784306470814, 7223.638818059076, 7232.20445750967, 6800.455963522906, 7534.472586918863, 7558.697652093854, 7566.924330756732, 7570.507916985378, 2655.4290827472187, 2942.396808654221, 2947.1539640768574, 2992.177151283371, 3029.363833594926, 826.5164878546118, 863.4344504349662, 944.8535477001076, 980.3823591137681, 1024.359775140537, 13236.338183091, 14690.853091469162, 15071.623209419853, 15336.923315383352, 15785.447509337118, 920.1672486399818, 920.3281604428671, 966.3090890013674, 966.6375109334, 978.7846673731767, 8989.561670132747, 9142.908570914338, 9173.44959302444, 9193.264538836876, 9341.299402544837, 336469.0, 338031.0, 343704.0, 424117.0, 432535.0, 43497.0, 52954.735226323624, 54251.72874135683, 67810.0, 68341.65829170922, 1058.6665200461985, 1081.561967403203, 1091.5688303120223, 1095.3044816541553, 1103.9668809935874, 14156.221407822668, 14232.0, 14672.926635366755, 14822.184779836782, 15216.315265812844, 29753.0, 30083.84958075283, 30145.547816782328, 30196.0, 30471.238219043815, 34802.477962831086, 35812.82093589516, 36116.0, 36408.27183456369, 38107.42838857475, 6703.932960670526, 6846.0, 6869.450443964571, 7272.163701174432, 7423.740169094056, 9340.626374944926, 9469.573869176042, 9893.307468477138, 10267.383956962607, 10271.537780799732, 8476.194761497647, 8847.911520884709, 8883.866741998745, 8927.508987005776, 9124.863127052966, 8731.607077681392, 8918.86621700662, 9013.459192448474, 9296.349255552046, 9409.623615055321, 8799.252063574668, 9182.770430739285, 9228.815423691623, 9297.07029297065, 9640.903590964, 7211.783646490614, 7224.638768061471, 7234.204237533761, 7282.053333066668, 7336.046313979148, 7518.699252029857, 9178.954105229432, 9280.95359523198, 9481.431114133175, 9500.144986951207], "unit": "score", "name": "jquery.html", "value": 8363.973667196982}, {"lowerIsBetter": false, "replicates": [1297.0920355750977, 1460.4961288355516, 1477.9778303325452, 1626.7885174927264, 1755.3680674957004, 6825.6928438220275, 7454.403647708184, 7593.392528597713, 7597.734079307225, 7610.124835643903, 7651.579163146025, 7803.843923121534, 7817.452778305521, 7819.413543984209, 7820.413468989835, 1872.0733237047612, 1916.8945707986056, 1926.8458523318102, 2327.17385328209, 2351.31811774586, 2328.3480625424822, 2399.520095980802, 2399.9280021599293, 2401.9759802401927, 2404.7475015123423, 2305.262316058862, 2305.8962346694357, 2332.8950197241165, 2356.599378105726, 2359.4573248152933, 2266.5580211858696, 2272.9545409091893, 2273.068042102738, 2275.294658655822, 2358.8820558971984, 2302.1597117052324, 2309.364924645719, 2311.5954707926044, 2314.6412306092584, 2329.615613423783, 8015.519068855829, 8017.438779285452, 8074.6770129194765, 8101.311388531982, 8112.918870811275, 4877.195262781637, 4980.078685443168, 5013.498650134994, 5019.171836646949, 5025.422076461181, 3195.2650890295363, 3214.1964508872784, 3247.155739507745, 3311.6688331166692, 3329.334133173351, 980.9742880950885, 1013.9594416223342, 1018.332991890313, 1025.3027941000116, 1035.9326643768206, 11087.168462365275, 11100.278481898651, 11129.220954533186, 11150.442477876155, 11156.497957591928, 4469.217886869785, 4515.480719717275, 4559.065391594715, 4581.381513495702, 4586.0, 9390.483523406141, 9431.764205894908, 9434.764130896783, 9442.433453992782, 9452.52737363129, 4893.388326459192, 4934.802607895644, 4935.0, 4941.678790878654, 4944.505549445099, 4442.755648439367, 4445.911081778347, 4451.532589078165, 4454.844080457168, 4455.554444555519, 3444.8277586120594, 3510.0347404463464, 3683.37382644951, 3830.597787232356, 3932.2135572885536, 1221.2123180548674, 1232.6240496648609, 1255.140228943177, 1256.5664845628244, 1265.1080987903506, 1060.4432672846663, 1069.005824583145, 1082.285691443659, 1220.7558488302375, 1323.8874695650784, 7295.306945840137, 7407.333339999426, 7410.333070023616, 7420.220876807965, 7444.032275804111, 1090.7436752363187, 1105.4086063955745, 1115.9497822598003, 1121.7027487715761, 1128.4357821089454, 5823.79616713413, 5976.342602313742, 5976.73104710289, 5979.9402005980255, 5986.3714309997695, 9465.66870159541, 9515.714528564155, 9656.95171524152, 9699.660511882192, 9841.065098815601, 9679.032096790264, 9681.225501959827, 9712.5143742814, 9712.805743885225, 9721.805563888682, 7209.6034718091005, 7353.816154596071, 7415.369693575999, 7420.814479637944, 7573.772786816405, 7352.5220860643885, 7415.3326200642205, 7502.699892004477, 7511.436642251743, 7519.1728909818785, 8478.448900821428, 8506.78733031679, 8550.0, 8657.480551166951, 8683.69607063775, 8718.302535797247, 8819.206271435345, 8840.98328692183, 8968.865467018131, 8969.372143950122, 7224.241454647186, 7277.053982982178, 7326.7069317226715, 7333.083364579427, 7345.669444874887, 6498.122753428227, 6594.208694956636, 6697.263301036979, 7091.0, 7732.613369331623, 7029.894551581628, 7085.82285442868, 7124.536905101152, 7212.531185472927, 7239.457040722073, 6892.620905850226, 6933.82665433348, 6971.0, 7102.0, 7102.112235970504, 7126.35862772353, 7170.749023784142, 7175.748848790267, 7179.282071792779, 7183.425325973805, 6366.93633063682, 6614.768483103068, 6620.04009418622, 6630.46956243509, 6635.668216589248, 6591.077249185022, 6620.5034622402545, 6624.735010599522, 6626.734930602722, 6638.0374845648075], "unit": "score", "name": "mootools.html", "value": 4576.007882778207}, {"lowerIsBetter": false, "replicates": [348.6234866344348, 349.4129861832124, 354.58690625421383, 354.90062782420915, 358.0493788990231, 5626.352969408509, 5782.797602083922, 5786.045302525084, 5795.913061304083, 5837.8832423351505, 5591.440855914407, 5745.166950792132, 5778.30660320761, 5785.652860828353, 5822.155787410834, 4492.258777301741, 4514.187446259672, 4515.638748900096, 4522.954770452303, 4523.954760452402, 4321.222180007598, 4385.079133381978, 4444.28891377378, 4500.8874778130485, 4541.727496350213, 4499.887502812423, 4506.278995360743, 4510.052888893337, 4522.706024108439, 4541.977290113561, 4501.392312037866, 4506.729596224204, 4519.796609152596, 4522.9321560176295, 4526.140033393661, 4025.496812898388, 4035.858744943913, 4037.3338399164104, 4038.1318016626565, 4043.413705012786, 5371.355437347504, 5520.696361700105, 5522.91715624266, 5531.976584331912, 5557.5831812614215, 5178.689278643294, 5180.585553155776, 5186.170212765977, 5194.11700010999, 5196.558292545138, 5811.82564523065, 6144.692765361714, 6154.292256390528, 6159.599626024339, 6162.383761623847, 4190.455240818705, 4212.53662097169, 4331.7184383015, 4335.56644335567, 4338.132373525307, 6249.843753906143, 6370.617762934193, 6373.362663733589, 6378.872422551523, 6382.553221274513, 4406.876246557107, 4408.919814645433, 4409.647228221735, 4410.426644536254, 4414.757188354607, 4348.326009468537, 4463.732176069446, 4469.687121901501, 4469.843555475542, 4505.6846020778885, 5157.406898206679, 5160.122779127557, 5161.509656582693, 5162.483751624883, 5164.7346400131455, 6146.416090471487, 6172.259328880563, 6184.134221209034, 6190.690465476709, 6190.876182476325, 1565.5225156327429, 1588.849059339384, 1590.0698091616302, 1590.90454572726, 1591.6020994751311, 1064.302881612545, 1071.1002757683584, 1078.7249251440833, 1083.06315037492, 1098.5880294889416, 5869.706514674249, 5873.647581145145, 5875.882482350329, 5878.5297176225795, 5882.823515294548, 6313.747450101944, 6337.6197428154455, 6344.555881088279, 6344.777932772331, 6350.0, 5820.563457740686, 5864.296284445893, 5869.031609784423, 5874.882502350015, 5881.647101173858, 3294.5387645729616, 3416.4533674611944, 3416.8633254669535, 3418.6239513653477, 3420.486926960976, 6543.411093001652, 6583.045458408504, 6590.703418346186, 6593.241777195588, 6599.406053455212, 6438.581492202992, 6456.160699109179, 6456.51576131792, 6468.06213099098, 6473.935260647428, 6350.5554611177695, 6558.245801732862, 6613.008048792623, 6613.437857782143, 6626.271110177973, 6130.570860039755, 6285.057241413824, 6363.3636636336, 6375.553711240169, 6379.457746091449, 6152.892479353581, 6319.0, 6319.46284565817, 6321.841953951188, 6330.778422755181, 6561.081448597296, 6598.1422415085735, 6609.933900660932, 6613.404793568409, 6625.436837868835, 4439.844605438794, 4447.888027993002, 4474.948387129087, 4475.597196252353, 4475.9328610071525, 6290.968545157245, 6292.1505596743855, 6301.369863013662, 6301.558890877594, 6309.274433440213, 6150.04674275488, 6180.949238629354, 6197.845053873689, 6199.907001395073, 6212.099245609452, 6040.697965101639, 6168.444839964424, 6181.258249010148, 6182.969085154546, 6192.195014648067, 6139.109829074849, 6147.323794382525, 6150.10823430609, 6150.323464419, 6153.29237137717, 6251.4061164189325, 6288.119663247057, 6290.2451705793765, 6292.716827742855, 6292.905606415999, 5923.822285331447, 6114.938850611437, 6142.692865356625, 6153.538484613761, 6153.6923153841235], "unit": "score", "name": "prototype.html", "value": 4678.742651400612}, {"lowerIsBetter": false, "replicates": [836.5022811427199, 851.506126446661, 854.1031916487689, 855.850226210413, 878.4553576782392, 11911.7617647647, 11980.880191198085, 11981.580644677439, 12003.579874704386, 12057.216280941733, 10760.623378181765, 10761.677149685522, 10762.73093172671, 10773.5690572377, 10780.19148563857, 658.3416583416583, 671.2750229751881, 800.403699244064, 820.5404973215019, 824.2746383182791, 811.4319976016783, 820.8071103290722, 823.9988414076895, 825.014108140772, 825.3397282174267, 677.156939610186, 855.7518319687283, 856.2080075929771, 856.4689892266804, 858.0732808566733, 684.5995092870677, 685.0990946904805, 686.2245662401505, 686.2691233835949, 826.6197549127409, 626.3266987987931, 627.2598333965964, 627.8210709947643, 627.9246490421133, 628.2555172121006, 11702.53189872404, 11725.237859539187, 11741.412929353499, 11750.882491175149, 11760.353180575064, 12384.504619815196, 12628.68428289291, 12642.367881605884, 12658.683532911658, 12897.355132243445, 10512.789744205149, 10588.205884558613, 10592.205584581186, 10697.572097116106, 10717.839232411443, 3591.3535563598543, 3660.4143337065943, 3722.013666378412, 3756.4740936268945, 3770.754900931458, 47069.76465117687, 47494.5250547497, 48087.519124808656, 48139.51860481386, 48342.51657483415, 10003.043016277661, 10150.949245253727, 10172.0, 10295.639652612272, 10307.330023548446, 16801.91599041997, 16962.23669934856, 16966.660666786844, 17000.404985825684, 17017.0, 7273.709051637875, 7351.595662238521, 7454.2545745426105, 7569.848603027908, 7660.387169026464, 4213.915721685549, 4406.5593440655675, 4410.33844923264, 4411.757353345597, 4417.116576684676, 3235.6602556731204, 3255.2675647979017, 3273.4107860585323, 3275.836208189581, 3275.836208189581, 594.5511139090046, 606.4117805728437, 614.9046897730859, 621.8445388652837, 636.6848410037061, 618.7555915413386, 632.250782822357, 635.726647459326, 662.9005649152666, 674.8920172772333, 8089.959550202211, 8904.554772261361, 8915.108489151162, 8932.732018039469, 9034.774130646787, 550.758784552901, 582.5747204540625, 583.439897698206, 613.4938675592654, 643.6363454648109, 3951.980240098781, 4041.4544036555276, 4068.6541643960004, 4150.418941348214, 4238.703290769617, 56284.43715562792, 56385.436145638836, 56412.153817692764, 56415.43584564184, 58512.12231816526, 49529.752351238014, 49561.50438495569, 49865.0, 50845.23732144021, 51015.0, 43572.564274357486, 44213.0, 44656.10687786226, 44974.0, 45568.54431455643, 8285.875711864206, 8369.66521339164, 8464.0, 8589.184027517376, 8626.008009079036, 32936.505952411215, 33843.66156338504, 34118.31763364768, 34624.82687586546, 34647.30705385929, 40928.59071409367, 41837.0, 44393.55606443894, 44765.0, 45223.773881130386, 10554.525046373084, 10743.570257189625, 10827.0, 10903.0, 11036.0, 11692.415379231175, 11990.280583165038, 12126.939365303117, 12651.557195498113, 12660.240385576895, 10809.459527023775, 10996.23026388145, 11591.6522504325, 11926.522939082339, 11964.461599227881, 11289.37908415045, 11578.536858525564, 11708.648740537797, 11900.068351345839, 11964.76070478603, 7224.819379515554, 9399.295052870926, 10777.676669699922, 10839.891601083888, 10855.348679079281, 9330.160285574331, 9422.670206543013, 9601.663941762004, 9646.324757266924, 9900.455474948947, 9671.323007389416, 9982.750431239278, 10037.799244015225, 10065.798684026426, 10091.091801737879], "unit": "score", "name": "yui.html", "value": 6175.445860111305}], "name": "dromaeo_css", "value": 6816.286690859083}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 108.0, 112.0, 112.0, 111.0, 109.0, 110.0, 104.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [157.0, 127.0, 154.0, 170.0, 127.0, 163.0, 159.0, 129.0, 162.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 162.0, 161.0, 162.0, 160.0, 160.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 95.0, 95.0, 76.0, 73.0, 75.0, 104.0, 102.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 142.0, 95.0, 97.0, 96.0, 140.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 56.0, 54.0, 61.0, 55.0, 58.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 67.0, 68.0, 73.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 81.0, 82.0, 83.0, 83.0, 83.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [115.0, 112.0, 113.0, 117.0, 120.0, 115.0, 120.0, 119.0, 120.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.5}, {"lowerIsBetter": true, "replicates": [143.0, 143.0, 143.0, 141.0, 141.0, 129.0, 153.0, 143.0, 142.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 70.0, 69.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1493.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.84155756965424], "unit": "score", "name": "Richards", "value": 210.32931599999992}, {"lowerIsBetter": false, "replicates": [190.3311762466692], "unit": "score", "name": "DeltaBlue", "value": 347.3839720000001}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1106.1946902654868], "unit": "score", "name": "RayTrace", "value": 668.9500559999998}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [42833.333333333336], "unit": "score", "name": "RegExp", "value": 21.268132295719834}, {"lowerIsBetter": false, "replicates": [568.8282138794084], "unit": "score", "name": "Splay", "value": 143.26117800000003}, {"lowerIsBetter": false, "replicates": [4812.5], "unit": "score", "name": "NavierStokes", "value": 308.3636363636364}], "name": "v8_7", "value": 20090.696607025307}]} 16:11:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20090.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1494.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6816.29"}}} 16:11:47 INFO - Return code: 0 16:11:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:11:47 INFO - # TBPL SUCCESS # 16:11:47 INFO - Running post-action listener: _resource_record_post_action 16:11:47 INFO - Running post-run listener: _resource_record_post_run 16:11:48 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 20480; Write bytes: 565796864; Read time: 172; Write time: 471324 16:11:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252956672; Read time: 0; Write time: 274360 16:11:48 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 20480; Write bytes: 312655872; Read time: 172; Write time: 196944 16:11:48 INFO - Running post-run listener: _upload_blobber_files 16:11:48 INFO - Blob upload gear active. 16:11:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:11:48 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 16:11:48 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'] 16:11:48 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 16:11:49 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:11:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:11:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:50 INFO - (blobuploader) - INFO - Done attempting. 16:11:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:51 INFO - (blobuploader) - INFO - Done attempting. 16:11:51 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:51 INFO - Return code: 0 16:11:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:11:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be57dca5ddfd5e7d47e695a6cd09c9b10c922375a560fc6aec350e1517c86fd9808fad7f4229cc85ff3a78e3c3840844eadb611a2c387a285100f83400f4b4ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb983433b43dd7bbcd9a6a65e2da5a55b860b80570778fefb73a5e056761a07303b7f49309402948c3ff19c99b374668e9aa8995ef7c64e20e5d2842432c067c"} 16:11:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:11:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:11:51 INFO - Contents: 16:11:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be57dca5ddfd5e7d47e695a6cd09c9b10c922375a560fc6aec350e1517c86fd9808fad7f4229cc85ff3a78e3c3840844eadb611a2c387a285100f83400f4b4ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb983433b43dd7bbcd9a6a65e2da5a55b860b80570778fefb73a5e056761a07303b7f49309402948c3ff19c99b374668e9aa8995ef7c64e20e5d2842432c067c"} 16:11:51 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:51 INFO - Copying logs to upload dir... 16:11:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:11:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.342053 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-22 16:11:51.017490) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 16:11:51.022097) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be57dca5ddfd5e7d47e695a6cd09c9b10c922375a560fc6aec350e1517c86fd9808fad7f4229cc85ff3a78e3c3840844eadb611a2c387a285100f83400f4b4ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb983433b43dd7bbcd9a6a65e2da5a55b860b80570778fefb73a5e056761a07303b7f49309402948c3ff19c99b374668e9aa8995ef7c64e20e5d2842432c067c"} build_url:https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/AmYvBSn8TCqBqd01I_Q-gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be57dca5ddfd5e7d47e695a6cd09c9b10c922375a560fc6aec350e1517c86fd9808fad7f4229cc85ff3a78e3c3840844eadb611a2c387a285100f83400f4b4ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb983433b43dd7bbcd9a6a65e2da5a55b860b80570778fefb73a5e056761a07303b7f49309402948c3ff19c99b374668e9aa8995ef7c64e20e5d2842432c067c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 16:11:51.047113) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:11:51.047424) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453505983.105470-1746789458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:11:51.149028) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 16:11:51.149318) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 16:11:51.149585) ========= ========= Total master_lag: 0.35 =========