builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1453413612.49 results: success (0) buildid: 20160121113025 builduid: 2d178b69b52a41e7a3db1bca7aae6b65 revision: 2155aa176b08a59c0bf2ef54a8882361ce152b80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:12.489972) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:12.490461) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:12.490822) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006354 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:12.514751) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:12.515080) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:12.529110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:12.529453) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:12.581943) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:12.582245) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:12.582618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:12.582898) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 14:00:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-01-21 14:00:13 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.450995 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:13.046173) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:13.046486) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016757 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:13.098325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:13.099027) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 2155aa176b08a59c0bf2ef54a8882361ce152b80 --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/b2g-inbound --rev 2155aa176b08a59c0bf2ef54a8882361ce152b80 --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=5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 14:00:13,732 truncating revision to first 12 chars 2016-01-21 14:00:13,732 Setting DEBUG logging. 2016-01-21 14:00:13,732 attempt 1/10 2016-01-21 14:00:13,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/2155aa176b08?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 14:00:13,993 unpacking tar archive at: b2g-inbound-2155aa176b08/testing/mozharness/ program finished with exit code 0 elapsedTime=0.570316 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:13.685157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:13.685567) ========= echo 2155aa176b08a59c0bf2ef54a8882361ce152b80 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2155aa176b08a59c0bf2ef54a8882361ce152b80'] 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=5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2155aa176b08a59c0bf2ef54a8882361ce152b80 program finished with exit code 0 elapsedTime=0.004244 script_repo_revision: '2155aa176b08a59c0bf2ef54a8882361ce152b80' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:13.736195) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:13.736567) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 14:00:13.747311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-21 14:00:13.747732) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:00:14 INFO - MultiFileLogger online at 20160121 14:00:14 in /builds/slave/test-pgo 14:00:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 14:00:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:00:14 INFO - {'append_to_log': False, 14:00:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:00:14 INFO - 'blob_upload_branch': 'B2G-Inbound', 14:00:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:00:14 INFO - 'branch': 'B2G-Inbound', 14:00:14 INFO - 'buildbot_json_path': 'buildprops.json', 14:00:14 INFO - 'config_files': ('talos/linux_config.py',), 14:00:14 INFO - 'default_actions': ('clobber', 14:00:14 INFO - 'read-buildbot-config', 14:00:14 INFO - 'download-and-extract', 14:00:14 INFO - 'populate-webroot', 14:00:14 INFO - 'create-virtualenv', 14:00:14 INFO - 'install', 14:00:14 INFO - 'run-tests'), 14:00:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:00:14 INFO - 'download_minidump_stackwalk': True, 14:00:14 INFO - 'download_symbols': 'ondemand', 14:00:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:00:14 INFO - 'tooltool.py': '/tools/tooltool.py', 14:00:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:00:14 INFO - '/tools/misc-python/virtualenv.py')}, 14:00:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:00:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:00:14 INFO - 'installer_path': 'installer.exe', 14:00:14 INFO - 'log_level': 'info', 14:00:14 INFO - 'log_name': 'talos', 14:00:14 INFO - 'log_to_console': True, 14:00:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:00:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:00:14 INFO - 'opt_config_files': (), 14:00:14 INFO - 'pip_index': False, 14:00:14 INFO - 'sps_profile': False, 14:00:14 INFO - 'sps_profile_interval': 0, 14:00:14 INFO - 'suite': 'dromaeojs', 14:00:14 INFO - 'system_bits': '32', 14:00:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:00:14 INFO - 'title': 'talos-linux64-ix-039', 14:00:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:00:14 INFO - 'use_talos_json': True, 14:00:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:00:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:00:14 INFO - 'work_dir': 'build'} 14:00:14 INFO - ##### 14:00:14 INFO - ##### Running clobber step. 14:00:14 INFO - ##### 14:00:14 INFO - Running pre-action listener: _resource_record_pre_action 14:00:14 INFO - Running main action method: clobber 14:00:14 INFO - rmtree: /builds/slave/test-pgo/build 14:00:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:00:15 INFO - Running post-action listener: _resource_record_post_action 14:00:15 INFO - ##### 14:00:15 INFO - ##### Running read-buildbot-config step. 14:00:15 INFO - ##### 14:00:15 INFO - Running pre-action listener: _resource_record_pre_action 14:00:15 INFO - Running main action method: read_buildbot_config 14:00:15 INFO - Using buildbot properties: 14:00:15 INFO - { 14:00:15 INFO - "project": "", 14:00:15 INFO - "product": "firefox", 14:00:15 INFO - "script_repo_revision": "production", 14:00:15 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 14:00:15 INFO - "repository": "", 14:00:15 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 14:00:15 INFO - "buildid": "20160121113025", 14:00:15 INFO - "pgo_build": "True", 14:00:15 INFO - "basedir": "/builds/slave/test-pgo", 14:00:15 INFO - "buildnumber": 222, 14:00:15 INFO - "slavename": "talos-linux64-ix-039", 14:00:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:00:15 INFO - "platform": "ubuntu64_hw", 14:00:15 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 14:00:15 INFO - "branch": "b2g-inbound", 14:00:15 INFO - "repo_path": "integration/b2g-inbound", 14:00:15 INFO - "revision": "2155aa176b08a59c0bf2ef54a8882361ce152b80", 14:00:15 INFO - "stage_platform": "linux64-pgo", 14:00:15 INFO - "builduid": "2d178b69b52a41e7a3db1bca7aae6b65", 14:00:15 INFO - "slavebuilddir": "test" 14:00:15 INFO - } 14:00:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:00:15 INFO - Running post-action listener: _resource_record_post_action 14:00:15 INFO - ##### 14:00:15 INFO - ##### Running download-and-extract step. 14:00:15 INFO - ##### 14:00:15 INFO - Running pre-action listener: _resource_record_pre_action 14:00:15 INFO - Running main action method: download_and_extract 14:00:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:15 INFO - https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:00:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/test_packages.json 14:00:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/test_packages.json 14:00:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:00:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:00:16 INFO - Downloaded 1448 bytes. 14:00:16 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:00:16 INFO - Using the following test package requirements: 14:00:16 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:00:16 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:00:16 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:00:16 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:16 INFO - u'jsshell-linux-x86_64.zip'], 14:00:16 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:00:16 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:00:16 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:00:16 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:00:16 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:00:16 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:00:16 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:00:16 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:00:16 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')]} 14:00:16 INFO - https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:00:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:00:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:00:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/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 14:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/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 14:00:17 INFO - Downloaded 22487094 bytes. 14:00:17 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'] 14:00:17 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 14:00:18 INFO - Return code: 0 14:00:18 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 14:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:18 INFO - https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:00:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:00:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:00:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/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 14:00:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/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 14:00:26 INFO - Downloaded 22487094 bytes. 14:00:26 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'] 14:00:26 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 14:00:27 INFO - Return code: 0 14:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:27 INFO - https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:00:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:00:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:00:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/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 14:00:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/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 14:00:31 INFO - Downloaded 10705515 bytes. 14:00:31 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'] 14:00:31 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 14:00:31 INFO - Return code: 0 14:00:31 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')]} 14:00:31 INFO - https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:00:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:00:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:00:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/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 14:00:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/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 14:00:33 INFO - Downloaded 55938526 bytes. 14:00:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:00:33 INFO - mkdir: /builds/slave/test-pgo/properties 14:00:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:00:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:00:33 INFO - Contents: 14:00:33 INFO - build_url:https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:00:33 INFO - Running post-action listener: _resource_record_post_action 14:00:33 INFO - Running post-action listener: set_extra_try_arguments 14:00:33 INFO - ##### 14:00:33 INFO - ##### Running populate-webroot step. 14:00:33 INFO - ##### 14:00:33 INFO - Running pre-action listener: _resource_record_pre_action 14:00:33 INFO - Running main action method: populate_webroot 14:00:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:00:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:00:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:00:33 INFO - '--tppagecycles', 14:00:33 INFO - '7'], 14:00:33 INFO - 'tests': ['tsvgm']}}, 14:00:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:00:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:00:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:00:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:00:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:00:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:00:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:00:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:33 INFO - 'talos_options': ['--e10s'], 14:00:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:00:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:33 INFO - 'tests': ['damp', 'tps']}, 14:00:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:33 INFO - 'talos_options': ['--e10s'], 14:00:33 INFO - 'tests': ['damp', 'tps']}, 14:00:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:00:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:00:33 INFO - 'other': {'tests': ['a11yr', 14:00:33 INFO - 'ts_paint', 14:00:33 INFO - 'tpaint', 14:00:33 INFO - 'sessionrestore', 14:00:33 INFO - 'sessionrestore_no_auto_restore']}, 14:00:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:00:33 INFO - 'tests': ['a11yr', 14:00:33 INFO - 'ts_paint', 14:00:33 INFO - 'tpaint', 14:00:33 INFO - 'sessionrestore', 14:00:33 INFO - 'sessionrestore_no_auto_restore']}, 14:00:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:00:33 INFO - 'tests': ['a11yr', 14:00:33 INFO - 'ts_paint', 14:00:33 INFO - 'tpaint', 14:00:33 INFO - 'sessionrestore', 14:00:33 INFO - 'sessionrestore_no_auto_restore']}, 14:00:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:00:33 INFO - 'tests': ['a11yr', 14:00:33 INFO - 'ts_paint', 14:00:33 INFO - 'tpaint', 14:00:33 INFO - 'sessionrestore', 14:00:33 INFO - 'sessionrestore_no_auto_restore']}, 14:00:33 INFO - 'other_l64': {'tests': ['a11yr', 14:00:33 INFO - 'ts_paint', 14:00:33 INFO - 'tpaint', 14:00:33 INFO - 'sessionrestore', 14:00:33 INFO - 'sessionrestore_no_auto_restore']}, 14:00:33 INFO - 'other_nol64': {'tests': ['a11yr', 14:00:33 INFO - 'ts_paint', 14:00:33 INFO - 'tpaint', 14:00:33 INFO - 'sessionrestore', 14:00:33 INFO - 'sessionrestore_no_auto_restore']}, 14:00:33 INFO - 'svgr': {'tests': ['tsvgx', 14:00:33 INFO - 'tsvgr_opacity', 14:00:33 INFO - 'tart', 14:00:33 INFO - 'tscrollx', 14:00:33 INFO - 'cart']}, 14:00:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:00:33 INFO - 'tests': ['tsvgx', 14:00:33 INFO - 'tsvgr_opacity', 14:00:33 INFO - 'tart', 14:00:33 INFO - 'tscrollx', 14:00:33 INFO - 'cart']}, 14:00:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:33 INFO - 'tests': ['tp5o']}, 14:00:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:33 INFO - 'talos_options': ['--e10s'], 14:00:33 INFO - 'tests': ['tp5o']}, 14:00:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:33 INFO - 'talos_options': ['--xperf_path', 14:00:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:00:33 INFO - 'tests': ['tp5n']}, 14:00:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:33 INFO - 'talos_options': ['--e10s', 14:00:33 INFO - '--xperf_path', 14:00:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:00:33 INFO - 'tests': ['tp5n']}}, 14:00:33 INFO - 'talos.zip': {'path': '', 14:00:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:00:33 INFO - Running post-action listener: _resource_record_post_action 14:00:33 INFO - ##### 14:00:33 INFO - ##### Running create-virtualenv step. 14:00:33 INFO - ##### 14:00:33 INFO - Running pre-action listener: _resource_record_pre_action 14:00:33 INFO - Running main action method: create_virtualenv 14:00:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:00:33 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 14:00:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:00:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:00:33 INFO - Using real prefix '/usr' 14:00:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:00:33 INFO - Installing distribute.............................................................................................................................................................................................done. 14:00:35 INFO - Installing pip.................done. 14:00:35 INFO - Return code: 0 14:00:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:00:35 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')]} 14:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:35 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')]} 14:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:35 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 0x7f8ed0c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1073630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104840>, '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 0x10716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', '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 14:00:35 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 14:00:35 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 14:00:35 INFO - Using env: {'DISPLAY': ':0', 14:00:35 INFO - 'HOME': '/home/cltbld', 14:00:35 INFO - 'LANG': 'en_US.UTF-8', 14:00:35 INFO - 'LANGUAGE': 'en_US:en', 14:00:35 INFO - 'LOGNAME': 'cltbld', 14:00:35 INFO - 'MAIL': '/var/mail/cltbld', 14:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:35 INFO - 'MOZ_NO_REMOTE': '1', 14:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:35 INFO - 'NO_EM_RESTART': '1', 14:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:35 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:35 INFO - 'SHELL': '/bin/bash', 14:00:35 INFO - 'SHLVL': '1', 14:00:35 INFO - 'TERM': 'linux', 14:00:35 INFO - 'TMOUT': '86400', 14:00:35 INFO - 'USER': 'cltbld', 14:00:35 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', 14:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:35 INFO - '_': '/tools/buildbot/bin/python'} 14:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:36 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 14:00:36 INFO - Cleaning up... 14:00:36 INFO - Return code: 0 14:00:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:00:36 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')]} 14:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:36 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')]} 14:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:36 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 0x7f8ed0c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1073630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104840>, '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 0x10716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', '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 14:00:36 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 14:00:36 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 14:00:36 INFO - Using env: {'DISPLAY': ':0', 14:00:36 INFO - 'HOME': '/home/cltbld', 14:00:36 INFO - 'LANG': 'en_US.UTF-8', 14:00:36 INFO - 'LANGUAGE': 'en_US:en', 14:00:36 INFO - 'LOGNAME': 'cltbld', 14:00:36 INFO - 'MAIL': '/var/mail/cltbld', 14:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:36 INFO - 'MOZ_NO_REMOTE': '1', 14:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:36 INFO - 'NO_EM_RESTART': '1', 14:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:36 INFO - 'SHELL': '/bin/bash', 14:00:36 INFO - 'SHLVL': '1', 14:00:36 INFO - 'TERM': 'linux', 14:00:36 INFO - 'TMOUT': '86400', 14:00:36 INFO - 'USER': 'cltbld', 14:00:36 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', 14:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:36 INFO - '_': '/tools/buildbot/bin/python'} 14:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:36 INFO - Downloading/unpacking psutil>=0.7.1 14:00:36 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 14:00:36 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 14:00:36 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 14:00:36 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 14:00:36 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 14:00:36 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 14:00:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:00:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:00:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:00:38 INFO - Installing collected packages: psutil 14:00:38 INFO - Running setup.py install for psutil 14:00:38 INFO - building 'psutil._psutil_linux' extension 14:00:38 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 14:00:38 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 14:00:38 INFO - building 'psutil._psutil_posix' extension 14:00:38 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 14:00:38 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 14:00:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:00:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:00:38 INFO - Successfully installed psutil 14:00:38 INFO - Cleaning up... 14:00:38 INFO - Return code: 0 14:00:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ed0c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1073630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104840>, '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 0x10716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', '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 14:00:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:00:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:00:38 INFO - Using env: {'DISPLAY': ':0', 14:00:38 INFO - 'HOME': '/home/cltbld', 14:00:38 INFO - 'LANG': 'en_US.UTF-8', 14:00:38 INFO - 'LANGUAGE': 'en_US:en', 14:00:38 INFO - 'LOGNAME': 'cltbld', 14:00:38 INFO - 'MAIL': '/var/mail/cltbld', 14:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:38 INFO - 'MOZ_NO_REMOTE': '1', 14:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:38 INFO - 'NO_EM_RESTART': '1', 14:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:38 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:38 INFO - 'SHELL': '/bin/bash', 14:00:38 INFO - 'SHLVL': '1', 14:00:38 INFO - 'TERM': 'linux', 14:00:38 INFO - 'TMOUT': '86400', 14:00:38 INFO - 'USER': 'cltbld', 14:00:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', 14:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:38 INFO - '_': '/tools/buildbot/bin/python'} 14:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:00:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:00:40 INFO - Installing collected packages: mozsystemmonitor 14:00:40 INFO - Running setup.py install for mozsystemmonitor 14:00:40 INFO - Successfully installed mozsystemmonitor 14:00:40 INFO - Cleaning up... 14:00:40 INFO - Return code: 0 14:00:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:00: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')]} 14:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ed0c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1073630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104840>, '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 0x10716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', '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 14:00:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:00:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:00:40 INFO - Using env: {'DISPLAY': ':0', 14:00:40 INFO - 'HOME': '/home/cltbld', 14:00:40 INFO - 'LANG': 'en_US.UTF-8', 14:00:40 INFO - 'LANGUAGE': 'en_US:en', 14:00:40 INFO - 'LOGNAME': 'cltbld', 14:00:40 INFO - 'MAIL': '/var/mail/cltbld', 14:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:40 INFO - 'MOZ_NO_REMOTE': '1', 14:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:40 INFO - 'NO_EM_RESTART': '1', 14:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:40 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:40 INFO - 'SHELL': '/bin/bash', 14:00:40 INFO - 'SHLVL': '1', 14:00:40 INFO - 'TERM': 'linux', 14:00:40 INFO - 'TMOUT': '86400', 14:00:40 INFO - 'USER': 'cltbld', 14:00:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', 14:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:40 INFO - '_': '/tools/buildbot/bin/python'} 14:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:00:41 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 14:00:41 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 14:00:41 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 14:00:41 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 14:00:41 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 14:00:41 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 14:00:42 INFO - Downloading blobuploader-1.2.4.tar.gz 14:00:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:00:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:00:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:00:43 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 14:00:43 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 14:00:43 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 14:00:43 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 14:00:43 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 14:00:43 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 14:00:43 INFO - Downloading docopt-0.6.1.tar.gz 14:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:00:43 INFO - Installing collected packages: blobuploader, requests, docopt 14:00:43 INFO - Running setup.py install for blobuploader 14:00:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:00:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:00:43 INFO - Running setup.py install for requests 14:00:43 INFO - Running setup.py install for docopt 14:00:44 INFO - Successfully installed blobuploader requests docopt 14:00:44 INFO - Cleaning up... 14:00:44 INFO - Return code: 0 14:00:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:44 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 0x7f8ed0c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1073630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104840>, '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 0x10716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', '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 14:00:44 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 14:00:44 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 14:00:44 INFO - Using env: {'DISPLAY': ':0', 14:00:44 INFO - 'HOME': '/home/cltbld', 14:00:44 INFO - 'LANG': 'en_US.UTF-8', 14:00:44 INFO - 'LANGUAGE': 'en_US:en', 14:00:44 INFO - 'LOGNAME': 'cltbld', 14:00:44 INFO - 'MAIL': '/var/mail/cltbld', 14:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:44 INFO - 'MOZ_NO_REMOTE': '1', 14:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:44 INFO - 'NO_EM_RESTART': '1', 14:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:44 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:44 INFO - 'SHELL': '/bin/bash', 14:00:44 INFO - 'SHLVL': '1', 14:00:44 INFO - 'TERM': 'linux', 14:00:44 INFO - 'TMOUT': '86400', 14:00:44 INFO - 'USER': 'cltbld', 14:00:44 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', 14:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:44 INFO - '_': '/tools/buildbot/bin/python'} 14:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:00:44 INFO - Running setup.py (path:/tmp/pip-N2DBQt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:00:44 INFO - Running setup.py (path:/tmp/pip-N6Hl7q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:00:44 INFO - Running setup.py (path:/tmp/pip-LSYBU9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:00:44 INFO - Running setup.py (path:/tmp/pip-MRxZ50-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:00:44 INFO - Running setup.py (path:/tmp/pip-c3jC7t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:00:44 INFO - Running setup.py (path:/tmp/pip-n19JIi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:00:44 INFO - Running setup.py (path:/tmp/pip-bMgaAl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:00:44 INFO - Running setup.py (path:/tmp/pip-4qaxHO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:00:44 INFO - Running setup.py (path:/tmp/pip-NlQBAu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:00:44 INFO - Running setup.py (path:/tmp/pip-yVM9Gw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:00:45 INFO - Running setup.py (path:/tmp/pip-hfakS6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:00:45 INFO - Running setup.py (path:/tmp/pip-nEMrhu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:00:45 INFO - Running setup.py (path:/tmp/pip-hdfDSI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:00:45 INFO - Running setup.py (path:/tmp/pip-yNwwQz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:00:45 INFO - Running setup.py (path:/tmp/pip-Rm79J4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:00:45 INFO - Running setup.py (path:/tmp/pip-1SV8za-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:00:45 INFO - Running setup.py (path:/tmp/pip-SNTLmI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:00:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:00:45 INFO - Running setup.py install for manifestparser 14:00:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:00:45 INFO - Running setup.py install for mozcrash 14:00:45 INFO - Running setup.py install for mozdebug 14:00:45 INFO - Running setup.py install for mozdevice 14:00:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:00:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:00:45 INFO - Running setup.py install for mozfile 14:00:46 INFO - Running setup.py install for mozhttpd 14:00:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:00:46 INFO - Running setup.py install for mozinfo 14:00:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:00:46 INFO - Running setup.py install for mozInstall 14:00:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:00:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:00:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:00:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:00:46 INFO - Running setup.py install for mozleak 14:00:46 INFO - Running setup.py install for mozlog 14:00:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:00:46 INFO - Running setup.py install for moznetwork 14:00:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:00:46 INFO - Running setup.py install for mozprocess 14:00:46 INFO - Running setup.py install for mozprofile 14:00:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:00:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:00:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:00:46 INFO - Running setup.py install for mozrunner 14:00:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:00:47 INFO - Running setup.py install for mozscreenshot 14:00:47 INFO - Running setup.py install for moztest 14:00:47 INFO - Running setup.py install for mozversion 14:00:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:00:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:00:47 INFO - Cleaning up... 14:00:47 INFO - Return code: 0 14:00:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:00: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')]} 14:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:47 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 0x7f8ed0c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1073630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104840>, '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 0x10716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', '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 14:00:47 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 14:00:47 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 14:00:47 INFO - Using env: {'DISPLAY': ':0', 14:00:47 INFO - 'HOME': '/home/cltbld', 14:00:47 INFO - 'LANG': 'en_US.UTF-8', 14:00:47 INFO - 'LANGUAGE': 'en_US:en', 14:00:47 INFO - 'LOGNAME': 'cltbld', 14:00:47 INFO - 'MAIL': '/var/mail/cltbld', 14:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:47 INFO - 'MOZ_NO_REMOTE': '1', 14:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:47 INFO - 'NO_EM_RESTART': '1', 14:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:47 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:47 INFO - 'SHELL': '/bin/bash', 14:00:47 INFO - 'SHLVL': '1', 14:00:47 INFO - 'TERM': 'linux', 14:00:47 INFO - 'TMOUT': '86400', 14:00:47 INFO - 'USER': 'cltbld', 14:00:47 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', 14:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:47 INFO - '_': '/tools/buildbot/bin/python'} 14:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:00:47 INFO - Running setup.py (path:/tmp/pip-ZTSXga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:00:47 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)) 14:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:00:47 INFO - Running setup.py (path:/tmp/pip-7HQk_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:00:47 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)) 14:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:00:47 INFO - Running setup.py (path:/tmp/pip-y5wfKD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:00:47 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)) 14:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:00:47 INFO - Running setup.py (path:/tmp/pip-tlD9QB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:00:47 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)) 14:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:00:47 INFO - Running setup.py (path:/tmp/pip-KlB740-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:00:47 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)) 14:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:00:47 INFO - Running setup.py (path:/tmp/pip-9HHzHC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:00:47 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)) 14:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:00:47 INFO - Running setup.py (path:/tmp/pip-LAteAZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:00:48 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)) 14:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:00:48 INFO - Running setup.py (path:/tmp/pip-jIuW65-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:00:48 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)) 14:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:00:48 INFO - Running setup.py (path:/tmp/pip-7SVonb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:00:48 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)) 14:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:00:48 INFO - Running setup.py (path:/tmp/pip-40FHCm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:00:48 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)) 14:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:00:48 INFO - Running setup.py (path:/tmp/pip-9QkmCW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:00:48 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)) 14:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:00:48 INFO - Running setup.py (path:/tmp/pip-MEPRNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:00:48 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)) 14:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:00:48 INFO - Running setup.py (path:/tmp/pip-lPqS6g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:00:48 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)) 14:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:00:48 INFO - Running setup.py (path:/tmp/pip-vzr9T2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:00:48 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)) 14:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:00:48 INFO - Running setup.py (path:/tmp/pip-rS9An8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:00:48 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)) 14:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:00:48 INFO - Running setup.py (path:/tmp/pip-eZbRpD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:00:48 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)) 14:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:00:48 INFO - Running setup.py (path:/tmp/pip-Un54V7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:00:48 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)) 14:00:48 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)) 14:00:48 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)) 14:00:48 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)) 14:00:48 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)) 14:00:48 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)) 14:00:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:00:48 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 14:00:48 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 14:00:48 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 14:00:48 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 14:00:48 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 14:00:48 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 14:00:50 INFO - Downloading blessings-1.6.tar.gz 14:00:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:00:50 INFO - Installing collected packages: blessings 14:00:50 INFO - Running setup.py install for blessings 14:00:50 INFO - Successfully installed blessings 14:00:50 INFO - Cleaning up... 14:00:50 INFO - Return code: 0 14:00:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:00:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:00:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:00:50 INFO - Reading from file tmpfile_stdout 14:00:50 INFO - Current package versions: 14:00:50 INFO - argparse == 1.2.1 14:00:50 INFO - blessings == 1.6 14:00:50 INFO - blobuploader == 1.2.4 14:00:50 INFO - docopt == 0.6.1 14:00:50 INFO - manifestparser == 1.1 14:00:50 INFO - mozInstall == 1.12 14:00:50 INFO - mozcrash == 0.16 14:00:50 INFO - mozdebug == 0.1 14:00:50 INFO - mozdevice == 0.48 14:00:50 INFO - mozfile == 1.2 14:00:50 INFO - mozhttpd == 0.7 14:00:50 INFO - mozinfo == 0.9 14:00:50 INFO - mozleak == 0.1 14:00:50 INFO - mozlog == 3.1 14:00:50 INFO - moznetwork == 0.27 14:00:50 INFO - mozprocess == 0.22 14:00:50 INFO - mozprofile == 0.28 14:00:50 INFO - mozrunner == 6.11 14:00:50 INFO - mozscreenshot == 0.1 14:00:50 INFO - mozsystemmonitor == 0.0 14:00:50 INFO - moztest == 0.7 14:00:50 INFO - mozversion == 1.4 14:00:50 INFO - psutil == 3.1.1 14:00:50 INFO - requests == 1.2.3 14:00:50 INFO - wsgiref == 0.1.2 14:00:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:00: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')]} 14:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:51 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')]} 14:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:51 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 0x7f8ed0c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1073630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104840>, '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 0x10716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', '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 14:00:51 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 14:00:51 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 14:00:51 INFO - Using env: {'DISPLAY': ':0', 14:00:51 INFO - 'HOME': '/home/cltbld', 14:00:51 INFO - 'LANG': 'en_US.UTF-8', 14:00:51 INFO - 'LANGUAGE': 'en_US:en', 14:00:51 INFO - 'LOGNAME': 'cltbld', 14:00:51 INFO - 'MAIL': '/var/mail/cltbld', 14:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:51 INFO - 'MOZ_NO_REMOTE': '1', 14:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:51 INFO - 'NO_EM_RESTART': '1', 14:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:51 INFO - 'SHELL': '/bin/bash', 14:00:51 INFO - 'SHLVL': '1', 14:00:51 INFO - 'TERM': 'linux', 14:00:51 INFO - 'TMOUT': '86400', 14:00:51 INFO - 'USER': 'cltbld', 14:00:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', 14:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:51 INFO - '_': '/tools/buildbot/bin/python'} 14:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:51 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)) 14:00:51 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)) 14:00:51 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)) 14:00:51 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)) 14:00:51 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)) 14:00:51 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)) 14:00:51 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)) 14:00:51 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)) 14:00:51 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)) 14:00:51 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)) 14:00:51 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)) 14:00:51 INFO - Cleaning up... 14:00:51 INFO - Return code: 0 14:00:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:00:51 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')]} 14:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:51 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')]} 14:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:51 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 0x7f8ed0c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1073630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104840>, '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 0x10716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', '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 14:00:51 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 14:00:51 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 14:00:51 INFO - Using env: {'DISPLAY': ':0', 14:00:51 INFO - 'HOME': '/home/cltbld', 14:00:51 INFO - 'LANG': 'en_US.UTF-8', 14:00:51 INFO - 'LANGUAGE': 'en_US:en', 14:00:51 INFO - 'LOGNAME': 'cltbld', 14:00:51 INFO - 'MAIL': '/var/mail/cltbld', 14:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:51 INFO - 'MOZ_NO_REMOTE': '1', 14:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:51 INFO - 'NO_EM_RESTART': '1', 14:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:51 INFO - 'SHELL': '/bin/bash', 14:00:51 INFO - 'SHLVL': '1', 14:00:51 INFO - 'TERM': 'linux', 14:00:51 INFO - 'TMOUT': '86400', 14:00:51 INFO - 'USER': 'cltbld', 14:00:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', 14:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:51 INFO - '_': '/tools/buildbot/bin/python'} 14:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:51 INFO - Downloading/unpacking jsonschema 14:00:51 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 14:00:51 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 14:00:51 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 14:00:51 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 14:00:51 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 14:00:51 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 14:00:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:00:53 INFO - Downloading/unpacking functools32 (from jsonschema) 14:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:53 INFO - Downloading functools32-3.2.3-2.tar.gz 14:00:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:00:53 INFO - warning: no files found matching '*.txt' 14:00:53 INFO - no previously-included directories found matching 'build' 14:00:53 INFO - no previously-included directories found matching 'dist' 14:00:53 INFO - no previously-included directories found matching '.git*' 14:00:53 INFO - Installing collected packages: jsonschema, functools32 14:00:53 INFO - Running setup.py install for functools32 14:00:53 INFO - warning: no files found matching '*.txt' 14:00:53 INFO - no previously-included directories found matching 'build' 14:00:53 INFO - no previously-included directories found matching 'dist' 14:00:53 INFO - no previously-included directories found matching '.git*' 14:00:53 INFO - Successfully installed jsonschema functools32 14:00:53 INFO - Cleaning up... 14:00:53 INFO - Return code: 0 14:00:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:53 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 0x7f8ed0c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1073630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104840>, '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 0x10716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', '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 14:00:53 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 14:00:53 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 14:00:53 INFO - Using env: {'DISPLAY': ':0', 14:00:53 INFO - 'HOME': '/home/cltbld', 14:00:53 INFO - 'LANG': 'en_US.UTF-8', 14:00:53 INFO - 'LANGUAGE': 'en_US:en', 14:00:53 INFO - 'LOGNAME': 'cltbld', 14:00:53 INFO - 'MAIL': '/var/mail/cltbld', 14:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:53 INFO - 'MOZ_NO_REMOTE': '1', 14:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:53 INFO - 'NO_EM_RESTART': '1', 14:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:53 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:53 INFO - 'SHELL': '/bin/bash', 14:00:53 INFO - 'SHLVL': '1', 14:00:53 INFO - 'TERM': 'linux', 14:00:53 INFO - 'TMOUT': '86400', 14:00:53 INFO - 'USER': 'cltbld', 14:00:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', 14:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:53 INFO - '_': '/tools/buildbot/bin/python'} 14:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:53 INFO - Downloading/unpacking flake8 14:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:00:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:00:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:00:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:00:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:00:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:00:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:00:56 INFO - no previously-included directories found matching 'docs/_build' 14:00:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:00:56 INFO - Running setup.py install for pep8 14:00:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:00:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:00:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:00:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:00:56 INFO - no previously-included directories found matching 'docs/_build' 14:00:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:00:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:00:56 INFO - Cleaning up... 14:00:56 INFO - Return code: 0 14:00:56 INFO - Running post-action listener: _resource_record_post_action 14:00:56 INFO - Running post-action listener: _start_resource_monitoring 14:00:56 INFO - Starting resource monitoring. 14:00:56 INFO - ##### 14:00:56 INFO - ##### Running install step. 14:00:56 INFO - ##### 14:00:56 INFO - Running pre-action listener: _resource_record_pre_action 14:00:56 INFO - Running main action method: install 14:00:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:00:56 INFO - Reading from file tmpfile_stdout 14:00:56 INFO - Detecting whether we're running mozinstall >=1.0... 14:00:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:00:56 INFO - Reading from file tmpfile_stdout 14:00:56 INFO - Output received: 14:00:56 INFO - Usage: mozinstall [options] installer 14:00:56 INFO - Options: 14:00:56 INFO - -h, --help show this help message and exit 14:00:56 INFO - -d DEST, --destination=DEST 14:00:56 INFO - Directory to install application into. [default: 14:00:56 INFO - "/builds/slave/test-pgo"] 14:00:56 INFO - --app=APP Application being installed. [default: firefox] 14:00:56 INFO - mkdir: /builds/slave/test-pgo/build/application 14:00:56 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'] 14:00:56 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 14:01:13 INFO - Reading from file tmpfile_stdout 14:01:13 INFO - Output received: 14:01:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:01:13 INFO - Running post-action listener: _resource_record_post_action 14:01:13 INFO - ##### 14:01:13 INFO - ##### Running run-tests step. 14:01:13 INFO - ##### 14:01:13 INFO - Running pre-action listener: _resource_record_pre_action 14:01:13 INFO - Running main action method: run_tests 14:01:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:01:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:01:13 INFO - Python 2.7.3 14:01:13 INFO - Return code: 0 14:01:13 INFO - grabbing minidump binary from tooltool 14:01:13 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')]} 14:01:13 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 0x1104840>, '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 0x10716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:01:13 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 14:01:13 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 14:01:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:01:13 INFO - Return code: 0 14:01:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:01:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:01:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:01:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:01:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:01:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:01:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:01:14 INFO - Return code: 0 14:01:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 14:01:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 14:01:14 INFO - Using env: {'DISPLAY': ':0', 14:01:14 INFO - 'HOME': '/home/cltbld', 14:01:14 INFO - 'LANG': 'en_US.UTF-8', 14:01:14 INFO - 'LANGUAGE': 'en_US:en', 14:01:14 INFO - 'LOGNAME': 'cltbld', 14:01:14 INFO - 'MAIL': '/var/mail/cltbld', 14:01:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:01:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:14 INFO - 'MOZ_NO_REMOTE': '1', 14:01:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:14 INFO - 'NO_EM_RESTART': '1', 14:01:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:14 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:01:14 INFO - 'SHELL': '/bin/bash', 14:01:14 INFO - 'SHLVL': '1', 14:01:14 INFO - 'TERM': 'linux', 14:01:14 INFO - 'TMOUT': '86400', 14:01:14 INFO - 'USER': 'cltbld', 14:01:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130', 14:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:14 INFO - '_': '/tools/buildbot/bin/python'} 14:01:14 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 14:01:14 INFO - mozversion application_buildid: 20160121113025 14:01:14 INFO - mozversion application_changeset: 2155aa176b08a59c0bf2ef54a8882361ce152b80 14:01:14 INFO - mozversion application_display_name: Nightly 14:01:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:01:14 INFO - mozversion application_name: Firefox 14:01:14 INFO - mozversion application_remotingname: firefox 14:01:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 14:01:14 INFO - mozversion application_vendor: Mozilla 14:01:14 INFO - mozversion application_version: 46.0a1 14:01:14 INFO - mozversion platform_buildid: 20160121113025 14:01:14 INFO - mozversion platform_changeset: 2155aa176b08a59c0bf2ef54a8882361ce152b80 14:01:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 14:01:14 INFO - mozversion platform_version: 46.0a1 14:01:14 INFO - using testdate: 1453413674 14:01:14 INFO - actual date: 1453413674 14:01:14 INFO - starting webserver on 'localhost:41922' 14:01:14 INFO - SUITE-START | Running 3 tests 14:01:14 INFO - TEST-START | dromaeo_css 14:01:14 INFO - operating with platform_type : linux_ 14:01:14 INFO - Initialising browser for dromaeo_css test... 14:01:14 INFO - TEST-INFO | started process 12549 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcax4HM/profile http://localhost:41922/getInfo.html) 14:01:18 INFO - PROCESS | 12549 | __metrics Screen width/height:1600/1200 14:01:18 INFO - PROCESS | 12549 | colorDepth:24 14:01:18 INFO - PROCESS | 12549 | Browser inner width/height: 1024/697 14:01:18 INFO - PROCESS | 12549 | __metrics 14:01:18 INFO - PROCESS | 12549 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:01:19 INFO - PROCESS | 12549 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:01:19 INFO - TEST-INFO | 12549: exit 0 14:01:19 INFO - Browser initialized. 14:01:19 INFO - Running cycle 1/1 for dromaeo_css test... 14:01:19 INFO - TEST-INFO | started process 12644 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcax4HM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:31 INFO - PROCESS | 12644 | RSS: Main: 148946944 14:01:31 INFO - PROCESS | 12644 | 14:02:23 INFO - PROCESS | 12644 | 1453413743216 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] 14:04:31 INFO - PROCESS | 12644 | Cycle 1(1): loaded http://localhost:41922/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41922/tests/dromaeo/cssquery-ext.html) 14:04:32 INFO - PROCESS | 12644 | RSS: Main: 251899904 14:04:32 INFO - PROCESS | 12644 | 14:07:34 INFO - PROCESS | 12644 | Cycle 1(1): loaded http://localhost:41922/tests/dromaeo/cssquery-ext.html (next: http://localhost:41922/tests/dromaeo/cssquery-jquery.html) 14:07:35 INFO - PROCESS | 12644 | RSS: Main: 231120896 14:07:35 INFO - PROCESS | 12644 | 14:10:37 INFO - PROCESS | 12644 | Cycle 1(1): loaded http://localhost:41922/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41922/tests/dromaeo/cssquery-mootools.html) 14:10:38 INFO - PROCESS | 12644 | RSS: Main: 238211072 14:10:38 INFO - PROCESS | 12644 | 14:13:39 INFO - PROCESS | 12644 | Cycle 1(1): loaded http://localhost:41922/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41922/tests/dromaeo/cssquery-prototype.html) 14:13:40 INFO - PROCESS | 12644 | RSS: Main: 214065152 14:13:40 INFO - PROCESS | 12644 | 14:16:43 INFO - PROCESS | 12644 | Cycle 1(1): loaded http://localhost:41922/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41922/tests/dromaeo/cssquery-yui.html) 14:16:43 INFO - PROCESS | 12644 | RSS: Main: 215834624 14:16:43 INFO - PROCESS | 12644 | 14:19:46 INFO - PROCESS | 12644 | Cycle 1(1): loaded http://localhost:41922/tests/dromaeo/cssquery-yui.html (next: http://localhost:41922/tests/dromaeo/cssquery-dojo.html) 14:19:46 INFO - PROCESS | 12644 | RSS: Main: 309723136 14:19:46 INFO - PROCESS | 12644 | 14:19:46 INFO - PROCESS | 12644 | __start_tp_report 14:19:46 INFO - PROCESS | 12644 | _x_x_mozilla_page_load 14:19:46 INFO - PROCESS | 12644 | _x_x_mozilla_page_load_details 14:19:46 INFO - PROCESS | 12644 | |i|pagename|runs| 14:19:46 INFO - PROCESS | 12644 | |0;dojo.html;3137.121605950335;3147.842607869606;3182.109009477347;3192.63284722257;3218.5011323244903;4855.878603034917;4971.502849715027;5031.52200540949;5055.873603159923;5109.2080727487255;5058.5953123750105;5066.569341605968;5069.087564238435;5105.208692652635;5121.9487805121935;4632.907341853161;4658.277966915117;4661.09108723799;4685.69542979707;4764.475907650156;4700.459447163568;4717.528247175289;4754.310624959378;4772.76136193189;4775.2598347256235;4527.366168736379;4606.193916064675;4639.211334073216;4688.062387522509;4692.577668009862;4614;4619.907601847978;4643.117807616542;4658.277966915133;4662.207424737769;4489.326601009842;4642.721436713808;4644.047970166108;4653.930191047137;4689.296605509201;4908.631852611068;4934.777934992898;4961.82633607822;4973.701577905301;5008.424031236418;5458.836234912919;5475.890482190373;5477.178423236506;5479.150731636602;5480.7533660985355;5365.543928766059;5443.972780136113;5488.313960754906;5528.253685752412;5548;5051.9494805051845;5154.484551544853;5196.454372290893;5221.5039571240295;5228.712420816815;5559.9444005560235;5560.694161821058;5560.943420750044;5563.693996830213;5609.15862620602;5341.118715411992;5343.7060961647485;5344.465553444625;5344.465553444702;5346.064438723208;5308.991291654651;5351.785928562892;5373.516383525502;5412.756425960842;5413.53984911287;5454.236406903036;5464.508194262536;5464.808731694451;5465.043617366945;5465.07093794048;5393.164059570773;5419.756110974937;5448.400675925645;5453.700046497481;5508.44915508446;4177.916441671149;4253.425787518708;4255.3829694694095;4256.893577660521;4282.336237883133;3847.634474724897;3851.5185601799776;3864.961350386516;3873.767573945572;3903.1022864741267;4978.576820970258;4983.750812459362;4991.401031876198;4999.600031997505;5040.294358789773;5355.196720491957;5359.544438722753;5378.327709036371;5387.030334539821;5417.187421886749;4909.459959404463;4977.651564390458;5053.7220452875445;5125.308083408692;5131;4726.314684370747;4727.196376615983;4729.125111854318;4729.716217026989;4738.763061846894;5632.2678051853;5660.235868157828;5669.433056694297;5671.943280567224;5680.602357834994;5230.084735171254;5358.33020872391;5430.076886929152;5430.212619170277;5481.068218402801;5565.55475561946;5600.299962504687;5609.859753506195;5611;5614.63504872182;5343.732813359395;5349.1976203569775;5355.116405793001;5375.973120134374;5409.729513524387;5365.785368585213;5445.727713614383;5460.044492213926;5500.4499550044675;5529.723513824373;5318.122509785842;5358.142697168434;5373.704446255493;5374.785008599612;5376.462353764592;5264.9210261846865;5324.227986941949;5354.625176237626;5359.062164121186;5406.810761623325;5219.086659834438;5274.472552744848;5299.8410047698635;5326.387465441524;5361.24942508057;5322;5323.0684630190335;5324.813631523033;5325.254464375068;5330.333708286465;5200.115980283436;5232.659877107976;5237.607179461479;5277.920831187458;5281.577473802164 14:19:46 INFO - PROCESS | 12644 | |1;ext.html;531.3862488825406;542.5903442900609;554.0193856873333;554.8529639645494;565.6153815405528;27172.592411113823;27748;33800.32399352015;34397.31205375891;34414.8279258604;37824.621753782456;38305.61694383055;38319.892405917664;38439.807800961025;38485.230295394074;8508.872366914502;8658.350623703216;8709.303255739558;8721.084286149959;8755;8569.957150214272;8611.35414843886;8622.784430389227;8623.525706086162;8635.95682021589;8554.70058547951;8611.784705382384;8638.827223455528;8644.740657780276;8652.8702069469;8613.138686131399;8678.349123815738;8686.522241276727;8690.304775617999;8696.260817830493;8533.274671652916;8653.350998675061;8676.219140277342;8684.43551169172;8700.216980471789;38458;38949;38986.22027559461;38988.80505597482;39111.41332880009;3355.9161020974425;3358.8320583970703;3420.863165473378;3445.707114895237;3496.160921378876;29600.70399296001;30259.243518912204;30457.847710761525;30688.2327941801;31284.217894552818;3882.456456096149;3944.4280579316123;4000;4071.2468193384025;4121.62905338521;260013;260616;261000;261020;261176;48489.515104849204;48867.266990995166;59253.703731481066;59496.10755838666;60086.39913600896;49417.25874111891;49542.50457495451;49695.50304496981;49712;49777.77333379943;12713.682157946125;13357.06500544972;13476.663083422993;13499.392527336293;13522.323883805968;9199.218066464291;9610.759731006781;9657.275704322205;9675.661351852652;9685.806283874424;17862.374816881347;17912.283508659508;17922.91038544799;17997.19012644434;18001.54996125081;7030.296970303031;7143.142822861186;7146.678399472036;7172.282771722786;7299.343059124704;955.7801705607749;956.297121615612;1007.2848277722752;1023.4831410137981;1099.5931505343074;27980.580291295646;28193.859030704716;28513;28529.429411411656;28803.56794648082;1024.882138554076;1055.1980494823988;1143.5311522275827;1155.475798813615;1156.7281688803125;14848;14852.773226078582;14909.254537273093;14939.17834519112;14954.551363459113;324405;327142;327749;327903;329390;50773.23840142401;50994.74502627463;51058;51251.23123153156;51364;1338.598420473854;1355.755963926483;1378.400395827818;1381.3576686840668;1382.9446822127404;27039.324016899736;27369.58945615857;28217.294567635974;28338.433231334846;28623.570646439905;41224;41397.586024139375;41447.37828932508;41460.792696036326;41494.377584336864;241185;244776;245221;245323;246565;27571.17286481409;28231.71768282291;28404.28989275202;29502.85248573829;31564.053078407684;36449.27101458009;39765;40112.799436002635;40182.1963560733;40687.1862562753;33620.49569256512;33824;33843.66156338504;33896;34155;28301.858490707415;33534.832325838215;34165.487517687754;34330.31339373248;34441.311173776885;29312.26719332034;32036.839815800773;32039.359212815147;32043.198920027186;32205.194870128435;27152.456950860476;30258;31056;31241.218969525944;31250.06249812509;23662.17182398608;24073.638895416934;24179.879100604383;24287.75712242855;24396.6340504889 14:19:46 INFO - PROCESS | 12644 | |2;jquery.html;362.22845339427016;366.70113857206377;371.8568351184794;372.20905575651733;375.7444937442538;13660.382996737813;13663.590092297221;15697.372105115795;17183.3126674933;18189.454316370513;16849.32602695891;17112.48662540126;17158.485245442625;17204.655906881853;17765.555861103447;5732.828015159552;5902.085176797603;5927.585069045147;5929.229200203968;5931.317898441691;4335.804888780012;4498.662600304974;5739.880723258966;6385.936140638604;6585.143931288926;6144.907826382586;6399.200099987502;6578.769743058994;6615.933840661604;6623.238327592317;6299.496040316763;6307.653079080672;6311.495080393557;6366.586171898812;6620.23867255267;6203.534734894901;6386.64873431961;6388.297287298394;6393.264774550939;6393.9680301598655;22150.88924555383;22228.66454070153;22351.441213969618;22707.77292227073;22937.88531057334;2243.921462748796;2250.3698964290024;2298.8505747126383;2404.699412573428;2424.6484259782233;13443.596692099252;13856.515021974283;13937.09408888429;13987.230702311368;14059.929700351433;1904.561950751321;1946.6593346164507;1966.9606607867906;1979.9208031678716;2000.7799142094505;60095.39904600986;62498;62991.37008629947;64253.67873160604;67356.66321668409;14625.0493717908;14644.420377015682;14665.388724154103;14742.894282928823;14929.925350373396;22591.548169036527;22632.321030368785;22664.546709065726;22822.8858855708;22843;8355.456895301786;8501.532415717194;8513.659453621909;8583.18459746323;8701.608427620773;7269.20038795732;7294.161171465244;7294.234105418961;7304.123505179413;7354.191038985708;6980.162380514371;7216;7751.186125456746;7765.1458339582605;7802.024746906637;2900.550414685727;2957.704229577068;2972.1677930179585;3001.609790727235;3046.45163870501;853.47511280562;963.1764841060932;992.4789485520015;1018.7402212435782;1048.0776916313748;13969.860301397059;15750.448734294245;15824.525264242091;16138.273777680033;16339.918300408423;926.092429419173;928.2249321816224;946.1815529567012;968.9806203875883;978.280963491833;7908.604569771604;7981.521108733495;9499.952500237454;9864.753381165385;9903.108720215216;354103.58964103385;356213;359275;474315;480609;68850.31149688439;70711;71451.64274178595;73403;74803.25196747963;1133.863936327646;1153.8903804138592;1154.572808061023;1154.9711257218637;1163.1102206811627;15208.619784505476;15274.15992120444;15336.693266134838;15382.307796149424;15753.291101900671;33085.33829323352;33157.33685326328;33490;33533.32933341368;34395.31209375848;42414.15171696487;42830.35754463623;43450.348244776986;43830.561694382646;44299;7068.752593659197;7086.610236437045;7087.114110736158;7141.785746427616;7275.963620181865;10335.638252661121;10869.510872010937;10930.945345273223;10959.178061645567;11149.554017839195;9254.676086336945;9291.16379525819;9489.051094890456;9621.134097931219;9747.512624368896;6924.549904256207;8980.955095224483;9367.391119577205;9615.086566776425;9744;8776.385653004229;9788.657396991355;9881.604735810488;9883.258755593215;10036.64871729486;7033.226345102137;7211.67547460355;7218.783436496913;7302.671379788028;7422.888656670047;8707.259882910024;9658.613655453702;9659.613615455584;9817.55820988043;9846.950765246414 14:19:46 INFO - PROCESS | 12644 | |3;mootools.html;1300.5253082624845;1453.5130731205045;1459.4162335065973;1608.3888122513442;1766.1169415292345;6992.545484543508;7451.180370159285;7666.425018123635;7667.309942105209;7672.88490672639;7387.852242955151;7578.50739701919;7578.810529736759;7597.962010189955;7602.847943041136;2009.889456079915;2033.0749508973456;2310.7689231076924;2330.533893221354;2364.1725396111397;2335;2341.5785158671433;2345.57779599672;2347.9647805282934;2347.9647805282934;2277.6697378880053;2335.3927978725483;2335.544568809083;2335.614623587106;2336.2523992322463;2273.374821923976;2278.6582012698063;2364.0898254172093;2369.277370402027;2370.383700237933;2313.2828823064906;2328.1385887221836;2342.086586231354;2350.6003979323555;2373.715154181509;7990.440669153161;8076.676932922676;8091.109977902426;8098.311643510308;8109.310708589777;4729.385179926588;4842.927356089626;4853.514648535153;4859.1010663027455;4867.756612169377;3219.4044101841;3270.7546933980047;3305.752068594865;3408.437607794711;3419.8803041893416;1091.2034215022998;1114.9944250278697;1132.162199972023;1136.8806275341053;1147.3632134165534;10809.405482698448;10831.458427078614;10979.890201097967;10985.176111791568;10992.340459572371;4392.1874453226255;4419;4428.269335559661;4464.910701785946;4505.949792844248;8967.192952634294;8970.506622135714;8990.955045224731;9002.909970900208;9034;4855.247436647325;4859.562639362474;4875.634327425457;4878.292647566083;4895.192293271571;4468.888277793016;4480.663950203682;4492.281235002384;4492.685512014127;4495.43807024122;3552.0587044433246;3637.2361804020925;3761;3781.9243615128094;3799.411091280856;1241.1002023532867;1260.6974326161655;1264.1467009768369;1269.1306455078116;1272.26844564374;1023.4422239879284;1039.4698703661188;1043.801677681238;1190.33936165429;1354.6545630864264;7173;7290.307420795016;7334.9266507335315;7335.229800870832;7335.706571737178;1143.2511704833348;1143.7932831930864;1154.5381847261162;1155.3587758793783;1170.4089434835353;5794.449527294901;5837.854053648608;5868.295804503401;5882.882342353129;5901.232839730894;9248.676296329597;9352.906470935339;9478.810423791485;9485.4782986935;9636.662716804878;9295.488748118918;9507;9513.286503512127;9513.762155946019;9516.714498564916;7225.6387180641805;7233.204347521663;7243.5653860768525;7271.527350722186;7338.5596864187255;7440.73957411488;7474.439417043634;7516.24837516244;7551.660175292015;7551.848963020819;8777.91222087771;8819.11808819113;9069;9108.772280693036;9113.453192808453;8614.353923455641;9074.27405807547;9074.364794464323;9106.269808736319;9214.078592140731;6368.395002474757;6900.447964162955;7020.7542736006035;7038.627467643965;7041.859162816818;6995.965020174866;7043.36609705129;7053.964730176316;7056.364927156581;7390.187079421152;6991.545549539263;7112;7184.8922266165;7238.565686058853;7327.74352897646;6886.208086069965;6912.27421120775;6964;7002.124734408199;7016.368526832405;7075.787726368218;7080.610566418691;7133;7146.392556632744;7204.56772593646;6239.937600624117;6253.312135664983;6279.811605651837;6283.8114856554375;6331.0819931110655;6640.335966403321;6666.200055993312;6707;6711.4966377520905;6721.697523611351 14:19:46 INFO - PROCESS | 12644 | |4;prototype.html;334.3730505302558;337.54094431573066;344.60370573840095;344.9517067610535;349.59447041431946;5655.830325090254;5774.884502309951;5782.681952492617;5782.76868925243;5789.565782566308;5563.860903477415;5689.2319536862615;5737.655740655564;5742.368339482654;5770.307563092424;4523.638108951292;4524.524924882873;4525.932111018337;4532.954670453303;4535.90928181437;4305.461817272841;4429.446319210098;4433.069055498349;4443.488998765135;4533.274676051832;4403.537628549005;4423.535528769481;4501.189785838547;4510.706804057742;4512.481064677555;4474.686771925966;4477.552244775513;4481.955180448186;4496.303073023687;4511.526289739596;3988.960110398888;3993.201359728037;4003.199360127986;4004.799760011988;4005.218982298453;5430.972845135789;5474.39781624021;5531.363893152258;5531.9723401383135;5536.086545719952;5141.742912854343;5187.325647665779;5191.844244672666;5193.143131383317;5201.219817027439;5843.123531470271;6110;6153.815385538396;6154.5384096192965;6162.137300777895;4284.143171365708;4352.455943007124;4456.977715111436;4460.933086003713;4465.508794032654;6269.247690277196;6374.808755737289;6378.489720822369;6385.201849768779;6388.776392826228;4489.506154323022;4490.326451032372;4490.842820501267;4490.955090449119;4495.595396414338;4480.305552639346;4514.210013247669;4555.453345598549;4559.840405585788;4586.601086668531;5185.611079169077;5189.792408303701;5193.246979188072;5193.324867767242;5193.896122077537;6094.6647934363145;6127.693615319216;6128.754849805958;6130.417610327012;6130.448259656563;1598.2168737318862;1628.23472967705;1629.9511014669342;1631.9755203671955;1632.9918350408173;1110.189561620022;1112.7496313329598;1121.8822023687396;1129.8983091521802;1144.5765066925292;5830.038043722739;5832.270966129234;5835.533157347402;5835.970820145957;5836.212111364996;6326.620402775756;6331.2085989251345;6335.3981371769605;6336.809895703136;6396.0725694774;5816.505597024216;5823.417658234142;5826.038703613941;5828.88342233153;5833.445822646841;3292.9341413172083;3413.992872102736;3415.112070861544;3416.2313479467416;3416.6241713411505;6560.540762146699;6560.86878262432;6568;6574.572652777554;6582.80251592453;6419.037144428373;6437.613743175424;6443.162388889415;6448.677566121769;6451.41937225652;6377.5216858735785;6555.2133743951035;6664.466842652576;6679.799606011828;6688.799336019927;6157.138000679819;6290;6411.871762564816;6412.39082287182;6423.614583125028;6237.282712488122;6373.267074286517;6392.4246817786625;6407.967960160169;6410.583312084699;6652.40128388428;6659.467242620675;6663.433608143362;6665.100211471389;6670.166229221348;4294.055307832272;4366.454193225847;4375.912481750411;4389.780510974502;4404.251277282934;6339.683015849281;6352.047192921099;6356.682165891594;6369.49044076482;6380.202474690664;6199.876002480015;6209.751609935552;6210.161628180319;6212.782552610637;6217.844553886008;6111.877762444815;6188.81433556994;6193.071039344134;6194.5354098443695;6207.503399728102;6156.538259630635;6161.322254551906;6161.691915404302;6162.137300777984;6166.383361663977;6311.116443697794;6339.1125242467015;6346.143270658402;6347.619142851444;6360.268569114426;6095.878082438415;6097.817065488042;6152.046432802923;6155.261368635793;6182.196314479089 14:19:46 INFO - PROCESS | 12644 | |5;yui.html;751.2412463411954;751.6730222353275;797.4736673795296;840.3361344537816;858.090424150401;13325.533606323781;13516.189028658275;13530.93234533826;13531.188128712283;13551.390187441564;11386.60146894859;11481.885181148185;11483.540658373655;11484.310941343525;11506.769864602704;669.2437545573495;673.0207548017647;809.3606051219544;820.9466384685006;840.995795021024;827.983440331193;831.5675848558745;834.6953362022879;838.8448137094626;840.1892174052069;869.9173578510031;872.2672954718035;877.7673916412156;878.0429332028089;878.8989266234369;707.741674288886;713.4007433755644;859.5229647545609;867.1805144138791;879.6261588824788;639.0095352204065;643.8841008618447;644.0693198328418;644.9451796597294;645.8966565349522;12046.518139274418;12130.757384852253;12172.2696638202;12180.390980451031;12186.634400967985;11818.881811181951;12205.267683938904;12482.43829027696;12528.498860045587;12625;10493.422861742602;10618.097461715763;10666.413347265898;10684.465776711133;10734.624288149877;3615.4215325547784;3677.2093999789904;3682;3706.684931780802;3788.9810550947345;46470;46779.06441871177;46789.29816052762;46805.76597116992;47744;9850.852237216448;10022.248331375176;10226.386416815016;10318.638847640297;10401.219908506891;17367.218475168647;17535.912320438318;17572.824271757374;17575;17584.648307034044;7659.463837531431;7819.257170568787;7852.803679907934;7894.289513943772;7918.089419716691;4430.5126436092005;4441.866743997685;4458.331250312414;4542.482365063008;4608.654350923627;2903.2016195546394;2942.073246927211;2945.572891930658;2946.2634341414646;2948.469275530382;556.2296219735695;565.5334349161958;569.5785119011902;572.2103497173873;575.3900865083025;545.738045738048;668.1481111582771;675.7330854312519;704.799132247307;708.3377042465312;9056.592453339616;9268;9444.905550944402;9510.762230944143;9790.902090979142;555.7276934302163;561.5760101123625;567.7161419290355;664.6942406492971;706.261956255714;3914.3499631847963;4275.957240427618;4297.076128632297;4388.363687265329;4401.537838526972;54095.45904540983;54259.45740542623;54634.45365546373;54653;54677;47585.524144758805;48923.26615100777;49842;50000;50071.74964125229;45019.324710129375;45373.319400209686;45374.54625453703;45452.54547454549;45594.77202613965;8674.436161649724;9017.774555636162;9032.593533290887;9066.229370503317;9111.225545828414;34711.4793278096;34936.65063349334;35557.46663799993;37278.627213727515;37346.06634834042;43914.56085439232;43976.12047759091;45089;45648.54351456443;46221.76889115533;11293.265937714023;11302.460778848477;11392.829107563559;11403.894158761857;11435.714107147387;12152;12273.754524909631;12479.438425271066;12540.435680394587;12786.872131278567;11139.610113645984;11367.43162841838;11493.54025838957;11714.648560543197;11847.170698051053;11702.590409335633;11775;11906.583269585522;12211.633650990485;12323.322217277777;11548.94225528867;11615.76768464643;11938.343391113573;11950.223235489666;12311.876881231432;9345.205657519187;9463.952680236554;9541.522923853918;9603.807923841623;9877.555510001923;9189.678361257324;9299.76750581241;9655;9662.178714809039;9671.323007389698 14:19:46 INFO - PROCESS | 12644 | __end_tp_report 14:19:46 INFO - PROCESS | 12644 | __start_cc_report 14:19:46 INFO - PROCESS | 12644 | _x_x_mozilla_cycle_collect,806 14:19:46 INFO - PROCESS | 12644 | __end_cc_report 14:19:46 INFO - PROCESS | 12644 | __startTimestamp1453414786843__endTimestamp 14:19:46 INFO - PROCESS | 12644 | 14:19:46 INFO - PROCESS | 12644 | ------- Summary: start ------- 14:19:46 INFO - PROCESS | 12644 | Number of tests: 6 14:19:46 INFO - PROCESS | 12644 | 14:19:46 INFO - PROCESS | 12644 | [#0] dojo.html Cycles:165 Average:5065.51 Median:5277.92 stddev:528.80 (10.0%) stddev-sans-first:508.32 14:19:46 INFO - PROCESS | 12644 | Values: 3137.1 3147.8 3182.1 3192.6 3218.5 4855.9 4971.5 5031.5 5055.9 5109.2 5058.6 5066.6 5069.1 5105.2 5121.9 4632.9 4658.3 4661.1 4685.7 4764.5 4700.5 4717.5 4754.3 4772.8 4775.3 4527.4 4606.2 4639.2 4688.1 4692.6 4614.0 4619.9 4643.1 4658.3 4662.2 4489.3 4642.7 4644.0 4653.9 4689.3 4908.6 4934.8 4961.8 4973.7 5008.4 5458.8 5475.9 5477.2 5479.2 5480.8 5365.5 5444.0 5488.3 5528.3 5548.0 5051.9 5154.5 5196.5 5221.5 5228.7 5559.9 5560.7 5560.9 5563.7 5609.2 5341.1 5343.7 5344.5 5344.5 5346.1 5309.0 5351.8 5373.5 5412.8 5413.5 5454.2 5464.5 5464.8 5465.0 5465.1 5393.2 5419.8 5448.4 5453.7 5508.4 4177.9 4253.4 4255.4 4256.9 4282.3 3847.6 3851.5 3865.0 3873.8 3903.1 4978.6 4983.8 4991.4 4999.6 5040.3 5355.2 5359.5 5378.3 5387.0 5417.2 4909.5 4977.7 5053.7 5125.3 5131.0 4726.3 4727.2 4729.1 4729.7 4738.8 5632.3 5660.2 5669.4 5671.9 5680.6 5230.1 5358.3 5430.1 5430.2 5481.1 5565.6 5600.3 5609.9 5611.0 5614.6 5343.7 5349.2 5355.1 5376.0 5409.7 5365.8 5445.7 5460.0 5500.4 5529.7 5318.1 5358.1 5373.7 5374.8 5376.5 5264.9 5324.2 5354.6 5359.1 5406.8 5219.1 5274.5 5299.8 5326.4 5361.2 5322.0 5323.1 5324.8 5325.3 5330.3 5200.1 5232.7 5237.6 5277.9 5281.6 14:19:46 INFO - PROCESS | 12644 | 14:19:46 INFO - PROCESS | 12644 | [#1] ext.html Cycles:180 Average:43450.82 Median:18793.18 stddev:73191.00 (389.5%) stddev-sans-first:73325.38 14:19:46 INFO - PROCESS | 12644 | Values: 531.4 542.6 554.0 554.9 565.6 27172.6 27748.0 33800.3 34397.3 34414.8 37824.6 38305.6 38319.9 38439.8 38485.2 8508.9 8658.4 8709.3 8721.1 8755.0 8570.0 8611.4 8622.8 8623.5 8636.0 8554.7 8611.8 8638.8 8644.7 8652.9 8613.1 8678.3 8686.5 8690.3 8696.3 8533.3 8653.4 8676.2 8684.4 8700.2 38458.0 38949.0 38986.2 38988.8 39111.4 3355.9 3358.8 3420.9 3445.7 3496.2 29600.7 30259.2 30457.8 30688.2 31284.2 3882.5 3944.4 4000.0 4071.2 4121.6 260013.0 260616.0 261000.0 261020.0 261176.0 48489.5 48867.3 59253.7 59496.1 60086.4 49417.3 49542.5 49695.5 49712.0 49777.8 12713.7 13357.1 13476.7 13499.4 13522.3 9199.2 9610.8 9657.3 9675.7 9685.8 17862.4 17912.3 17922.9 17997.2 18001.5 7030.3 7143.1 7146.7 7172.3 7299.3 955.8 956.3 1007.3 1023.5 1099.6 27980.6 28193.9 28513.0 28529.4 28803.6 1024.9 1055.2 1143.5 1155.5 1156.7 14848.0 14852.8 14909.3 14939.2 14954.6 324405.0 327142.0 327749.0 327903.0 329390.0 50773.2 50994.7 51058.0 51251.2 51364.0 1338.6 1355.8 1378.4 1381.4 1382.9 27039.3 27369.6 28217.3 28338.4 28623.6 41224.0 41397.6 41447.4 41460.8 41494.4 241185.0 244776.0 245221.0 245323.0 246565.0 27571.2 28231.7 28404.3 29502.9 31564.1 36449.3 39765.0 40112.8 40182.2 40687.2 33620.5 33824.0 33843.7 33896.0 34155.0 28301.9 33534.8 34165.5 34330.3 34441.3 29312.3 32036.8 32039.4 32043.2 32205.2 27152.5 30258.0 31056.0 31241.2 31250.1 23662.2 24073.6 24179.9 24287.8 24396.6 14:19:46 INFO - PROCESS | 12644 | 14:19:46 INFO - PROCESS | 12644 | [#2] jquery.html Cycles:180 Average:24757.03 Median:5736.35 stddev:67083.80 (1169.5%) stddev-sans-first:67246.98 14:19:46 INFO - PROCESS | 12644 | Values: 362.2 366.7 371.9 372.2 375.7 13660.4 13663.6 15697.4 17183.3 18189.5 16849.3 17112.5 17158.5 17204.7 17765.6 5732.8 5902.1 5927.6 5929.2 5931.3 4335.8 4498.7 5739.9 6385.9 6585.1 6144.9 6399.2 6578.8 6615.9 6623.2 6299.5 6307.7 6311.5 6366.6 6620.2 6203.5 6386.6 6388.3 6393.3 6394.0 22150.9 22228.7 22351.4 22707.8 22937.9 2243.9 2250.4 2298.9 2404.7 2424.6 13443.6 13856.5 13937.1 13987.2 14059.9 1904.6 1946.7 1967.0 1979.9 2000.8 60095.4 62498.0 62991.4 64253.7 67356.7 14625.0 14644.4 14665.4 14742.9 14929.9 22591.5 22632.3 22664.5 22822.9 22843.0 8355.5 8501.5 8513.7 8583.2 8701.6 7269.2 7294.2 7294.2 7304.1 7354.2 6980.2 7216.0 7751.2 7765.1 7802.0 2900.6 2957.7 2972.2 3001.6 3046.5 853.5 963.2 992.5 1018.7 1048.1 13969.9 15750.4 15824.5 16138.3 16339.9 926.1 928.2 946.2 969.0 978.3 7908.6 7981.5 9500.0 9864.8 9903.1 354103.6 356213.0 359275.0 474315.0 480609.0 68850.3 70711.0 71451.6 73403.0 74803.3 1133.9 1153.9 1154.6 1155.0 1163.1 15208.6 15274.2 15336.7 15382.3 15753.3 33085.3 33157.3 33490.0 33533.3 34395.3 42414.2 42830.4 43450.3 43830.6 44299.0 7068.8 7086.6 7087.1 7141.8 7276.0 10335.6 10869.5 10930.9 10959.2 11149.6 9254.7 9291.2 9489.1 9621.1 9747.5 6924.5 8981.0 9367.4 9615.1 9744.0 8776.4 9788.7 9881.6 9883.3 10036.6 7033.2 7211.7 7218.8 7302.7 7422.9 8707.3 9658.6 9659.6 9817.6 9847.0 14:19:46 INFO - PROCESS | 12644 | 14:19:46 INFO - PROCESS | 12644 | [#3] mootools.html Cycles:180 Average:5540.38 Median:6246.62 stddev:2844.87 (45.5%) stddev-sans-first:2835.00 14:19:46 INFO - PROCESS | 12644 | Values: 1300.5 1453.5 1459.4 1608.4 1766.1 6992.5 7451.2 7666.4 7667.3 7672.9 7387.9 7578.5 7578.8 7598.0 7602.8 2009.9 2033.1 2310.8 2330.5 2364.2 2335.0 2341.6 2345.6 2348.0 2348.0 2277.7 2335.4 2335.5 2335.6 2336.3 2273.4 2278.7 2364.1 2369.3 2370.4 2313.3 2328.1 2342.1 2350.6 2373.7 7990.4 8076.7 8091.1 8098.3 8109.3 4729.4 4842.9 4853.5 4859.1 4867.8 3219.4 3270.8 3305.8 3408.4 3419.9 1091.2 1115.0 1132.2 1136.9 1147.4 10809.4 10831.5 10979.9 10985.2 10992.3 4392.2 4419.0 4428.3 4464.9 4505.9 8967.2 8970.5 8991.0 9002.9 9034.0 4855.2 4859.6 4875.6 4878.3 4895.2 4468.9 4480.7 4492.3 4492.7 4495.4 3552.1 3637.2 3761.0 3781.9 3799.4 1241.1 1260.7 1264.1 1269.1 1272.3 1023.4 1039.5 1043.8 1190.3 1354.7 7173.0 7290.3 7334.9 7335.2 7335.7 1143.3 1143.8 1154.5 1155.4 1170.4 5794.4 5837.9 5868.3 5882.9 5901.2 9248.7 9352.9 9478.8 9485.5 9636.7 9295.5 9507.0 9513.3 9513.8 9516.7 7225.6 7233.2 7243.6 7271.5 7338.6 7440.7 7474.4 7516.2 7551.7 7551.8 8777.9 8819.1 9069.0 9108.8 9113.5 8614.4 9074.3 9074.4 9106.3 9214.1 6368.4 6900.4 7020.8 7038.6 7041.9 6996.0 7043.4 7054.0 7056.4 7390.2 6991.5 7112.0 7184.9 7238.6 7327.7 6886.2 6912.3 6964.0 7002.1 7016.4 7075.8 7080.6 7133.0 7146.4 7204.6 6239.9 6253.3 6279.8 6283.8 6331.1 6640.3 6666.2 6707.0 6711.5 6721.7 14:19:46 INFO - PROCESS | 12644 | 14:19:46 INFO - PROCESS | 12644 | [#4] prototype.html Cycles:180 Average:5179.38 Median:5819.96 stddev:1535.75 (26.4%) stddev-sans-first:1496.38 14:19:46 INFO - PROCESS | 12644 | Values: 334.4 337.5 344.6 345.0 349.6 5655.8 5774.9 5782.7 5782.8 5789.6 5563.9 5689.2 5737.7 5742.4 5770.3 4523.6 4524.5 4525.9 4533.0 4535.9 4305.5 4429.4 4433.1 4443.5 4533.3 4403.5 4423.5 4501.2 4510.7 4512.5 4474.7 4477.6 4482.0 4496.3 4511.5 3989.0 3993.2 4003.2 4004.8 4005.2 5431.0 5474.4 5531.4 5532.0 5536.1 5141.7 5187.3 5191.8 5193.1 5201.2 5843.1 6110.0 6153.8 6154.5 6162.1 4284.1 4352.5 4457.0 4460.9 4465.5 6269.2 6374.8 6378.5 6385.2 6388.8 4489.5 4490.3 4490.8 4491.0 4495.6 4480.3 4514.2 4555.5 4559.8 4586.6 5185.6 5189.8 5193.2 5193.3 5193.9 6094.7 6127.7 6128.8 6130.4 6130.4 1598.2 1628.2 1630.0 1632.0 1633.0 1110.2 1112.7 1121.9 1129.9 1144.6 5830.0 5832.3 5835.5 5836.0 5836.2 6326.6 6331.2 6335.4 6336.8 6396.1 5816.5 5823.4 5826.0 5828.9 5833.4 3292.9 3414.0 3415.1 3416.2 3416.6 6560.5 6560.9 6568.0 6574.6 6582.8 6419.0 6437.6 6443.2 6448.7 6451.4 6377.5 6555.2 6664.5 6679.8 6688.8 6157.1 6290.0 6411.9 6412.4 6423.6 6237.3 6373.3 6392.4 6408.0 6410.6 6652.4 6659.5 6663.4 6665.1 6670.2 4294.1 4366.5 4375.9 4389.8 4404.3 6339.7 6352.0 6356.7 6369.5 6380.2 6199.9 6209.8 6210.2 6212.8 6217.8 6111.9 6188.8 6193.1 6194.5 6207.5 6156.5 6161.3 6161.7 6162.1 6166.4 6311.1 6339.1 6346.1 6347.6 6360.3 6095.9 6097.8 6152.0 6155.3 6182.2 14:19:46 INFO - PROCESS | 12644 | 14:19:46 INFO - PROCESS | 12644 | [#5] yui.html Cycles:180 Average:13642.82 Median:45621.66 stddev:15489.47 (34.0%) stddev-sans-first:15502.67 14:19:46 INFO - PROCESS | 12644 | Values: 751.2 751.7 797.5 840.3 858.1 13325.5 13516.2 13530.9 13531.2 13551.4 11386.6 11481.9 11483.5 11484.3 11506.8 669.2 673.0 809.4 820.9 841.0 828.0 831.6 834.7 838.8 840.2 869.9 872.3 877.8 878.0 878.9 707.7 713.4 859.5 867.2 879.6 639.0 643.9 644.1 644.9 645.9 12046.5 12130.8 12172.3 12180.4 12186.6 11818.9 12205.3 12482.4 12528.5 12625.0 10493.4 10618.1 10666.4 10684.5 10734.6 3615.4 3677.2 3682.0 3706.7 3789.0 46470.0 46779.1 46789.3 46805.8 47744.0 9850.9 10022.2 10226.4 10318.6 10401.2 17367.2 17535.9 17572.8 17575.0 17584.6 7659.5 7819.3 7852.8 7894.3 7918.1 4430.5 4441.9 4458.3 4542.5 4608.7 2903.2 2942.1 2945.6 2946.3 2948.5 556.2 565.5 569.6 572.2 575.4 545.7 668.1 675.7 704.8 708.3 9056.6 9268.0 9444.9 9510.8 9790.9 555.7 561.6 567.7 664.7 706.3 3914.3 4276.0 4297.1 4388.4 4401.5 54095.5 54259.5 54634.5 54653.0 54677.0 47585.5 48923.3 49842.0 50000.0 50071.7 45019.3 45373.3 45374.5 45452.5 45594.8 8674.4 9017.8 9032.6 9066.2 9111.2 34711.5 34936.7 35557.5 37278.6 37346.1 43914.6 43976.1 45089.0 45648.5 46221.8 11293.3 11302.5 11392.8 11403.9 11435.7 12152.0 12273.8 12479.4 12540.4 12786.9 11139.6 11367.4 11493.5 11714.6 11847.2 11702.6 11775.0 11906.6 12211.6 12323.3 11548.9 11615.8 11938.3 11950.2 12311.9 9345.2 9464.0 9541.5 9603.8 9877.6 9189.7 9299.8 9655.0 9662.2 9671.3 14:19:46 INFO - PROCESS | 12644 | -------- Summary: end -------- 14:19:46 INFO - PROCESS | 12644 | 14:19:47 INFO - TEST-INFO | 12644: exit 0 14:19:47 INFO - TEST-OK | dromaeo_css | took 1113080ms 14:19:47 INFO - TEST-START | kraken 14:19:47 INFO - operating with platform_type : linux_ 14:19:47 INFO - Initialising browser for kraken test... 14:19:47 INFO - TEST-INFO | started process 12845 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphO4n0V/profile http://localhost:41922/getInfo.html) 14:19:51 INFO - PROCESS | 12845 | __metrics Screen width/height:1600/1200 14:19:51 INFO - PROCESS | 12845 | colorDepth:24 14:19:51 INFO - PROCESS | 12845 | Browser inner width/height: 1024/697 14:19:51 INFO - PROCESS | 12845 | __metrics 14:19:51 INFO - PROCESS | 12845 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:19:52 INFO - PROCESS | 12845 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:19:52 INFO - TEST-INFO | 12845: exit 0 14:19:52 INFO - Browser initialized. 14:19:52 INFO - Running cycle 1/1 for kraken test... 14:19:52 INFO - TEST-INFO | started process 12926 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphO4n0V/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:04 INFO - PROCESS | 12926 | RSS: Main: 149184512 14:20:04 INFO - PROCESS | 12926 | 14:20:07 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41922/tests/kraken/driver.html?testName=audio-beat-detection) 14:20:07 INFO - PROCESS | 12926 | RSS: Main: 185503744 14:20:07 INFO - PROCESS | 12926 | 14:20:10 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41922/tests/kraken/driver.html?testName=audio-dft) 14:20:11 INFO - PROCESS | 12926 | RSS: Main: 174731264 14:20:11 INFO - PROCESS | 12926 | 14:20:14 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41922/tests/kraken/driver.html?testName=audio-fft) 14:20:14 INFO - PROCESS | 12926 | RSS: Main: 160333824 14:20:14 INFO - PROCESS | 12926 | 14:20:16 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41922/tests/kraken/driver.html?testName=audio-oscillator) 14:20:17 INFO - PROCESS | 12926 | RSS: Main: 163651584 14:20:17 INFO - PROCESS | 12926 | 14:20:19 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41922/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:20:19 INFO - PROCESS | 12926 | RSS: Main: 164872192 14:20:19 INFO - PROCESS | 12926 | 14:20:22 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41922/tests/kraken/driver.html?testName=imaging-darkroom) 14:20:23 INFO - PROCESS | 12926 | RSS: Main: 165289984 14:20:23 INFO - PROCESS | 12926 | 14:20:26 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41922/tests/kraken/driver.html?testName=imaging-desaturate) 14:20:27 INFO - PROCESS | 12926 | RSS: Main: 164855808 14:20:27 INFO - PROCESS | 12926 | 14:20:30 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41922/tests/kraken/driver.html?testName=json-parse-financial) 14:20:30 INFO - PROCESS | 12926 | RSS: Main: 166690816 14:20:30 INFO - PROCESS | 12926 | 14:20:32 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41922/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:20:32 INFO - PROCESS | 12926 | RSS: Main: 177541120 14:20:32 INFO - PROCESS | 12926 | 14:20:34 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41922/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:20:35 INFO - PROCESS | 12926 | RSS: Main: 175497216 14:20:35 INFO - PROCESS | 12926 | 14:20:37 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41922/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:20:37 INFO - PROCESS | 12926 | RSS: Main: 188047360 14:20:37 INFO - PROCESS | 12926 | 14:20:40 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:20:40 INFO - PROCESS | 12926 | RSS: Main: 196878336 14:20:40 INFO - PROCESS | 12926 | 14:20:43 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:20:43 INFO - PROCESS | 12926 | RSS: Main: 194662400 14:20:43 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:41922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41922/tests/kraken/driver.html?testName=ai-astar) 14:20:45 INFO - PROCESS | 12926 | RSS: Main: 252641280 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | __start_tp_report 14:20:45 INFO - PROCESS | 12926 | _x_x_mozilla_page_load 14:20:45 INFO - PROCESS | 12926 | _x_x_mozilla_page_load_details 14:20:45 INFO - PROCESS | 12926 | |i|pagename|runs| 14:20:45 INFO - PROCESS | 12926 | |0;ai-astar;113;111;109;112;112;112;112;112;105;112 14:20:45 INFO - PROCESS | 12926 | |1;audio-beat-detection;156;127;155;162;127;151;148;130;164;128 14:20:45 INFO - PROCESS | 12926 | |2;audio-dft;162;163;164;163;163;164;163;163;165;165 14:20:45 INFO - PROCESS | 12926 | |3;audio-fft;72;73;94;97;72;73;75;105;92;73 14:20:45 INFO - PROCESS | 12926 | |4;audio-oscillator;96;97;140;97;96;95;142;96;97;140 14:20:45 INFO - PROCESS | 12926 | |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;109;108 14:20:45 INFO - PROCESS | 12926 | |6;imaging-darkroom;145;145;146;146;145;145;146;146;145;146 14:20:45 INFO - PROCESS | 12926 | |7;imaging-desaturate;96;95;95;96;96;96;95;96;96;96 14:20:45 INFO - PROCESS | 12926 | |8;json-parse-financial;55;55;59;56;56;56;56;55;55;54 14:20:45 INFO - PROCESS | 12926 | |9;json-stringify-tinderbox;68;68;69;67;68;71;68;67;69;69 14:20:45 INFO - PROCESS | 12926 | |10;stanford-crypto-aes;83;82;84;91;83;91;85;92;82;91 14:20:45 INFO - PROCESS | 12926 | |11;stanford-crypto-ccm;122;131;130;121;112;116;126;120;114;117 14:20:45 INFO - PROCESS | 12926 | |12;stanford-crypto-pbkdf2;143;134;141;142;146;132;142;142;142;141 14:20:45 INFO - PROCESS | 12926 | |13;stanford-crypto-sha256-iterative;67;66;67;66;67;65;73;69;67;67 14:20:45 INFO - PROCESS | 12926 | __end_tp_report 14:20:45 INFO - PROCESS | 12926 | __start_cc_report 14:20:45 INFO - PROCESS | 12926 | _x_x_mozilla_cycle_collect,947 14:20:45 INFO - PROCESS | 12926 | __end_cc_report 14:20:45 INFO - PROCESS | 12926 | __startTimestamp1453414845888__endTimestamp 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | ------- Summary: start ------- 14:20:45 INFO - PROCESS | 12926 | Number of tests: 14 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.36 (2.1%) stddev-sans-first:2.39 14:20:45 INFO - PROCESS | 12926 | Values: 113.0 111.0 109.0 112.0 112.0 112.0 112.0 112.0 105.0 112.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:153.00 stddev:15.19 (9.9%) stddev-sans-first:15.57 14:20:45 INFO - PROCESS | 12926 | Values: 156.0 127.0 155.0 162.0 127.0 151.0 148.0 130.0 164.0 128.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:0.97 (0.6%) stddev-sans-first:0.87 14:20:45 INFO - PROCESS | 12926 | Values: 162.0 163.0 164.0 163.0 163.0 164.0 163.0 163.0 165.0 165.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#3] audio-fft Cycles:10 Average:82.60 Median:74.00 stddev:12.85 (17.4%) stddev-sans-first:13.05 14:20:45 INFO - PROCESS | 12926 | Values: 72.0 73.0 94.0 97.0 72.0 73.0 75.0 105.0 92.0 73.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:96.00 stddev:21.45 (22.3%) stddev-sans-first:22.18 14:20:45 INFO - PROCESS | 12926 | Values: 96.0 97.0 140.0 97.0 96.0 95.0 142.0 96.0 97.0 140.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 14:20:45 INFO - PROCESS | 12926 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 108.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:20:45 INFO - PROCESS | 12926 | Values: 145.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:20:45 INFO - PROCESS | 12926 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.34 (2.4%) stddev-sans-first:1.39 14:20:45 INFO - PROCESS | 12926 | Values: 55.0 55.0 59.0 56.0 56.0 56.0 56.0 55.0 55.0 54.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:1.17 (1.7%) stddev-sans-first:1.24 14:20:45 INFO - PROCESS | 12926 | Values: 68.0 68.0 69.0 67.0 68.0 71.0 68.0 67.0 69.0 69.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:88.00 stddev:4.27 (4.9%) stddev-sans-first:4.35 14:20:45 INFO - PROCESS | 12926 | Values: 83.0 82.0 84.0 91.0 83.0 91.0 85.0 92.0 82.0 91.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:121.50 stddev:6.49 (5.3%) stddev-sans-first:6.87 14:20:45 INFO - PROCESS | 12926 | Values: 122.0 131.0 130.0 121.0 112.0 116.0 126.0 120.0 114.0 117.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:142.00 stddev:4.22 (3.0%) stddev-sans-first:4.38 14:20:45 INFO - PROCESS | 12926 | Values: 143.0 134.0 141.0 142.0 146.0 132.0 142.0 142.0 142.0 141.0 14:20:45 INFO - PROCESS | 12926 | 14:20:45 INFO - PROCESS | 12926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:2.22 (3.3%) stddev-sans-first:2.35 14:20:45 INFO - PROCESS | 12926 | Values: 67.0 66.0 67.0 66.0 67.0 65.0 73.0 69.0 67.0 67.0 14:20:45 INFO - PROCESS | 12926 | -------- Summary: end -------- 14:20:45 INFO - PROCESS | 12926 | 14:20:46 INFO - TEST-INFO | 12926: exit 0 14:20:46 INFO - TEST-OK | kraken | took 59445ms 14:20:46 INFO - TEST-START | v8_7 14:20:46 INFO - operating with platform_type : linux_ 14:20:46 INFO - Initialising browser for v8_7 test... 14:20:46 INFO - TEST-INFO | started process 13176 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2R0fPn/profile http://localhost:41922/getInfo.html) 14:20:51 INFO - PROCESS | 13176 | __metrics Screen width/height:1600/1200 14:20:51 INFO - PROCESS | 13176 | colorDepth:24 14:20:51 INFO - PROCESS | 13176 | Browser inner width/height: 1024/697 14:20:51 INFO - PROCESS | 13176 | __metrics 14:20:51 INFO - PROCESS | 13176 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:20:51 INFO - PROCESS | 13176 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:20:52 INFO - TEST-INFO | 13176: exit 0 14:20:52 INFO - Browser initialized. 14:20:52 INFO - Running cycle 1/1 for v8_7 test... 14:20:52 INFO - TEST-INFO | started process 13258 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2R0fPn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:21:04 INFO - PROCESS | 13258 | RSS: Main: 148938752 14:21:04 INFO - PROCESS | 13258 | 14:21:26 INFO - PROCESS | 13258 | Cycle 1(1): loaded http://localhost:41922/tests/v8_7/run.html (next: http://localhost:41922/tests/v8_7/run.html) 14:21:27 INFO - PROCESS | 13258 | RSS: Main: 506232832 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - PROCESS | 13258 | __start_tp_report 14:21:27 INFO - PROCESS | 13258 | _x_x_mozilla_page_load 14:21:27 INFO - PROCESS | 13258 | _x_x_mozilla_page_load_details 14:21:27 INFO - PROCESS | 13258 | |i|pagename|runs| 14:21:27 INFO - PROCESS | 13258 | |0;Richards;166.19577862722286 14:21:27 INFO - PROCESS | 13258 | |1;DeltaBlue;189.82536066818528 14:21:27 INFO - PROCESS | 13258 | |2;Encrypt;279.2516056967328 14:21:27 INFO - PROCESS | 13258 | |3;Decrypt;5229.166666666667 14:21:27 INFO - PROCESS | 13258 | |4;RayTrace;1984.126984126984 14:21:27 INFO - PROCESS | 13258 | |5;Earley;788.0220646178093 14:21:27 INFO - PROCESS | 13258 | |6;Boyer;12382.716049382716 14:21:27 INFO - PROCESS | 13258 | |7;RegExp;42187.5 14:21:27 INFO - PROCESS | 13258 | |8;Splay;580.6264501160093 14:21:27 INFO - PROCESS | 13258 | |9;NavierStokes;4826.923076923077 14:21:27 INFO - PROCESS | 13258 | __end_tp_report 14:21:27 INFO - PROCESS | 13258 | __startTimestamp1453414887025__endTimestamp 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - PROCESS | 13258 | ------- Summary: start ------- 14:21:27 INFO - PROCESS | 13258 | Number of tests: 10 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - PROCESS | 13258 | [#0] Richards Cycles:1 Average:166.20 Median:166.20 stddev:0.00 (0.0%) 14:21:27 INFO - PROCESS | 13258 | Values: 166.2 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - PROCESS | 13258 | [#1] DeltaBlue Cycles:1 Average:189.83 Median:189.83 stddev:0.00 (0.0%) 14:21:27 INFO - PROCESS | 13258 | Values: 189.8 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - PROCESS | 13258 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 14:21:27 INFO - PROCESS | 13258 | Values: 279.3 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - PROCESS | 13258 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 14:21:27 INFO - PROCESS | 13258 | Values: 5229.2 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - PROCESS | 13258 | [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 14:21:27 INFO - PROCESS | 13258 | Values: 1984.1 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - PROCESS | 13258 | [#5] Earley Cycles:1 Average:788.02 Median:788.02 stddev:0.00 (0.0%) 14:21:27 INFO - PROCESS | 13258 | Values: 788.0 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - PROCESS | 13258 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 14:21:27 INFO - PROCESS | 13258 | Values: 12382.7 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - PROCESS | 13258 | [#7] RegExp Cycles:1 Average:42187.50 Median:42187.50 stddev:0.00 (0.0%) 14:21:27 INFO - PROCESS | 13258 | Values: 42187.5 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - PROCESS | 13258 | [#8] Splay Cycles:1 Average:580.63 Median:580.63 stddev:0.00 (0.0%) 14:21:27 INFO - PROCESS | 13258 | Values: 580.6 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - PROCESS | 13258 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 14:21:27 INFO - PROCESS | 13258 | Values: 4826.9 14:21:27 INFO - PROCESS | 13258 | -------- Summary: end -------- 14:21:27 INFO - PROCESS | 13258 | 14:21:27 INFO - TEST-INFO | 13258: exit 0 14:21:27 INFO - TEST-OK | v8_7 | took 41036ms 14:21:27 INFO - SUITE-END | took 1213s 14:21:28 INFO - Completed test suite (00:20:13) 14:21:28 INFO - Working with test: dromaeo_css 14:21:28 INFO - Generating results file: dromaeo_css 14:21:28 INFO - Working with test: kraken 14:21:28 INFO - Generating results file: kraken 14:21:28 INFO - javascript benchmark 14:21:28 INFO - Working with test: v8_7 14:21:28 INFO - Generating results file: v8_7 14:21:28 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:21:28 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 14:21:28 INFO - process_Request line: dromaeo_css 6880.33 graph.html#tests=[[72,201,35]] 14:21:28 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:21:28 INFO - process_Request line: kraken 1501.00 graph.html#tests=[[232,201,35]] 14:21:28 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:21:28 INFO - process_Request line: v8_7 18955.67 graph.html#tests=[[230,201,35]] 14:21:28 INFO - RETURN: dromaeo_css: 6880.33 14:21:28 INFO - RETURN: kraken: 1501.00 14:21:28 INFO - RETURN: v8_7: 18955.67 14:21:28 INFO - javascript benchmark 14:21:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3137.121605950335, 3147.842607869606, 3182.109009477347, 3192.63284722257, 3218.5011323244903, 4855.878603034917, 4971.502849715027, 5031.52200540949, 5055.873603159923, 5109.2080727487255, 5058.5953123750105, 5066.569341605968, 5069.087564238435, 5105.208692652635, 5121.9487805121935, 4632.907341853161, 4658.277966915117, 4661.09108723799, 4685.69542979707, 4764.475907650156, 4700.459447163568, 4717.528247175289, 4754.310624959378, 4772.76136193189, 4775.2598347256235, 4527.366168736379, 4606.193916064675, 4639.211334073216, 4688.062387522509, 4692.577668009862, 4614.0, 4619.907601847978, 4643.117807616542, 4658.277966915133, 4662.207424737769, 4489.326601009842, 4642.721436713808, 4644.047970166108, 4653.930191047137, 4689.296605509201, 4908.631852611068, 4934.777934992898, 4961.82633607822, 4973.701577905301, 5008.424031236418, 5458.836234912919, 5475.890482190373, 5477.178423236506, 5479.150731636602, 5480.7533660985355, 5365.543928766059, 5443.972780136113, 5488.313960754906, 5528.253685752412, 5548.0, 5051.9494805051845, 5154.484551544853, 5196.454372290893, 5221.5039571240295, 5228.712420816815, 5559.9444005560235, 5560.694161821058, 5560.943420750044, 5563.693996830213, 5609.15862620602, 5341.118715411992, 5343.7060961647485, 5344.465553444625, 5344.465553444702, 5346.064438723208, 5308.991291654651, 5351.785928562892, 5373.516383525502, 5412.756425960842, 5413.53984911287, 5454.236406903036, 5464.508194262536, 5464.808731694451, 5465.043617366945, 5465.07093794048, 5393.164059570773, 5419.756110974937, 5448.400675925645, 5453.700046497481, 5508.44915508446, 4177.916441671149, 4253.425787518708, 4255.3829694694095, 4256.893577660521, 4282.336237883133, 3847.634474724897, 3851.5185601799776, 3864.961350386516, 3873.767573945572, 3903.1022864741267, 4978.576820970258, 4983.750812459362, 4991.401031876198, 4999.600031997505, 5040.294358789773, 5355.196720491957, 5359.544438722753, 5378.327709036371, 5387.030334539821, 5417.187421886749, 4909.459959404463, 4977.651564390458, 5053.7220452875445, 5125.308083408692, 5131.0, 4726.314684370747, 4727.196376615983, 4729.125111854318, 4729.716217026989, 4738.763061846894, 5632.2678051853, 5660.235868157828, 5669.433056694297, 5671.943280567224, 5680.602357834994, 5230.084735171254, 5358.33020872391, 5430.076886929152, 5430.212619170277, 5481.068218402801, 5565.55475561946, 5600.299962504687, 5609.859753506195, 5611.0, 5614.63504872182, 5343.732813359395, 5349.1976203569775, 5355.116405793001, 5375.973120134374, 5409.729513524387, 5365.785368585213, 5445.727713614383, 5460.044492213926, 5500.4499550044675, 5529.723513824373, 5318.122509785842, 5358.142697168434, 5373.704446255493, 5374.785008599612, 5376.462353764592, 5264.9210261846865, 5324.227986941949, 5354.625176237626, 5359.062164121186, 5406.810761623325, 5219.086659834438, 5274.472552744848, 5299.8410047698635, 5326.387465441524, 5361.24942508057, 5322.0, 5323.0684630190335, 5324.813631523033, 5325.254464375068, 5330.333708286465, 5200.115980283436, 5232.659877107976, 5237.607179461479, 5277.920831187458, 5281.577473802164], "unit": "score", "name": "dojo.html", "value": 5033.799288878971}, {"lowerIsBetter": false, "replicates": [531.3862488825406, 542.5903442900609, 554.0193856873333, 554.8529639645494, 565.6153815405528, 27172.592411113823, 27748.0, 33800.32399352015, 34397.31205375891, 34414.8279258604, 37824.621753782456, 38305.61694383055, 38319.892405917664, 38439.807800961025, 38485.230295394074, 8508.872366914502, 8658.350623703216, 8709.303255739558, 8721.084286149959, 8755.0, 8569.957150214272, 8611.35414843886, 8622.784430389227, 8623.525706086162, 8635.95682021589, 8554.70058547951, 8611.784705382384, 8638.827223455528, 8644.740657780276, 8652.8702069469, 8613.138686131399, 8678.349123815738, 8686.522241276727, 8690.304775617999, 8696.260817830493, 8533.274671652916, 8653.350998675061, 8676.219140277342, 8684.43551169172, 8700.216980471789, 38458.0, 38949.0, 38986.22027559461, 38988.80505597482, 39111.41332880009, 3355.9161020974425, 3358.8320583970703, 3420.863165473378, 3445.707114895237, 3496.160921378876, 29600.70399296001, 30259.243518912204, 30457.847710761525, 30688.2327941801, 31284.217894552818, 3882.456456096149, 3944.4280579316123, 4000.0, 4071.2468193384025, 4121.62905338521, 260013.0, 260616.0, 261000.0, 261020.0, 261176.0, 48489.515104849204, 48867.266990995166, 59253.703731481066, 59496.10755838666, 60086.39913600896, 49417.25874111891, 49542.50457495451, 49695.50304496981, 49712.0, 49777.77333379943, 12713.682157946125, 13357.06500544972, 13476.663083422993, 13499.392527336293, 13522.323883805968, 9199.218066464291, 9610.759731006781, 9657.275704322205, 9675.661351852652, 9685.806283874424, 17862.374816881347, 17912.283508659508, 17922.91038544799, 17997.19012644434, 18001.54996125081, 7030.296970303031, 7143.142822861186, 7146.678399472036, 7172.282771722786, 7299.343059124704, 955.7801705607749, 956.297121615612, 1007.2848277722752, 1023.4831410137981, 1099.5931505343074, 27980.580291295646, 28193.859030704716, 28513.0, 28529.429411411656, 28803.56794648082, 1024.882138554076, 1055.1980494823988, 1143.5311522275827, 1155.475798813615, 1156.7281688803125, 14848.0, 14852.773226078582, 14909.254537273093, 14939.17834519112, 14954.551363459113, 324405.0, 327142.0, 327749.0, 327903.0, 329390.0, 50773.23840142401, 50994.74502627463, 51058.0, 51251.23123153156, 51364.0, 1338.598420473854, 1355.755963926483, 1378.400395827818, 1381.3576686840668, 1382.9446822127404, 27039.324016899736, 27369.58945615857, 28217.294567635974, 28338.433231334846, 28623.570646439905, 41224.0, 41397.586024139375, 41447.37828932508, 41460.792696036326, 41494.377584336864, 241185.0, 244776.0, 245221.0, 245323.0, 246565.0, 27571.17286481409, 28231.71768282291, 28404.28989275202, 29502.85248573829, 31564.053078407684, 36449.27101458009, 39765.0, 40112.799436002635, 40182.1963560733, 40687.1862562753, 33620.49569256512, 33824.0, 33843.66156338504, 33896.0, 34155.0, 28301.858490707415, 33534.832325838215, 34165.487517687754, 34330.31339373248, 34441.311173776885, 29312.26719332034, 32036.839815800773, 32039.359212815147, 32043.198920027186, 32205.194870128435, 27152.456950860476, 30258.0, 31056.0, 31241.218969525944, 31250.06249812509, 23662.17182398608, 24073.638895416934, 24179.879100604383, 24287.75712242855, 24396.6340504889], "unit": "score", "name": "ext.html", "value": 17486.79884094154}, {"lowerIsBetter": false, "replicates": [362.22845339427016, 366.70113857206377, 371.8568351184794, 372.20905575651733, 375.7444937442538, 13660.382996737813, 13663.590092297221, 15697.372105115795, 17183.3126674933, 18189.454316370513, 16849.32602695891, 17112.48662540126, 17158.485245442625, 17204.655906881853, 17765.555861103447, 5732.828015159552, 5902.085176797603, 5927.585069045147, 5929.229200203968, 5931.317898441691, 4335.804888780012, 4498.662600304974, 5739.880723258966, 6385.936140638604, 6585.143931288926, 6144.907826382586, 6399.200099987502, 6578.769743058994, 6615.933840661604, 6623.238327592317, 6299.496040316763, 6307.653079080672, 6311.495080393557, 6366.586171898812, 6620.23867255267, 6203.534734894901, 6386.64873431961, 6388.297287298394, 6393.264774550939, 6393.9680301598655, 22150.88924555383, 22228.66454070153, 22351.441213969618, 22707.77292227073, 22937.88531057334, 2243.921462748796, 2250.3698964290024, 2298.8505747126383, 2404.699412573428, 2424.6484259782233, 13443.596692099252, 13856.515021974283, 13937.09408888429, 13987.230702311368, 14059.929700351433, 1904.561950751321, 1946.6593346164507, 1966.9606607867906, 1979.9208031678716, 2000.7799142094505, 60095.39904600986, 62498.0, 62991.37008629947, 64253.67873160604, 67356.66321668409, 14625.0493717908, 14644.420377015682, 14665.388724154103, 14742.894282928823, 14929.925350373396, 22591.548169036527, 22632.321030368785, 22664.546709065726, 22822.8858855708, 22843.0, 8355.456895301786, 8501.532415717194, 8513.659453621909, 8583.18459746323, 8701.608427620773, 7269.20038795732, 7294.161171465244, 7294.234105418961, 7304.123505179413, 7354.191038985708, 6980.162380514371, 7216.0, 7751.186125456746, 7765.1458339582605, 7802.024746906637, 2900.550414685727, 2957.704229577068, 2972.1677930179585, 3001.609790727235, 3046.45163870501, 853.47511280562, 963.1764841060932, 992.4789485520015, 1018.7402212435782, 1048.0776916313748, 13969.860301397059, 15750.448734294245, 15824.525264242091, 16138.273777680033, 16339.918300408423, 926.092429419173, 928.2249321816224, 946.1815529567012, 968.9806203875883, 978.280963491833, 7908.604569771604, 7981.521108733495, 9499.952500237454, 9864.753381165385, 9903.108720215216, 354103.58964103385, 356213.0, 359275.0, 474315.0, 480609.0, 68850.31149688439, 70711.0, 71451.64274178595, 73403.0, 74803.25196747963, 1133.863936327646, 1153.8903804138592, 1154.572808061023, 1154.9711257218637, 1163.1102206811627, 15208.619784505476, 15274.15992120444, 15336.693266134838, 15382.307796149424, 15753.291101900671, 33085.33829323352, 33157.33685326328, 33490.0, 33533.32933341368, 34395.31209375848, 42414.15171696487, 42830.35754463623, 43450.348244776986, 43830.561694382646, 44299.0, 7068.752593659197, 7086.610236437045, 7087.114110736158, 7141.785746427616, 7275.963620181865, 10335.638252661121, 10869.510872010937, 10930.945345273223, 10959.178061645567, 11149.554017839195, 9254.676086336945, 9291.16379525819, 9489.051094890456, 9621.134097931219, 9747.512624368896, 6924.549904256207, 8980.955095224483, 9367.391119577205, 9615.086566776425, 9744.0, 8776.385653004229, 9788.657396991355, 9881.604735810488, 9883.258755593215, 10036.64871729486, 7033.226345102137, 7211.67547460355, 7218.783436496913, 7302.671379788028, 7422.888656670047, 8707.259882910024, 9658.613655453702, 9659.613615455584, 9817.55820988043, 9846.950765246414], "unit": "score", "name": "jquery.html", "value": 8903.751164498388}, {"lowerIsBetter": false, "replicates": [1300.5253082624845, 1453.5130731205045, 1459.4162335065973, 1608.3888122513442, 1766.1169415292345, 6992.545484543508, 7451.180370159285, 7666.425018123635, 7667.309942105209, 7672.88490672639, 7387.852242955151, 7578.50739701919, 7578.810529736759, 7597.962010189955, 7602.847943041136, 2009.889456079915, 2033.0749508973456, 2310.7689231076924, 2330.533893221354, 2364.1725396111397, 2335.0, 2341.5785158671433, 2345.57779599672, 2347.9647805282934, 2347.9647805282934, 2277.6697378880053, 2335.3927978725483, 2335.544568809083, 2335.614623587106, 2336.2523992322463, 2273.374821923976, 2278.6582012698063, 2364.0898254172093, 2369.277370402027, 2370.383700237933, 2313.2828823064906, 2328.1385887221836, 2342.086586231354, 2350.6003979323555, 2373.715154181509, 7990.440669153161, 8076.676932922676, 8091.109977902426, 8098.311643510308, 8109.310708589777, 4729.385179926588, 4842.927356089626, 4853.514648535153, 4859.1010663027455, 4867.756612169377, 3219.4044101841, 3270.7546933980047, 3305.752068594865, 3408.437607794711, 3419.8803041893416, 1091.2034215022998, 1114.9944250278697, 1132.162199972023, 1136.8806275341053, 1147.3632134165534, 10809.405482698448, 10831.458427078614, 10979.890201097967, 10985.176111791568, 10992.340459572371, 4392.1874453226255, 4419.0, 4428.269335559661, 4464.910701785946, 4505.949792844248, 8967.192952634294, 8970.506622135714, 8990.955045224731, 9002.909970900208, 9034.0, 4855.247436647325, 4859.562639362474, 4875.634327425457, 4878.292647566083, 4895.192293271571, 4468.888277793016, 4480.663950203682, 4492.281235002384, 4492.685512014127, 4495.43807024122, 3552.0587044433246, 3637.2361804020925, 3761.0, 3781.9243615128094, 3799.411091280856, 1241.1002023532867, 1260.6974326161655, 1264.1467009768369, 1269.1306455078116, 1272.26844564374, 1023.4422239879284, 1039.4698703661188, 1043.801677681238, 1190.33936165429, 1354.6545630864264, 7173.0, 7290.307420795016, 7334.9266507335315, 7335.229800870832, 7335.706571737178, 1143.2511704833348, 1143.7932831930864, 1154.5381847261162, 1155.3587758793783, 1170.4089434835353, 5794.449527294901, 5837.854053648608, 5868.295804503401, 5882.882342353129, 5901.232839730894, 9248.676296329597, 9352.906470935339, 9478.810423791485, 9485.4782986935, 9636.662716804878, 9295.488748118918, 9507.0, 9513.286503512127, 9513.762155946019, 9516.714498564916, 7225.6387180641805, 7233.204347521663, 7243.5653860768525, 7271.527350722186, 7338.5596864187255, 7440.73957411488, 7474.439417043634, 7516.24837516244, 7551.660175292015, 7551.848963020819, 8777.91222087771, 8819.11808819113, 9069.0, 9108.772280693036, 9113.453192808453, 8614.353923455641, 9074.27405807547, 9074.364794464323, 9106.269808736319, 9214.078592140731, 6368.395002474757, 6900.447964162955, 7020.7542736006035, 7038.627467643965, 7041.859162816818, 6995.965020174866, 7043.36609705129, 7053.964730176316, 7056.364927156581, 7390.187079421152, 6991.545549539263, 7112.0, 7184.8922266165, 7238.565686058853, 7327.74352897646, 6886.208086069965, 6912.27421120775, 6964.0, 7002.124734408199, 7016.368526832405, 7075.787726368218, 7080.610566418691, 7133.0, 7146.392556632744, 7204.56772593646, 6239.937600624117, 6253.312135664983, 6279.811605651837, 6283.8114856554375, 6331.0819931110655, 6640.335966403321, 6666.200055993312, 6707.0, 6711.4966377520905, 6721.697523611351], "unit": "score", "name": "mootools.html", "value": 4573.82282424472}, {"lowerIsBetter": false, "replicates": [334.3730505302558, 337.54094431573066, 344.60370573840095, 344.9517067610535, 349.59447041431946, 5655.830325090254, 5774.884502309951, 5782.681952492617, 5782.76868925243, 5789.565782566308, 5563.860903477415, 5689.2319536862615, 5737.655740655564, 5742.368339482654, 5770.307563092424, 4523.638108951292, 4524.524924882873, 4525.932111018337, 4532.954670453303, 4535.90928181437, 4305.461817272841, 4429.446319210098, 4433.069055498349, 4443.488998765135, 4533.274676051832, 4403.537628549005, 4423.535528769481, 4501.189785838547, 4510.706804057742, 4512.481064677555, 4474.686771925966, 4477.552244775513, 4481.955180448186, 4496.303073023687, 4511.526289739596, 3988.960110398888, 3993.201359728037, 4003.199360127986, 4004.799760011988, 4005.218982298453, 5430.972845135789, 5474.39781624021, 5531.363893152258, 5531.9723401383135, 5536.086545719952, 5141.742912854343, 5187.325647665779, 5191.844244672666, 5193.143131383317, 5201.219817027439, 5843.123531470271, 6110.0, 6153.815385538396, 6154.5384096192965, 6162.137300777895, 4284.143171365708, 4352.455943007124, 4456.977715111436, 4460.933086003713, 4465.508794032654, 6269.247690277196, 6374.808755737289, 6378.489720822369, 6385.201849768779, 6388.776392826228, 4489.506154323022, 4490.326451032372, 4490.842820501267, 4490.955090449119, 4495.595396414338, 4480.305552639346, 4514.210013247669, 4555.453345598549, 4559.840405585788, 4586.601086668531, 5185.611079169077, 5189.792408303701, 5193.246979188072, 5193.324867767242, 5193.896122077537, 6094.6647934363145, 6127.693615319216, 6128.754849805958, 6130.417610327012, 6130.448259656563, 1598.2168737318862, 1628.23472967705, 1629.9511014669342, 1631.9755203671955, 1632.9918350408173, 1110.189561620022, 1112.7496313329598, 1121.8822023687396, 1129.8983091521802, 1144.5765066925292, 5830.038043722739, 5832.270966129234, 5835.533157347402, 5835.970820145957, 5836.212111364996, 6326.620402775756, 6331.2085989251345, 6335.3981371769605, 6336.809895703136, 6396.0725694774, 5816.505597024216, 5823.417658234142, 5826.038703613941, 5828.88342233153, 5833.445822646841, 3292.9341413172083, 3413.992872102736, 3415.112070861544, 3416.2313479467416, 3416.6241713411505, 6560.540762146699, 6560.86878262432, 6568.0, 6574.572652777554, 6582.80251592453, 6419.037144428373, 6437.613743175424, 6443.162388889415, 6448.677566121769, 6451.41937225652, 6377.5216858735785, 6555.2133743951035, 6664.466842652576, 6679.799606011828, 6688.799336019927, 6157.138000679819, 6290.0, 6411.871762564816, 6412.39082287182, 6423.614583125028, 6237.282712488122, 6373.267074286517, 6392.4246817786625, 6407.967960160169, 6410.583312084699, 6652.40128388428, 6659.467242620675, 6663.433608143362, 6665.100211471389, 6670.166229221348, 4294.055307832272, 4366.454193225847, 4375.912481750411, 4389.780510974502, 4404.251277282934, 6339.683015849281, 6352.047192921099, 6356.682165891594, 6369.49044076482, 6380.202474690664, 6199.876002480015, 6209.751609935552, 6210.161628180319, 6212.782552610637, 6217.844553886008, 6111.877762444815, 6188.81433556994, 6193.071039344134, 6194.5354098443695, 6207.503399728102, 6156.538259630635, 6161.322254551906, 6161.691915404302, 6162.137300777984, 6166.383361663977, 6311.116443697794, 6339.1125242467015, 6346.143270658402, 6347.619142851444, 6360.268569114426, 6095.878082438415, 6097.817065488042, 6152.046432802923, 6155.261368635793, 6182.196314479089], "unit": "score", "name": "prototype.html", "value": 4690.556196961352}, {"lowerIsBetter": false, "replicates": [751.2412463411954, 751.6730222353275, 797.4736673795296, 840.3361344537816, 858.090424150401, 13325.533606323781, 13516.189028658275, 13530.93234533826, 13531.188128712283, 13551.390187441564, 11386.60146894859, 11481.885181148185, 11483.540658373655, 11484.310941343525, 11506.769864602704, 669.2437545573495, 673.0207548017647, 809.3606051219544, 820.9466384685006, 840.995795021024, 827.983440331193, 831.5675848558745, 834.6953362022879, 838.8448137094626, 840.1892174052069, 869.9173578510031, 872.2672954718035, 877.7673916412156, 878.0429332028089, 878.8989266234369, 707.741674288886, 713.4007433755644, 859.5229647545609, 867.1805144138791, 879.6261588824788, 639.0095352204065, 643.8841008618447, 644.0693198328418, 644.9451796597294, 645.8966565349522, 12046.518139274418, 12130.757384852253, 12172.2696638202, 12180.390980451031, 12186.634400967985, 11818.881811181951, 12205.267683938904, 12482.43829027696, 12528.498860045587, 12625.0, 10493.422861742602, 10618.097461715763, 10666.413347265898, 10684.465776711133, 10734.624288149877, 3615.4215325547784, 3677.2093999789904, 3682.0, 3706.684931780802, 3788.9810550947345, 46470.0, 46779.06441871177, 46789.29816052762, 46805.76597116992, 47744.0, 9850.852237216448, 10022.248331375176, 10226.386416815016, 10318.638847640297, 10401.219908506891, 17367.218475168647, 17535.912320438318, 17572.824271757374, 17575.0, 17584.648307034044, 7659.463837531431, 7819.257170568787, 7852.803679907934, 7894.289513943772, 7918.089419716691, 4430.5126436092005, 4441.866743997685, 4458.331250312414, 4542.482365063008, 4608.654350923627, 2903.2016195546394, 2942.073246927211, 2945.572891930658, 2946.2634341414646, 2948.469275530382, 556.2296219735695, 565.5334349161958, 569.5785119011902, 572.2103497173873, 575.3900865083025, 545.738045738048, 668.1481111582771, 675.7330854312519, 704.799132247307, 708.3377042465312, 9056.592453339616, 9268.0, 9444.905550944402, 9510.762230944143, 9790.902090979142, 555.7276934302163, 561.5760101123625, 567.7161419290355, 664.6942406492971, 706.261956255714, 3914.3499631847963, 4275.957240427618, 4297.076128632297, 4388.363687265329, 4401.537838526972, 54095.45904540983, 54259.45740542623, 54634.45365546373, 54653.0, 54677.0, 47585.524144758805, 48923.26615100777, 49842.0, 50000.0, 50071.74964125229, 45019.324710129375, 45373.319400209686, 45374.54625453703, 45452.54547454549, 45594.77202613965, 8674.436161649724, 9017.774555636162, 9032.593533290887, 9066.229370503317, 9111.225545828414, 34711.4793278096, 34936.65063349334, 35557.46663799993, 37278.627213727515, 37346.06634834042, 43914.56085439232, 43976.12047759091, 45089.0, 45648.54351456443, 46221.76889115533, 11293.265937714023, 11302.460778848477, 11392.829107563559, 11403.894158761857, 11435.714107147387, 12152.0, 12273.754524909631, 12479.438425271066, 12540.435680394587, 12786.872131278567, 11139.610113645984, 11367.43162841838, 11493.54025838957, 11714.648560543197, 11847.170698051053, 11702.590409335633, 11775.0, 11906.583269585522, 12211.633650990485, 12323.322217277777, 11548.94225528867, 11615.76768464643, 11938.343391113573, 11950.223235489666, 12311.876881231432, 9345.205657519187, 9463.952680236554, 9541.522923853918, 9603.807923841623, 9877.555510001923, 9189.678361257324, 9299.76750581241, 9655.0, 9662.178714809039, 9671.323007389698], "unit": "score", "name": "yui.html", "value": 6308.635446339443}], "name": "dromaeo_css", "value": 6880.330678595931}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 111.0, 109.0, 112.0, 112.0, 112.0, 112.0, 112.0, 105.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 155.0, 162.0, 127.0, 151.0, 148.0, 130.0, 164.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 164.0, 163.0, 163.0, 164.0, 163.0, 163.0, 165.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 94.0, 97.0, 72.0, 73.0, 75.0, 105.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 140.0, 97.0, 96.0, 95.0, 142.0, 96.0, 97.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 59.0, 56.0, 56.0, 56.0, 56.0, 55.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 67.0, 68.0, 71.0, 68.0, 67.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 84.0, 91.0, 83.0, 91.0, 85.0, 92.0, 82.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [122.0, 131.0, 130.0, 121.0, 112.0, 116.0, 126.0, 120.0, 114.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [143.0, 134.0, 141.0, 142.0, 146.0, 132.0, 142.0, 142.0, 142.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 66.0, 67.0, 65.0, 73.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1501.0000000000005}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.19577862722286], "unit": "score", "name": "Richards", "value": 212.41213400000004}, {"lowerIsBetter": false, "replicates": [189.82536066818528], "unit": "score", "name": "DeltaBlue", "value": 348.30962399999987}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [788.0220646178093], "unit": "score", "name": "Earley", "value": 845.7415470000001}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [42187.5], "unit": "score", "name": "RegExp", "value": 21.593718518518536}, {"lowerIsBetter": false, "replicates": [580.6264501160093], "unit": "score", "name": "Splay", "value": 140.35013386613386}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 18955.671463335166}]} 14:21:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18955.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1501.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6880.33"}}} 14:21:28 INFO - Return code: 0 14:21:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:21:28 INFO - # TBPL SUCCESS # 14:21:28 INFO - Running post-action listener: _resource_record_post_action 14:21:28 INFO - Running post-run listener: _resource_record_post_run 14:21:29 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 551313408; Read time: 0; Write time: 619840 14:21:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236048384; Read time: 0; Write time: 285708 14:21:29 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 315265024; Read time: 0; Write time: 334132 14:21:29 INFO - Running post-run listener: _upload_blobber_files 14:21:29 INFO - Blob upload gear active. 14:21:29 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:21:29 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 14:21:29 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:21:29 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:21:29 INFO - (blobuploader) - INFO - Open directory for files ... 14:21:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:21:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:30 INFO - (blobuploader) - INFO - Done attempting. 14:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:21:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:31 INFO - (blobuploader) - INFO - Done attempting. 14:21:31 INFO - (blobuploader) - INFO - Iteration through files over. 14:21:31 INFO - Return code: 0 14:21:31 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:21:31 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:21:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/caee0e6a00784fc8ba3558dbce120fec2cb12920dfb1af6c5b44c6000522f7caecdb23472170e510f88194f4b42edabc4e35422d97b924595af9a5d974090a1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/beed9d7eec43960fdd08675aa1130705160a416ccd531c3fc25ea9eeddd42c10b97d79c70a5279beb90742b86d04307640f43bdb1202fe6c994abf2670a400e7"} 14:21:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:21:31 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:21:31 INFO - Contents: 14:21:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/caee0e6a00784fc8ba3558dbce120fec2cb12920dfb1af6c5b44c6000522f7caecdb23472170e510f88194f4b42edabc4e35422d97b924595af9a5d974090a1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/beed9d7eec43960fdd08675aa1130705160a416ccd531c3fc25ea9eeddd42c10b97d79c70a5279beb90742b86d04307640f43bdb1202fe6c994abf2670a400e7"} 14:21:31 INFO - Running post-run listener: copy_logs_to_upload_dir 14:21:31 INFO - Copying logs to upload dir... 14:21:31 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:21:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.224222 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-21 14:21:30.979077) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 14:21:30.982615) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/caee0e6a00784fc8ba3558dbce120fec2cb12920dfb1af6c5b44c6000522f7caecdb23472170e510f88194f4b42edabc4e35422d97b924595af9a5d974090a1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/beed9d7eec43960fdd08675aa1130705160a416ccd531c3fc25ea9eeddd42c10b97d79c70a5279beb90742b86d04307640f43bdb1202fe6c994abf2670a400e7"} build_url:https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/GLS5KcOSRgi0c5Hp3V6BGg/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/B2G-Inbound/sha512/caee0e6a00784fc8ba3558dbce120fec2cb12920dfb1af6c5b44c6000522f7caecdb23472170e510f88194f4b42edabc4e35422d97b924595af9a5d974090a1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/beed9d7eec43960fdd08675aa1130705160a416ccd531c3fc25ea9eeddd42c10b97d79c70a5279beb90742b86d04307640f43bdb1202fe6c994abf2670a400e7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 14:21:31.007251) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 14:21:31.007569) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453410610.244948-499566130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 14:21:31.089996) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 14:21:31.090315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 14:21:31.090607) ========= ========= Total master_lag: 0.27 =========