builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1453500158.41 results: success (0) buildid: 20160122113031 builduid: c7807351252a4bc88448244fc5396aa9 revision: 3957a325013c029e68c53c09205ccb602ea923ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.406214) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.406650) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.407258) ========= 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=7de08804244eb36560b44971000001c3-1453496720.768728-1029133726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006290 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.440400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.440669) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.459142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.459399) ========= 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=7de08804244eb36560b44971000001c3-1453496720.768728-1029133726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.508150) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.508410) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.508783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.509063) ========= 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=7de08804244eb36560b44971000001c3-1453496720.768728-1029133726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 14:02:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 34.1M=0s 2016-01-22 14:02:38 (34.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164722 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.686532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.686933) ========= 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=7de08804244eb36560b44971000001c3-1453496720.768728-1029133726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019593 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.736551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:38.736904) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 3957a325013c029e68c53c09205ccb602ea923ba --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 3957a325013c029e68c53c09205ccb602ea923ba --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=7de08804244eb36560b44971000001c3-1453496720.768728-1029133726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 14:02:38,908 truncating revision to first 12 chars 2016-01-22 14:02:38,909 Setting DEBUG logging. 2016-01-22 14:02:38,909 attempt 1/10 2016-01-22 14:02:38,909 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/3957a325013c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 14:02:39,259 unpacking tar archive at: b2g-inbound-3957a325013c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641881 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:39.391563) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:39.391916) ========= echo 3957a325013c029e68c53c09205ccb602ea923ba in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3957a325013c029e68c53c09205ccb602ea923ba'] 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=7de08804244eb36560b44971000001c3-1453496720.768728-1029133726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3957a325013c029e68c53c09205ccb602ea923ba program finished with exit code 0 elapsedTime=0.003909 script_repo_revision: '3957a325013c029e68c53c09205ccb602ea923ba' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:39.440915) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:39.441198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 14:02:39.450815) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-22 14:02:39.451092) ========= /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=7de08804244eb36560b44971000001c3-1453496720.768728-1029133726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:02:39 INFO - MultiFileLogger online at 20160122 14:02:39 in /builds/slave/test-pgo 14:02:39 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:02:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:02:39 INFO - {'append_to_log': False, 14:02:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:02:39 INFO - 'blob_upload_branch': 'B2G-Inbound', 14:02:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:02:39 INFO - 'branch': 'B2G-Inbound', 14:02:39 INFO - 'buildbot_json_path': 'buildprops.json', 14:02:39 INFO - 'config_files': ('talos/linux_config.py',), 14:02:39 INFO - 'default_actions': ('clobber', 14:02:39 INFO - 'read-buildbot-config', 14:02:39 INFO - 'download-and-extract', 14:02:39 INFO - 'populate-webroot', 14:02:39 INFO - 'create-virtualenv', 14:02:39 INFO - 'install', 14:02:39 INFO - 'run-tests'), 14:02:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:02:39 INFO - 'download_minidump_stackwalk': True, 14:02:39 INFO - 'download_symbols': 'ondemand', 14:02:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:02:39 INFO - 'tooltool.py': '/tools/tooltool.py', 14:02:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:02:39 INFO - '/tools/misc-python/virtualenv.py')}, 14:02:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:02:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:02:39 INFO - 'installer_path': 'installer.exe', 14:02:39 INFO - 'log_level': 'info', 14:02:39 INFO - 'log_name': 'talos', 14:02:39 INFO - 'log_to_console': True, 14:02:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:02:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:02:39 INFO - 'opt_config_files': (), 14:02:39 INFO - 'pip_index': False, 14:02:39 INFO - 'sps_profile': False, 14:02:39 INFO - 'sps_profile_interval': 0, 14:02:39 INFO - 'suite': 'dromaeojs', 14:02:39 INFO - 'system_bits': '32', 14:02:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:02:39 INFO - 'title': 'talos-linux64-ix-003', 14:02:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:02:39 INFO - 'use_talos_json': True, 14:02:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:02:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:02:39 INFO - 'work_dir': 'build'} 14:02:39 INFO - ##### 14:02:39 INFO - ##### Running clobber step. 14:02:39 INFO - ##### 14:02:39 INFO - Running pre-action listener: _resource_record_pre_action 14:02:39 INFO - Running main action method: clobber 14:02:39 INFO - rmtree: /builds/slave/test-pgo/build 14:02:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:02:40 INFO - Running post-action listener: _resource_record_post_action 14:02:40 INFO - ##### 14:02:40 INFO - ##### Running read-buildbot-config step. 14:02:40 INFO - ##### 14:02:40 INFO - Running pre-action listener: _resource_record_pre_action 14:02:40 INFO - Running main action method: read_buildbot_config 14:02:40 INFO - Using buildbot properties: 14:02:40 INFO - { 14:02:40 INFO - "project": "", 14:02:40 INFO - "product": "firefox", 14:02:40 INFO - "script_repo_revision": "production", 14:02:40 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 14:02:40 INFO - "repository": "", 14:02:40 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 14:02:40 INFO - "buildid": "20160122113031", 14:02:40 INFO - "pgo_build": "True", 14:02:40 INFO - "basedir": "/builds/slave/test-pgo", 14:02:40 INFO - "buildnumber": 1127, 14:02:40 INFO - "slavename": "talos-linux64-ix-003", 14:02:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:02:40 INFO - "platform": "ubuntu64_hw", 14:02:40 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 14:02:40 INFO - "branch": "b2g-inbound", 14:02:40 INFO - "repo_path": "integration/b2g-inbound", 14:02:40 INFO - "revision": "3957a325013c029e68c53c09205ccb602ea923ba", 14:02:40 INFO - "stage_platform": "linux64-pgo", 14:02:40 INFO - "builduid": "c7807351252a4bc88448244fc5396aa9", 14:02:40 INFO - "slavebuilddir": "test" 14:02:40 INFO - } 14:02:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:02:40 INFO - Running post-action listener: _resource_record_post_action 14:02:40 INFO - ##### 14:02:40 INFO - ##### Running download-and-extract step. 14:02:40 INFO - ##### 14:02:40 INFO - Running pre-action listener: _resource_record_pre_action 14:02:40 INFO - Running main action method: download_and_extract 14:02:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:02: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:02:40 INFO - https://queue.taskcluster.net/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:02:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/test_packages.json 14:02:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/test_packages.json 14:02:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:02:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:02:44 INFO - Downloaded 1448 bytes. 14:02:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:02:44 INFO - Using the following test package requirements: 14:02:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:02:44 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:02:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:44 INFO - u'jsshell-linux-x86_64.zip'], 14:02:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:02:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:02:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:02:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:02:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:02:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:02: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:02:44 INFO - https://queue.taskcluster.net/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/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:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/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:02:47 INFO - Downloaded 22488770 bytes. 14:02:47 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:02:47 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:02:49 INFO - Return code: 0 14:02:49 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:02:49 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:02:49 INFO - https://queue.taskcluster.net/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/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:02:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/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:02:50 INFO - Downloaded 22488770 bytes. 14:02:50 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:02:50 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:02:51 INFO - Return code: 0 14:02: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:02:51 INFO - https://queue.taskcluster.net/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:02:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/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:02:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/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:02:52 INFO - Downloaded 10706572 bytes. 14:02:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:02:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 14:02:53 INFO - Return code: 0 14:02: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:02:53 INFO - https://queue.taskcluster.net/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:02:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/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:02:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3d0aoJKSzSVxKkGfkihUQ/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:02:54 INFO - Downloaded 55936719 bytes. 14:02:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:54 INFO - mkdir: /builds/slave/test-pgo/properties 14:02:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:02:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:02:54 INFO - Contents: 14:02:54 INFO - build_url:https://queue.taskcluster.net/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:54 INFO - Running post-action listener: _resource_record_post_action 14:02:54 INFO - Running post-action listener: set_extra_try_arguments 14:02:54 INFO - ##### 14:02:54 INFO - ##### Running populate-webroot step. 14:02:54 INFO - ##### 14:02:54 INFO - Running pre-action listener: _resource_record_pre_action 14:02:54 INFO - Running main action method: populate_webroot 14:02:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:02:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:02:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:02:54 INFO - '--tppagecycles', 14:02:54 INFO - '7'], 14:02:54 INFO - 'tests': ['tsvgm']}}, 14:02:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:02:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:02:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:02:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:02:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:02:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:02:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'talos_options': ['--e10s'], 14:02:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'tests': ['damp', 'tps']}, 14:02:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'talos_options': ['--e10s'], 14:02:54 INFO - 'tests': ['damp', 'tps']}, 14:02:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:02:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:02:54 INFO - 'other': {'tests': ['a11yr', 14:02:54 INFO - 'ts_paint', 14:02:54 INFO - 'tpaint', 14:02:54 INFO - 'sessionrestore', 14:02:54 INFO - 'sessionrestore_no_auto_restore']}, 14:02:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:02:54 INFO - 'tests': ['a11yr', 14:02:54 INFO - 'ts_paint', 14:02:54 INFO - 'tpaint', 14:02:54 INFO - 'sessionrestore', 14:02:54 INFO - 'sessionrestore_no_auto_restore']}, 14:02:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:02:54 INFO - 'tests': ['a11yr', 14:02:54 INFO - 'ts_paint', 14:02:54 INFO - 'tpaint', 14:02:54 INFO - 'sessionrestore', 14:02:54 INFO - 'sessionrestore_no_auto_restore']}, 14:02:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:02:54 INFO - 'tests': ['a11yr', 14:02:54 INFO - 'ts_paint', 14:02:54 INFO - 'tpaint', 14:02:54 INFO - 'sessionrestore', 14:02:54 INFO - 'sessionrestore_no_auto_restore']}, 14:02:54 INFO - 'other_l64': {'tests': ['a11yr', 14:02:54 INFO - 'ts_paint', 14:02:54 INFO - 'tpaint', 14:02:54 INFO - 'sessionrestore', 14:02:54 INFO - 'sessionrestore_no_auto_restore']}, 14:02:54 INFO - 'other_nol64': {'tests': ['a11yr', 14:02:54 INFO - 'ts_paint', 14:02:54 INFO - 'tpaint', 14:02:54 INFO - 'sessionrestore', 14:02:54 INFO - 'sessionrestore_no_auto_restore']}, 14:02:54 INFO - 'svgr': {'tests': ['tsvgx', 14:02:54 INFO - 'tsvgr_opacity', 14:02:54 INFO - 'tart', 14:02:54 INFO - 'tscrollx', 14:02:54 INFO - 'cart']}, 14:02:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:02:54 INFO - 'tests': ['tsvgx', 14:02:54 INFO - 'tsvgr_opacity', 14:02:54 INFO - 'tart', 14:02:54 INFO - 'tscrollx', 14:02:54 INFO - 'cart']}, 14:02:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'tests': ['tp5o']}, 14:02:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'talos_options': ['--e10s'], 14:02:54 INFO - 'tests': ['tp5o']}, 14:02:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'talos_options': ['--xperf_path', 14:02:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:54 INFO - 'tests': ['tp5n']}, 14:02:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'talos_options': ['--e10s', 14:02:54 INFO - '--xperf_path', 14:02:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:54 INFO - 'tests': ['tp5n']}}, 14:02:54 INFO - 'talos.zip': {'path': '', 14:02:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:02:54 INFO - Running post-action listener: _resource_record_post_action 14:02:54 INFO - ##### 14:02:54 INFO - ##### Running create-virtualenv step. 14:02:54 INFO - ##### 14:02:54 INFO - Running pre-action listener: _resource_record_pre_action 14:02:54 INFO - Running main action method: create_virtualenv 14:02:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:02:54 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:02:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:02:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:02:54 INFO - Using real prefix '/usr' 14:02:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:02:55 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:57 INFO - Installing pip.................done. 14:02:57 INFO - Return code: 0 14:02:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:02:57 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:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:57 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:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:57 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 0x7f9594e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162a840>, '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 0x15976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1597b60>, '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': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', '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:02:57 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:02:57 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:02:57 INFO - Using env: {'DISPLAY': ':0', 14:02:57 INFO - 'HOME': '/home/cltbld', 14:02:57 INFO - 'LANG': 'en_US.UTF-8', 14:02:57 INFO - 'LANGUAGE': 'en_US:en', 14:02:57 INFO - 'LOGNAME': 'cltbld', 14:02:57 INFO - 'MAIL': '/var/mail/cltbld', 14:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:57 INFO - 'MOZ_NO_REMOTE': '1', 14:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:57 INFO - 'NO_EM_RESTART': '1', 14:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:57 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:57 INFO - 'SHELL': '/bin/bash', 14:02:57 INFO - 'SHLVL': '1', 14:02:57 INFO - 'TERM': 'linux', 14:02:57 INFO - 'TMOUT': '86400', 14:02:57 INFO - 'USER': 'cltbld', 14:02:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', 14:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:57 INFO - '_': '/tools/buildbot/bin/python'} 14:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:57 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:02:57 INFO - Cleaning up... 14:02:57 INFO - Return code: 0 14:02:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:02:57 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:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:57 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:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:57 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 0x7f9594e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162a840>, '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 0x15976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1597b60>, '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': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', '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:02:57 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:02:57 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:02:57 INFO - Using env: {'DISPLAY': ':0', 14:02:57 INFO - 'HOME': '/home/cltbld', 14:02:57 INFO - 'LANG': 'en_US.UTF-8', 14:02:57 INFO - 'LANGUAGE': 'en_US:en', 14:02:57 INFO - 'LOGNAME': 'cltbld', 14:02:57 INFO - 'MAIL': '/var/mail/cltbld', 14:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:57 INFO - 'MOZ_NO_REMOTE': '1', 14:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:57 INFO - 'NO_EM_RESTART': '1', 14:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:57 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:57 INFO - 'SHELL': '/bin/bash', 14:02:57 INFO - 'SHLVL': '1', 14:02:57 INFO - 'TERM': 'linux', 14:02:57 INFO - 'TMOUT': '86400', 14:02:57 INFO - 'USER': 'cltbld', 14:02:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', 14:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:57 INFO - '_': '/tools/buildbot/bin/python'} 14:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:57 INFO - Downloading/unpacking psutil>=0.7.1 14:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:02:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:59 INFO - Installing collected packages: psutil 14:02:59 INFO - Running setup.py install for psutil 14:02:59 INFO - building 'psutil._psutil_linux' extension 14:02:59 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:02:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:02:59 INFO - building 'psutil._psutil_posix' extension 14:02:59 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:02:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:03:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:00 INFO - Successfully installed psutil 14:03:00 INFO - Cleaning up... 14:03:00 INFO - Return code: 0 14:03:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:00 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 0x7f9594e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162a840>, '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 0x15976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1597b60>, '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': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', '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:03:00 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:03:00 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:03:00 INFO - Using env: {'DISPLAY': ':0', 14:03:00 INFO - 'HOME': '/home/cltbld', 14:03:00 INFO - 'LANG': 'en_US.UTF-8', 14:03:00 INFO - 'LANGUAGE': 'en_US:en', 14:03:00 INFO - 'LOGNAME': 'cltbld', 14:03:00 INFO - 'MAIL': '/var/mail/cltbld', 14:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:00 INFO - 'MOZ_NO_REMOTE': '1', 14:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:00 INFO - 'NO_EM_RESTART': '1', 14:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:00 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:00 INFO - 'SHELL': '/bin/bash', 14:03:00 INFO - 'SHLVL': '1', 14:03:00 INFO - 'TERM': 'linux', 14:03:00 INFO - 'TMOUT': '86400', 14:03:00 INFO - 'USER': 'cltbld', 14:03:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', 14:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:00 INFO - '_': '/tools/buildbot/bin/python'} 14:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:03:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:03:02 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:03:02 INFO - Installing collected packages: mozsystemmonitor 14:03:02 INFO - Running setup.py install for mozsystemmonitor 14:03:02 INFO - Successfully installed mozsystemmonitor 14:03:02 INFO - Cleaning up... 14:03:02 INFO - Return code: 0 14:03:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:03:02 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:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:02 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:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:02 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 0x7f9594e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162a840>, '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 0x15976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1597b60>, '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': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', '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:03:02 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:03:02 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:03:02 INFO - Using env: {'DISPLAY': ':0', 14:03:02 INFO - 'HOME': '/home/cltbld', 14:03:02 INFO - 'LANG': 'en_US.UTF-8', 14:03:02 INFO - 'LANGUAGE': 'en_US:en', 14:03:02 INFO - 'LOGNAME': 'cltbld', 14:03:02 INFO - 'MAIL': '/var/mail/cltbld', 14:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:02 INFO - 'MOZ_NO_REMOTE': '1', 14:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:02 INFO - 'NO_EM_RESTART': '1', 14:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:02 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:02 INFO - 'SHELL': '/bin/bash', 14:03:02 INFO - 'SHLVL': '1', 14:03:02 INFO - 'TERM': 'linux', 14:03:02 INFO - 'TMOUT': '86400', 14:03:02 INFO - 'USER': 'cltbld', 14:03:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', 14:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:02 INFO - '_': '/tools/buildbot/bin/python'} 14:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:02 INFO - Downloading/unpacking blobuploader==1.2.4 14:03:02 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:03:02 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:03:02 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:03:02 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:03:02 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:03:02 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:03:04 INFO - Downloading blobuploader-1.2.4.tar.gz 14:03:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:03:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:03:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 INFO - Downloading docopt-0.6.1.tar.gz 14:03:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:03:05 INFO - Installing collected packages: blobuploader, requests, docopt 14:03:05 INFO - Running setup.py install for blobuploader 14:03:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:03:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:03:05 INFO - Running setup.py install for requests 14:03:05 INFO - Running setup.py install for docopt 14:03:05 INFO - Successfully installed blobuploader requests docopt 14:03:05 INFO - Cleaning up... 14:03:05 INFO - Return code: 0 14:03:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:05 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 0x7f9594e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162a840>, '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 0x15976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1597b60>, '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': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', '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:03:05 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:03:05 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:03:05 INFO - Using env: {'DISPLAY': ':0', 14:03:05 INFO - 'HOME': '/home/cltbld', 14:03:05 INFO - 'LANG': 'en_US.UTF-8', 14:03:05 INFO - 'LANGUAGE': 'en_US:en', 14:03:05 INFO - 'LOGNAME': 'cltbld', 14:03:05 INFO - 'MAIL': '/var/mail/cltbld', 14:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:05 INFO - 'MOZ_NO_REMOTE': '1', 14:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:05 INFO - 'NO_EM_RESTART': '1', 14:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:05 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:05 INFO - 'SHELL': '/bin/bash', 14:03:05 INFO - 'SHLVL': '1', 14:03:05 INFO - 'TERM': 'linux', 14:03:05 INFO - 'TMOUT': '86400', 14:03:05 INFO - 'USER': 'cltbld', 14:03:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', 14:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:05 INFO - '_': '/tools/buildbot/bin/python'} 14:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:05 INFO - Running setup.py (path:/tmp/pip-jm8oCi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:05 INFO - Running setup.py (path:/tmp/pip-9KNkxd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:05 INFO - Running setup.py (path:/tmp/pip-KFhRiM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:06 INFO - Running setup.py (path:/tmp/pip-SM8AgJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:06 INFO - Running setup.py (path:/tmp/pip-rvIDHi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:06 INFO - Running setup.py (path:/tmp/pip-k_Zki1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:06 INFO - Running setup.py (path:/tmp/pip-TKkJzn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:06 INFO - Running setup.py (path:/tmp/pip-yFX81w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:06 INFO - Running setup.py (path:/tmp/pip-vCAWMi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:06 INFO - Running setup.py (path:/tmp/pip-s9H9ol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:06 INFO - Running setup.py (path:/tmp/pip-Er4EW0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:06 INFO - Running setup.py (path:/tmp/pip-MsNqoC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:06 INFO - Running setup.py (path:/tmp/pip-JThPHQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:06 INFO - Running setup.py (path:/tmp/pip-HC_wjF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:06 INFO - Running setup.py (path:/tmp/pip-oRgB3z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:06 INFO - Running setup.py (path:/tmp/pip-t29ciZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:06 INFO - Running setup.py (path:/tmp/pip-76BjKF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:03:07 INFO - Running setup.py install for manifestparser 14:03:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:03:07 INFO - Running setup.py install for mozcrash 14:03:07 INFO - Running setup.py install for mozdebug 14:03:07 INFO - Running setup.py install for mozdevice 14:03:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:03:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:03:07 INFO - Running setup.py install for mozfile 14:03:07 INFO - Running setup.py install for mozhttpd 14:03:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:03:07 INFO - Running setup.py install for mozinfo 14:03:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:03:07 INFO - Running setup.py install for mozInstall 14:03:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:03:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:03:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:03:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:03:07 INFO - Running setup.py install for mozleak 14:03:07 INFO - Running setup.py install for mozlog 14:03:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:03:08 INFO - Running setup.py install for moznetwork 14:03:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:03:08 INFO - Running setup.py install for mozprocess 14:03:08 INFO - Running setup.py install for mozprofile 14:03:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:03:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:03:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:03:08 INFO - Running setup.py install for mozrunner 14:03:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:03:08 INFO - Running setup.py install for mozscreenshot 14:03:08 INFO - Running setup.py install for moztest 14:03:08 INFO - Running setup.py install for mozversion 14:03:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:03:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:03:08 INFO - Cleaning up... 14:03:08 INFO - Return code: 0 14:03:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:08 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 0x7f9594e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162a840>, '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 0x15976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1597b60>, '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': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', '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:03:08 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:03:08 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:03:08 INFO - Using env: {'DISPLAY': ':0', 14:03:08 INFO - 'HOME': '/home/cltbld', 14:03:08 INFO - 'LANG': 'en_US.UTF-8', 14:03:08 INFO - 'LANGUAGE': 'en_US:en', 14:03:08 INFO - 'LOGNAME': 'cltbld', 14:03:08 INFO - 'MAIL': '/var/mail/cltbld', 14:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:08 INFO - 'MOZ_NO_REMOTE': '1', 14:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:08 INFO - 'NO_EM_RESTART': '1', 14:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:08 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:08 INFO - 'SHELL': '/bin/bash', 14:03:08 INFO - 'SHLVL': '1', 14:03:08 INFO - 'TERM': 'linux', 14:03:08 INFO - 'TMOUT': '86400', 14:03:08 INFO - 'USER': 'cltbld', 14:03:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', 14:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:08 INFO - '_': '/tools/buildbot/bin/python'} 14:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:09 INFO - Running setup.py (path:/tmp/pip-OJmThN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:09 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:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:09 INFO - Running setup.py (path:/tmp/pip-_5bYf0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:09 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:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:09 INFO - Running setup.py (path:/tmp/pip-YABfsU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:09 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:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:09 INFO - Running setup.py (path:/tmp/pip-5eZCVN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:09 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:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:09 INFO - Running setup.py (path:/tmp/pip-O0RkyE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:09 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:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:09 INFO - Running setup.py (path:/tmp/pip-J5Asqd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:09 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:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:09 INFO - Running setup.py (path:/tmp/pip-f4FjmO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:09 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:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:09 INFO - Running setup.py (path:/tmp/pip-ljUYKA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:09 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:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:09 INFO - Running setup.py (path:/tmp/pip-qZe5ih-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:09 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:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:09 INFO - Running setup.py (path:/tmp/pip-Ui1ETU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:09 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:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:09 INFO - Running setup.py (path:/tmp/pip-2zu4Cn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:09 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:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:09 INFO - Running setup.py (path:/tmp/pip-Y3HGiu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:09 INFO - Running setup.py (path:/tmp/pip-zDiT3j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:09 INFO - Running setup.py (path:/tmp/pip-1JhSuk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:10 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:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:10 INFO - Running setup.py (path:/tmp/pip-_PUQYE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:10 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:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:10 INFO - Running setup.py (path:/tmp/pip-hXORTn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:10 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:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:10 INFO - Running setup.py (path:/tmp/pip-CN3Of1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:10 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:03:10 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:03:10 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:03:10 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:03:10 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:03:10 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:03:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:10 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:03:10 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:03:10 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:03:10 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:03:10 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:03:10 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:03:11 INFO - Downloading blessings-1.6.tar.gz 14:03:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:03:12 INFO - Installing collected packages: blessings 14:03:12 INFO - Running setup.py install for blessings 14:03:12 INFO - Successfully installed blessings 14:03:12 INFO - Cleaning up... 14:03:12 INFO - Return code: 0 14:03:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:03:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:03:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:03:12 INFO - Reading from file tmpfile_stdout 14:03:12 INFO - Current package versions: 14:03:12 INFO - argparse == 1.2.1 14:03:12 INFO - blessings == 1.6 14:03:12 INFO - blobuploader == 1.2.4 14:03:12 INFO - docopt == 0.6.1 14:03:12 INFO - manifestparser == 1.1 14:03:12 INFO - mozInstall == 1.12 14:03:12 INFO - mozcrash == 0.16 14:03:12 INFO - mozdebug == 0.1 14:03:12 INFO - mozdevice == 0.48 14:03:12 INFO - mozfile == 1.2 14:03:12 INFO - mozhttpd == 0.7 14:03:12 INFO - mozinfo == 0.9 14:03:12 INFO - mozleak == 0.1 14:03:12 INFO - mozlog == 3.1 14:03:12 INFO - moznetwork == 0.27 14:03:12 INFO - mozprocess == 0.22 14:03:12 INFO - mozprofile == 0.28 14:03:12 INFO - mozrunner == 6.11 14:03:12 INFO - mozscreenshot == 0.1 14:03:12 INFO - mozsystemmonitor == 0.0 14:03:12 INFO - moztest == 0.7 14:03:12 INFO - mozversion == 1.4 14:03:12 INFO - psutil == 3.1.1 14:03:12 INFO - requests == 1.2.3 14:03:12 INFO - wsgiref == 0.1.2 14:03:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:12 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 0x7f9594e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162a840>, '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 0x15976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1597b60>, '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': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', '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:03:12 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:03:12 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:03:12 INFO - Using env: {'DISPLAY': ':0', 14:03:12 INFO - 'HOME': '/home/cltbld', 14:03:12 INFO - 'LANG': 'en_US.UTF-8', 14:03:12 INFO - 'LANGUAGE': 'en_US:en', 14:03:12 INFO - 'LOGNAME': 'cltbld', 14:03:12 INFO - 'MAIL': '/var/mail/cltbld', 14:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:12 INFO - 'MOZ_NO_REMOTE': '1', 14:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:12 INFO - 'NO_EM_RESTART': '1', 14:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:12 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:12 INFO - 'SHELL': '/bin/bash', 14:03:12 INFO - 'SHLVL': '1', 14:03:12 INFO - 'TERM': 'linux', 14:03:12 INFO - 'TMOUT': '86400', 14:03:12 INFO - 'USER': 'cltbld', 14:03:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', 14:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:12 INFO - '_': '/tools/buildbot/bin/python'} 14:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:03:12 INFO - Cleaning up... 14:03:12 INFO - Return code: 0 14:03:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:12 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 0x7f9594e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162a840>, '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 0x15976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1597b60>, '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': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', '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:03:12 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:03:12 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:03:12 INFO - Using env: {'DISPLAY': ':0', 14:03:12 INFO - 'HOME': '/home/cltbld', 14:03:12 INFO - 'LANG': 'en_US.UTF-8', 14:03:12 INFO - 'LANGUAGE': 'en_US:en', 14:03:12 INFO - 'LOGNAME': 'cltbld', 14:03:12 INFO - 'MAIL': '/var/mail/cltbld', 14:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:12 INFO - 'MOZ_NO_REMOTE': '1', 14:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:12 INFO - 'NO_EM_RESTART': '1', 14:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:12 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:12 INFO - 'SHELL': '/bin/bash', 14:03:12 INFO - 'SHLVL': '1', 14:03:12 INFO - 'TERM': 'linux', 14:03:12 INFO - 'TMOUT': '86400', 14:03:12 INFO - 'USER': 'cltbld', 14:03:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', 14:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:12 INFO - '_': '/tools/buildbot/bin/python'} 14:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:12 INFO - Downloading/unpacking jsonschema 14:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:03:14 INFO - Downloading/unpacking functools32 (from jsonschema) 14:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:14 INFO - Downloading functools32-3.2.3-2.tar.gz 14:03:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:03:14 INFO - warning: no files found matching '*.txt' 14:03:14 INFO - no previously-included directories found matching 'build' 14:03:14 INFO - no previously-included directories found matching 'dist' 14:03:14 INFO - no previously-included directories found matching '.git*' 14:03:14 INFO - Installing collected packages: jsonschema, functools32 14:03:14 INFO - Running setup.py install for functools32 14:03:15 INFO - warning: no files found matching '*.txt' 14:03:15 INFO - no previously-included directories found matching 'build' 14:03:15 INFO - no previously-included directories found matching 'dist' 14:03:15 INFO - no previously-included directories found matching '.git*' 14:03:15 INFO - Successfully installed jsonschema functools32 14:03:15 INFO - Cleaning up... 14:03:15 INFO - Return code: 0 14:03:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:03: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:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:15 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 0x7f9594e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162a840>, '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 0x15976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1597b60>, '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': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', '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:03:15 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:03:15 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:03:15 INFO - Using env: {'DISPLAY': ':0', 14:03:15 INFO - 'HOME': '/home/cltbld', 14:03:15 INFO - 'LANG': 'en_US.UTF-8', 14:03:15 INFO - 'LANGUAGE': 'en_US:en', 14:03:15 INFO - 'LOGNAME': 'cltbld', 14:03:15 INFO - 'MAIL': '/var/mail/cltbld', 14:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:15 INFO - 'MOZ_NO_REMOTE': '1', 14:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:15 INFO - 'NO_EM_RESTART': '1', 14:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:15 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:15 INFO - 'SHELL': '/bin/bash', 14:03:15 INFO - 'SHLVL': '1', 14:03:15 INFO - 'TERM': 'linux', 14:03:15 INFO - 'TMOUT': '86400', 14:03:15 INFO - 'USER': 'cltbld', 14:03:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', 14:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:15 INFO - '_': '/tools/buildbot/bin/python'} 14:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:15 INFO - Downloading/unpacking flake8 14:03:15 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:03:15 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:03:15 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:03:15 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:03:15 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:03:15 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:03:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:03:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:03:17 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:03:17 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:03:17 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:03:17 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:03:17 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:03:17 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:03:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:03:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:03:17 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:03:17 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:03:17 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:03:17 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:03:17 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:03:17 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:03:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:03:17 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:03:17 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:03:17 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:03:17 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:03:17 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:03:17 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:03:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:17 INFO - no previously-included directories found matching 'docs/_build' 14:03:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:03:17 INFO - Running setup.py install for pep8 14:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:17 INFO - no previously-included directories found matching 'docs/_build' 14:03:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:03:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:03:17 INFO - Cleaning up... 14:03:18 INFO - Return code: 0 14:03:18 INFO - Running post-action listener: _resource_record_post_action 14:03:18 INFO - Running post-action listener: _start_resource_monitoring 14:03:18 INFO - Starting resource monitoring. 14:03:18 INFO - ##### 14:03:18 INFO - ##### Running install step. 14:03:18 INFO - ##### 14:03:18 INFO - Running pre-action listener: _resource_record_pre_action 14:03:18 INFO - Running main action method: install 14:03:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:03:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:03:18 INFO - Reading from file tmpfile_stdout 14:03:18 INFO - Detecting whether we're running mozinstall >=1.0... 14:03:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:03:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:03:18 INFO - Reading from file tmpfile_stdout 14:03:18 INFO - Output received: 14:03:18 INFO - Usage: mozinstall [options] installer 14:03:18 INFO - Options: 14:03:18 INFO - -h, --help show this help message and exit 14:03:18 INFO - -d DEST, --destination=DEST 14:03:18 INFO - Directory to install application into. [default: 14:03:18 INFO - "/builds/slave/test-pgo"] 14:03:18 INFO - --app=APP Application being installed. [default: firefox] 14:03:18 INFO - mkdir: /builds/slave/test-pgo/build/application 14:03:18 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:03:18 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:03:34 INFO - Reading from file tmpfile_stdout 14:03:34 INFO - Output received: 14:03:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:03:34 INFO - Running post-action listener: _resource_record_post_action 14:03:34 INFO - ##### 14:03:34 INFO - ##### Running run-tests step. 14:03:34 INFO - ##### 14:03:34 INFO - Running pre-action listener: _resource_record_pre_action 14:03:34 INFO - Running main action method: run_tests 14:03:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:03:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:03:34 INFO - Python 2.7.3 14:03:34 INFO - Return code: 0 14:03:34 INFO - grabbing minidump binary from tooltool 14:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:34 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 0x162a840>, '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 0x15976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1597b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:03:34 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:03:34 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:03:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:34 INFO - Return code: 0 14:03:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:03:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:03:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:03:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:03:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:03:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:03:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:03:35 INFO - Return code: 0 14:03:35 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/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:03:35 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/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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:03:35 INFO - Using env: {'DISPLAY': ':0', 14:03:35 INFO - 'HOME': '/home/cltbld', 14:03:35 INFO - 'LANG': 'en_US.UTF-8', 14:03:35 INFO - 'LANGUAGE': 'en_US:en', 14:03:35 INFO - 'LOGNAME': 'cltbld', 14:03:35 INFO - 'MAIL': '/var/mail/cltbld', 14:03:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:03:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:35 INFO - 'MOZ_NO_REMOTE': '1', 14:03:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:03:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:35 INFO - 'NO_EM_RESTART': '1', 14:03:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:35 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:03:35 INFO - 'SHELL': '/bin/bash', 14:03:35 INFO - 'SHLVL': '1', 14:03:35 INFO - 'TERM': 'linux', 14:03:35 INFO - 'TMOUT': '86400', 14:03:35 INFO - 'USER': 'cltbld', 14:03:35 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453496720.768728-1029133726', 14:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:35 INFO - '_': '/tools/buildbot/bin/python'} 14:03:35 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/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:03:35 INFO - mozversion application_buildid: 20160122113031 14:03:35 INFO - mozversion application_changeset: 3957a325013c029e68c53c09205ccb602ea923ba 14:03:35 INFO - mozversion application_display_name: Nightly 14:03:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:35 INFO - mozversion application_name: Firefox 14:03:35 INFO - mozversion application_remotingname: firefox 14:03:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 14:03:35 INFO - mozversion application_vendor: Mozilla 14:03:35 INFO - mozversion application_version: 46.0a1 14:03:35 INFO - mozversion platform_buildid: 20160122113031 14:03:35 INFO - mozversion platform_changeset: 3957a325013c029e68c53c09205ccb602ea923ba 14:03:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 14:03:35 INFO - mozversion platform_version: 46.0a1 14:03:35 INFO - using testdate: 1453500215 14:03:35 INFO - actual date: 1453500215 14:03:35 INFO - starting webserver on 'localhost:47738' 14:03:35 INFO - SUITE-START | Running 3 tests 14:03:35 INFO - TEST-START | dromaeo_css 14:03:35 INFO - operating with platform_type : linux_ 14:03:35 INFO - Initialising browser for dromaeo_css test... 14:03:35 INFO - TEST-INFO | started process 5208 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg1Nqeb/profile http://localhost:47738/getInfo.html) 14:03:39 INFO - PROCESS | 5208 | __metrics Screen width/height:1600/1200 14:03:39 INFO - PROCESS | 5208 | colorDepth:24 14:03:39 INFO - PROCESS | 5208 | Browser inner width/height: 1024/697 14:03:39 INFO - PROCESS | 5208 | __metrics 14:03:40 INFO - PROCESS | 5208 | 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:03:40 INFO - PROCESS | 5208 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:03:41 INFO - TEST-INFO | 5208: exit 0 14:03:41 INFO - Browser initialized. 14:03:41 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:41 INFO - TEST-INFO | started process 5301 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg1Nqeb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:53 INFO - PROCESS | 5301 | RSS: Main: 147836928 14:03:53 INFO - PROCESS | 5301 | 14:04:43 INFO - PROCESS | 5301 | 1453500283903 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:06:52 INFO - PROCESS | 5301 | Cycle 1(1): loaded http://localhost:47738/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47738/tests/dromaeo/cssquery-ext.html) 14:06:54 INFO - PROCESS | 5301 | RSS: Main: 261988352 14:06:54 INFO - PROCESS | 5301 | 14:09:56 INFO - PROCESS | 5301 | Cycle 1(1): loaded http://localhost:47738/tests/dromaeo/cssquery-ext.html (next: http://localhost:47738/tests/dromaeo/cssquery-jquery.html) 14:09:57 INFO - PROCESS | 5301 | RSS: Main: 225103872 14:09:57 INFO - PROCESS | 5301 | 14:12:59 INFO - PROCESS | 5301 | Cycle 1(1): loaded http://localhost:47738/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47738/tests/dromaeo/cssquery-mootools.html) 14:12:59 INFO - PROCESS | 5301 | RSS: Main: 227479552 14:12:59 INFO - PROCESS | 5301 | 14:16:01 INFO - PROCESS | 5301 | Cycle 1(1): loaded http://localhost:47738/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47738/tests/dromaeo/cssquery-prototype.html) 14:16:02 INFO - PROCESS | 5301 | RSS: Main: 209600512 14:16:02 INFO - PROCESS | 5301 | 14:19:04 INFO - PROCESS | 5301 | Cycle 1(1): loaded http://localhost:47738/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47738/tests/dromaeo/cssquery-yui.html) 14:19:05 INFO - PROCESS | 5301 | RSS: Main: 216211456 14:19:05 INFO - PROCESS | 5301 | 14:22:07 INFO - PROCESS | 5301 | Cycle 1(1): loaded http://localhost:47738/tests/dromaeo/cssquery-yui.html (next: http://localhost:47738/tests/dromaeo/cssquery-dojo.html) 14:22:08 INFO - PROCESS | 5301 | RSS: Main: 300302336 14:22:08 INFO - PROCESS | 5301 | 14:22:08 INFO - PROCESS | 5301 | __start_tp_report 14:22:08 INFO - PROCESS | 5301 | _x_x_mozilla_page_load 14:22:08 INFO - PROCESS | 5301 | _x_x_mozilla_page_load_details 14:22:08 INFO - PROCESS | 5301 | |i|pagename|runs| 14:22:08 INFO - PROCESS | 5301 | |0;dojo.html;3078.6305643322803;3087.9536806947895;3158.9368212635763;3160.8103513789174;3173.9206519837007;4886.096072226641;4991.326170966919;5013.899722005558;5052.418971818242;5060.645754797161;4952.3561936948145;4964.056829202449;5054.444011158769;5102.285680004802;5130.486951304868;4592.74739889306;4617.976910115444;4629.791659375336;4665.650076244278;4710.528947105279;4623.606993405548;4688.038952014829;4723.07899959508;4724.1260366832075;4759.714417134983;4518.796654150571;4589.632829373642;4670.9065818683775;4677.836275730333;4775.90448191036;4569.771511424448;4628.352030715669;4630.652701047401;4643.024964757405;4646.976765116153;4588.197065513556;4597.7241365518175;4607.838725644587;4610.723356598614;4651.348811166439;4815.157347464215;4841.564259216652;4857;4890.070886531547;4908.9263661045115;5266.552343050846;5295.682259064469;5296.788128474856;5318.175682769177;5344.091504444254;5325.520703136697;5345.251664766935;5350.518453339179;5351.438098999627;5380.91928621071;5022.67352622082;5024.472430394792;5081.390233172006;5102.489751024942;5166.5866730661455;5476.205950137208;5483.890322193533;5488.396276409591;5499.175123731472;5525.502704756591;5271.578273738091;5272.156454967187;5276.762545685453;5283.894322113536;5289.841304760864;5327.547158491494;5349.679019258857;5402.216678581583;5418.2685337479725;5430.456954304538;5313.362396512366;5317.2024196370085;5319.175527793198;5344.4922732340365;5347.572194224453;5315.867103322371;5323.600729945269;5330.573554115739;5332.973335133377;5371.677699338053;4129.855455059059;4187.853425130106;4192;4214.936775948363;4281.678874084394;3719.256148770257;3720.479132921393;3731.029932217643;3758.4174452959833;3763.41667041609;4923.335349727812;4930.161872481687;4939.185034469344;4944.505549445099;4949.282354058713;5313.6811791291875;5385.488378604026;5395.595330350161;5413.648112872651;5490.862728431741;5036.194208926554;5050.520200580939;5054.418741844662;5057.620678449131;5065.746712664352;4658.557437043475;4664.65015123867;4674.11191873543;4683.320918466871;4706.505816889246;5445.59158063139;5511.476409741068;5578.832635020955;5642.125470551989;5682.204491371212;5420.972895135499;5437.592180586551;5437.918431223614;5445.59158063139;5445.782168713207;5588.748506317144;5643.068893632505;5657.60396772222;5664.631798933056;5713.857153571194;5269.394019687785;5326.547243484192;5351.518363347317;5358.544523715528;5365.543928765943;5351.518363347317;5358.758855851418;5361.169018802092;5367.651102678469;5369.758360873848;5205.349331333583;5214.9478505214465;5249.291345668286;5259.39516955555;5305.336832895888;5141.53726164647;5273.736313184402;5299.655522391032;5302.2046692996355;5341.813036543703;5204.271402003798;5204.895902082013;5215.4002289735645;5216.530512253916;5268.841934741964;5125.923111153261;5196.038732834287;5261.158214685632;5320.06898792702;5328.4671532846405;5143.048536020848;5149.201873709581;5179.922301165561;5188.325517682677;5237.738113094406 14:22:08 INFO - PROCESS | 5301 | |1;ext.html;528.1865926473231;536.6404508978984;538.6175815171229;556.2629515891444;559.7872808332833;27962.860185699068;28756.281092972687;34542.23662107032;34923.825380873124;35114.648853511455;37753.622463775355;38208;38237.61762382375;38328.233435331276;38477.61522384775;8362.623681934312;8555.95722021392;8556;8558.486490810541;8561.972563292413;8235.670573177065;8346.123657015987;8348.248657620812;8362.16378362165;8363.83272334553;8537.743867683948;8565.057843637225;8595.140485951417;8603.096674849145;8603.096674849145;8460.957695211515;8514.914850851535;8521.488710677379;8523.57382130891;8528.57357132144;8449.662013519452;8565.186307300797;8581.785455363603;8585.871211931764;8592.269657079156;37611;37912.43131353032;37990.24019519622;38059.61940380588;38066.80966595177;3127.5934128563367;3172.793768405046;3230.499272612749;3745.7190710696805;3828.406596977473;26609.600855987177;27149.1855244343;27164.320891977663;27313.590296145572;27524.58713119305;3776.7356285060055;3889.533256009297;3903.4535165076913;3991.2616166009093;3996.760194388317;261229;262216;262508;263293;265947;51641.225381619304;53167.46832531702;58847;60098;61494.385056148865;53289.73355133277;53421.73289133607;53600.731996340546;53650.7317463418;53657.73171134198;12718.554850580185;13263.469461221635;13360.198388096745;13416.664583385298;13428.395722192525;9029.954850225708;9107.408018478778;9126.680566180152;9169.266458683423;9178.613560474325;19247;19332.90333548323;19378.418647440598;19384.515387115152;19498.220071197276;7665.23347665229;7950.801229969297;7982.401319901031;7995.800104997305;8088.8786668198845;894.7449976756593;1011.6762635956424;1016.4409574733867;1040.9167266618651;1062.5059347403494;27683.307917301827;28092;28094.719052809618;28334.433311333658;28439.28901777472;988.7923536057365;1021.9744506387251;1028.177845902714;1030.0317701360698;1127.768807394482;14708.705825883422;15024.173670448012;15872.92063539675;16972.915135424242;16997.575060623585;373501.26498734666;377947.6615701533;378772;379335;379399;52745.7362713184;52868.20697689538;53214.73392633012;53692.46307536953;56158.71920640452;1285.2802430638872;1317.953871614489;1324.0863803975033;1328.8006798980036;1334.2261488336742;25908;26265.73734262633;26360.3409914746;26399.73600263973;27293;41797.58202417937;42280.57719422766;42292;46189.53810461987;47394.76302618465;197126;198135;198916;199653;200384;31733.36533269368;32073;32086.358272833946;32091.518627220143;32159.839200803846;40743;41360.37959430551;41541.79229103835;41885.162296754504;42036.789816050725;34959.12602184864;35056.47415288824;35243.39859888638;35429.82285088558;35470.29059418849;35486.29027419385;35921.820390897876;36511.26977460489;36728.816355919116;36941;34676;35280.11799705028;35310.47034294436;35377.469337960465;35423.64576354204;29871.70128298689;31578;32269.51595726113;32320.676793231767;32397.19007024843;24513.632295515938;26120.8693956529;26217.213483594758;26218.606720899585;26703.19890403291 14:22:08 INFO - PROCESS | 5301 | |2;jquery.html;358.64673296802647;360.3046120986496;361.7738913179263;362.27725687253934;366.10852573982373;13734.862651373483;13841.584752457442;15643.608909777262;16722.163891805405;18109.732318737693;15904.681906361866;16351.264193111308;16720.163991800422;16818.495445136665;17001.74497382537;5280.894382112365;5498.532624726903;5499.285092937933;5505.201745746865;5506.256655351536;3987.7208595398333;4102.815373308194;5350.170723537838;5468.0977638689565;5770.4518070783415;5693.572982026344;5865.648061116325;5933.643981361132;5942;5942.019566771478;5738.196652468679;5749.0514065179195;5767.33675627304;5774.942250577525;5784.652920824764;4993.875153121165;5111.335526381584;5150.510701483353;5207.0366982108435;5208.609354298443;19490.415287541255;19703.113359898696;19794;19850.80149198504;20083.698744518842;2206.095500844646;2227.354067320475;2284.805791507724;2326.8836558172193;2442.7312995570474;12740;12773.616791496177;12813.807792883114;12986.740265194738;13270.402831872589;1646.1851383565092;1728.8357606027407;1742.4162905426697;1815.9649000069965;1875.5404925793132;52738;54251;55044.44955550433;55439;55940;9053.502057386775;9102.635894564275;9212.677556285498;9219.078092190728;9300.90699093014;11768.88231117695;11785.292882427082;11820.349880756641;11832;11850.703732406759;6461.0631458438265;6559.278479367265;6592.967035164794;6604.966975165094;6614.7023383947835;6129.35641757609;6141.232345956755;6189.876202475925;6190.81427557174;6201.193844800147;5649.463300986482;5728.112142617901;5730.169125476783;5783.710814459344;5784.3926387729525;1540.5224380442098;1600.0559669794645;1648.69499142659;1723.258998630576;1742.2421246757701;963.9277054220961;997.7261355698797;1016.207358260558;1055.630529314749;1060.9787804243872;16300.510984670478;16716.24776885043;16774.832251677326;16918.492445226417;17121.1166771655;830.8379865926207;841.0202114536496;911.2300106410073;934.2712684106408;1016.7661437869332;8480.406371553932;9071.727848164566;9077.228435583049;9287.628494860264;9366.62533498666;507396;522103;534510;535985;566156;45372.77313613477;45904.540954590026;46109.30836037462;69982.30017699758;70109.94835077478;1149.9022583080532;1150.8618965724;1193.8328633991248;1200.087933170779;1216.0697066743949;13861.584152475441;14005.439782408997;14038.859611404163;14083;14349.139051656934;30727;30763.38473230478;30906.381872361977;31635.36729265448;32101.03696889097;42791;42791.3581296287;44092.897677558314;44393.33409998788;45760.7711961438;6697.296783837627;6842.7605033823575;7074.717011319695;7137.571745695275;7195.676194571152;7787.649555769891;10141.645042423479;10315.535800889129;10949.178811589321;11183;9096.317776166681;9304.209142222986;9421.81156376855;9424.905750942677;9667.46828924416;9466.905330946878;9483.810323793623;9692.466914319499;9835.93536697356;10574;3152.8265945373223;4303.1393721255245;9563.90436095658;10136.847947280648;10143.949280253551;7281.708731650675;7294.416446684359;7328.230535793665;7366.373858221897;7389;9417.811643767223;9665.3234273603;9925.702228933143;10048.547815348473;10073.546690399096 14:22:08 INFO - PROCESS | 5301 | |3;mootools.html;1335.254610816659;1439.6041088700606;1449.3405500497279;1585.231162886;1759.6392739488406;6675;7339.302766237212;7424.777256682295;7426.405887528998;7431.851362972738;7165.964170179142;7259.891101633467;7307.926920730791;7317.19510853807;7335.119785625732;1960.3530834824473;2007.1770574064637;2009.7186393904865;2230.654248591467;2258.7515373308925;1966.429735376739;2236.9776302237015;2267.38780529257;2267.5351552931693;2273.96534576768;2205.8014778669917;2232.7320721513443;2236.37381533171;2240.843140980132;2265.4676151104477;2227.086894373307;2229;2231.6764069209953;2232.3414592695112;2232.6651002349613;2197.230969160797;2249.403907964391;2253.4028482452163;2253.808426283768;2272.693186419845;7637.656305466212;7690.15408305086;7722.1891701371105;7729.149793522708;7739.883901741478;4489.169503641837;4618.030213655136;4620.214563524209;4624.884377890546;4652.209124448852;3020.3808219315206;3071.1707838883376;3084.9691503084905;3085.7531397488146;3115.4859448191023;975.9951200244025;999.9850002249972;1001.8296889528798;1008.6620981971048;1083.5611577311201;9947.80104397908;9949.801003979952;9958.800823983553;9969.102780749767;9982.450965196911;4186.1836941796055;4224.070704445017;4236.915261694749;4261.595148460891;4289.978550107229;8677.435966662148;8679.349048821363;8687.174718401742;8693.434926729742;8696.17386348296;4591.334256532851;4609.884752881205;4615.976920115378;4618.1918164321105;4624.190766615829;4150.460440142762;4154.543000269968;4158.438610787505;4161.563035881189;4162.583741625874;3370.1406141433777;3639.053846000006;3642.7450078494253;3659.4144936809985;3669.614690457517;1116.330201878866;1179.3042105157997;1200.0459634590522;1203.4704729918808;1211.1158854036603;1093.1254996003165;1115.5482029777952;1116.1963386361806;1118.8433619293305;1145.6162185667895;6916.792496225121;6974;7006.089208402875;7015.789526314219;7018.298170182941;1078.336822853939;1088.907442867365;1120.3445984099394;1123.5112725964068;1132.3262658718215;5575.972120139373;5675.602707810413;5710.7430165642645;5759.740811663485;5774.105013722879;9043.68347107848;9174.770630734285;9267.192897384944;9276.07239276067;9283.62865485373;8953.194212520904;9093.954530227438;9093.99966003739;9114.680986165453;9224.584893679801;7248.383887369527;7262.257058306074;7318.085239345082;7322.3775979042375;7343.77968660941;6939.410150137295;6994.510384273052;7018.122734658168;7069.681864316221;7083.574985500886;8121.796955075934;8169.632366543401;8371.497710137412;8378.706745263886;8380;8347.624356904076;8451.66193352259;8565;8599.26906212979;8609.354298427517;6846.657667116724;6909.585424874524;6909.689063992032;6924.3421874923815;6930.653467326714;6517.837054073686;6625.337466253336;7291.270872912666;7348;7382.889256661262;6754;6800.761973330909;6812.591244525344;6910.619915904674;6922.723091076301;6599.934000659932;6670;6718.260991291052;6795.437049478549;6799.558028728117;6756.391924726799;6952.582845029315;6957.826054348682;6964.338387853146;6975.616341101085;6365;6371.808845734636;6378.77674281398;6406.295307516077;6419.518536109717;6415.903761443676;6585.4073133416305;6594.142761440982;6607.933920660732;6609.801705948829 14:22:08 INFO - PROCESS | 5301 | |4;prototype.html;314.8551666233533;320.67291362809937;322.3842460899682;324.9155219642895;328.58762253372;5805.419458054193;5823.242978412811;5837.036888913324;5839.708014599269;5848.210491583635;5766.077427611583;5781.13283007549;5784.884302313952;5785.82642520724;5798.275215598051;4242.766647834368;4306.181825453154;4350.064736081742;4441.666874984373;4444.755538445384;4183.477065366829;4359.346098085281;4366.061296821183;4366.104948485553;4392.758398288093;4338.609525142737;4360.324149756792;4364.323529852878;4367.475902891641;4379.496357918848;4352.782360881959;4359.476862776455;4367.388565600819;4369.3227549729845;4385.539518350591;3710.573284072312;3778.1876896467393;3786.318462676717;3828.3683192273243;3868.6905047596124;5413.079776437976;5462.289902312714;5465.863353416196;5470.070088085035;5483.725813709299;5111.821086262;5122.436531981479;5123.641345105844;5123.820666276662;5124.718140502271;5930.970345148246;6084;6089.786857460012;6091.908621370683;6097.3292937776805;4283.87148385549;4315.30955047194;4317.41714868495;4320.805563749639;4320.848770293056;6423.454006409461;6423.93576064238;6426;6429.485641148697;6431.035344698239;4415.2494076006515;4418.734875907456;4420.535843736361;4422.49141348749;4428.7121337112985;4256.531781504032;4464.129494748558;4465.888352791141;4466.709663871903;4469.307257375112;5042.773075211624;5045.066662667418;5052.5705315048635;5059.595232381401;5062.82280120194;6112.633242005405;6171.382861713792;6176.042713379434;6179.660118693425;6183.659898705614;1512.7882096506498;1547.365580112171;1547.7136729705041;1549.0241148076639;1549.3182999480193;1003.4079892863246;1022.4018948914968;1026.3226270661328;1029.5469993202967;1030.5620111452602;5864.970675146597;5880.764769409261;5882.176495290662;5882.882342353129;5886.264216972879;6346.270178929482;6356.269029061625;6357.046443033582;6357.809265722036;6368.4586810121655;5875.588708790344;5876.44173803488;5879.647221166743;5879.794207202813;5883.529317654577;3326.6673332667024;3419.042668052949;3425.3491836550975;3433.3819912415506;3436.742244331685;6437.613743175424;6510.414062734377;6684.364985326386;6693.297203793629;6715.597064176165;6521.413072823469;6551.475881929434;6553.148090748267;6555.180602424697;6567.047778072153;6536.901946470902;6672.9332706673285;6744;6776.2546119926765;6777.491688123312;6409.294977552372;6411.807645770635;6412.294647588668;6412.807615771534;6415.06981487691;6327.17746692927;6329.92391293472;6332.430081292706;6336.239651241696;6339.366063393623;6418.550701450854;6561.606303621798;6566.212054553484;6569.605823650596;6578.210614726264;4375.037491751809;4399.098184872158;4403.735775853459;4405.163019026375;4407.9861631824215;6402.231732192166;6406.23125224976;6411.743530258737;6415.839604009937;6416.165898433173;6197.256329240339;6246.781362652286;6250.531210159165;6254.436390902274;6254.843628909313;6102.389761023862;6230.221222347207;6233.688315584293;6236.064590311489;6239;6115.327313995368;6125.203723515914;6126.724297406538;6127.908081378872;6130.938690613037;6255.218097737783;6263.498920086473;6264.154339164337;6264.310925798068;6266.561340706106;5941.881162376815;6101.115338275837;6101.206843110367;6101.938980610137;6102.542309326907 14:22:08 INFO - PROCESS | 5301 | |5;yui.html;679.6839469646613;689.6758523493959;735.779266220134;759.9468037237392;762.5348537392191;12507.624771256866;12699.238045717264;12705.36473176342;12735.108542402035;12754.234745915252;11953.581624643139;11994.280343179393;12001.739817319187;12010.21933574317;12021.459034343454;651.7849109793781;659.6866488418011;778.4356341652314;786.19807796048;805.0098378993841;781.394419325022;790.3953475591177;794.9046114466244;799.8120441696196;800;815.0016230118117;827.6192951242435;828.4615000249855;829.9004119505638;830.5805568188086;693.2893783871522;701.4003027411566;822.1696086952162;835.4444294544121;839.7102999465175;614.4684847606833;616.5776443136466;617.8826023055605;618.2117799805239;619.5910698938724;11190.272632278877;11391.373474458902;11567.76864462706;11599.130065245055;11634.6509604712;12398.75202495945;12540.498380064786;12623.116381853273;12638.810417843739;12727.23636581808;10513.474326283731;10565.841512377321;10670.093042091432;10675.83986240207;10777;3580.874669386585;3644.034330902313;3655.342038433081;3736.8131593420494;3751.737378383514;47654;47887;47940.7602961983;48206;48643.51356486425;9668.226541876633;9847.950760246153;10023.649172278936;10026.548805303779;10332.690019299433;17400.140468327572;17428.12859357027;17530.12349382551;17739.11304434773;17745;7288;7352;7376.483646144826;7438.851222975511;7504.437167212481;3973.6821054315587;4092.6725861930972;4104.774237416911;4124.1957818225155;4173.8956526087095;2904.215861717367;2908.2293192304055;2910.54886492594;2916.9562456563167;2920.036387991958;536.495694047594;549.1570439375539;549.5219159331407;550.0758725341465;554.9472800083986;484.4501490807888;534.8769782949944;560.9046462101453;564.2523656155611;665.3845193196274;8337.374696897758;8347.66609335632;8459.154084591615;8499.61751721174;8613.913860861312;568.3435631845225;658.9670516474157;687.1033301541536;702.2766550453042;734.797930569087;3912.1197730510976;3948.230095131422;3997.9721871552183;4107.732997355162;4120.363221574134;51437;53199.46800531945;53472.465275346745;53537.46462535325;53652.46347536475;48342.75828620905;49449;49773.50226497761;50077.74961125171;50252.49747502478;43161;43345;43662.56337436649;43742.56257437512;43976.78011609922;8064.959675201587;8218.83562328762;8244.670213191404;8282.1303763104;8514.446560973516;31938;32159.03522894317;32706;33156.363418218476;33287.667123329426;39781.60218397779;41562.792186038874;42228.57771422246;42323.57676423196;44756.10487790291;10825.729356766144;10955.397453139834;11129.054030407506;11345.376004319842;11575.247608905394;12253;12332.383380831103;12452.875471245172;12455;12511.12422130442;10434.24827921113;10681.412522311348;10908.509117089592;10929.344239345664;10948.726281843017;11970.76058478843;12106.455209515769;12194.329311887932;12465.5013799447;12496.812547811609;10162.39025658463;11101.833472498081;11109.555617775199;11197.832032519356;11632;9390.624375024923;9465.242780577675;9519.190868776232;9709.50418383914;9775.511224438607;9008.189262966365;9035;9050.275977921881;9054.366194366332;9382.859257111013 14:22:08 INFO - PROCESS | 5301 | __end_tp_report 14:22:08 INFO - PROCESS | 5301 | __start_cc_report 14:22:08 INFO - PROCESS | 5301 | _x_x_mozilla_cycle_collect,901 14:22:08 INFO - PROCESS | 5301 | __end_cc_report 14:22:08 INFO - PROCESS | 5301 | __startTimestamp1453501328178__endTimestamp 14:22:08 INFO - PROCESS | 5301 | 14:22:08 INFO - PROCESS | 5301 | ------- Summary: start ------- 14:22:08 INFO - PROCESS | 5301 | Number of tests: 6 14:22:08 INFO - PROCESS | 5301 | 14:22:08 INFO - PROCESS | 5301 | [#0] dojo.html Cycles:165 Average:5010.75 Median:5204.27 stddev:526.10 (10.1%) stddev-sans-first:505.41 14:22:08 INFO - PROCESS | 5301 | Values: 3078.6 3088.0 3158.9 3160.8 3173.9 4886.1 4991.3 5013.9 5052.4 5060.6 4952.4 4964.1 5054.4 5102.3 5130.5 4592.7 4618.0 4629.8 4665.7 4710.5 4623.6 4688.0 4723.1 4724.1 4759.7 4518.8 4589.6 4670.9 4677.8 4775.9 4569.8 4628.4 4630.7 4643.0 4647.0 4588.2 4597.7 4607.8 4610.7 4651.3 4815.2 4841.6 4857.0 4890.1 4908.9 5266.6 5295.7 5296.8 5318.2 5344.1 5325.5 5345.3 5350.5 5351.4 5380.9 5022.7 5024.5 5081.4 5102.5 5166.6 5476.2 5483.9 5488.4 5499.2 5525.5 5271.6 5272.2 5276.8 5283.9 5289.8 5327.5 5349.7 5402.2 5418.3 5430.5 5313.4 5317.2 5319.2 5344.5 5347.6 5315.9 5323.6 5330.6 5333.0 5371.7 4129.9 4187.9 4192.0 4214.9 4281.7 3719.3 3720.5 3731.0 3758.4 3763.4 4923.3 4930.2 4939.2 4944.5 4949.3 5313.7 5385.5 5395.6 5413.6 5490.9 5036.2 5050.5 5054.4 5057.6 5065.7 4658.6 4664.7 4674.1 4683.3 4706.5 5445.6 5511.5 5578.8 5642.1 5682.2 5421.0 5437.6 5437.9 5445.6 5445.8 5588.7 5643.1 5657.6 5664.6 5713.9 5269.4 5326.5 5351.5 5358.5 5365.5 5351.5 5358.8 5361.2 5367.7 5369.8 5205.3 5214.9 5249.3 5259.4 5305.3 5141.5 5273.7 5299.7 5302.2 5341.8 5204.3 5204.9 5215.4 5216.5 5268.8 5125.9 5196.0 5261.2 5320.1 5328.5 5143.0 5149.2 5179.9 5188.3 5237.7 14:22:08 INFO - PROCESS | 5301 | 14:22:08 INFO - PROCESS | 5301 | [#1] ext.html Cycles:180 Average:44315.30 Median:205221.13 stddev:76128.08 (37.1%) stddev-sans-first:76270.65 14:22:08 INFO - PROCESS | 5301 | Values: 528.2 536.6 538.6 556.3 559.8 27962.9 28756.3 34542.2 34923.8 35114.6 37753.6 38208.0 38237.6 38328.2 38477.6 8362.6 8556.0 8556.0 8558.5 8562.0 8235.7 8346.1 8348.2 8362.2 8363.8 8537.7 8565.1 8595.1 8603.1 8603.1 8461.0 8514.9 8521.5 8523.6 8528.6 8449.7 8565.2 8581.8 8585.9 8592.3 37611.0 37912.4 37990.2 38059.6 38066.8 3127.6 3172.8 3230.5 3745.7 3828.4 26609.6 27149.2 27164.3 27313.6 27524.6 3776.7 3889.5 3903.5 3991.3 3996.8 261229.0 262216.0 262508.0 263293.0 265947.0 51641.2 53167.5 58847.0 60098.0 61494.4 53289.7 53421.7 53600.7 53650.7 53657.7 12718.6 13263.5 13360.2 13416.7 13428.4 9030.0 9107.4 9126.7 9169.3 9178.6 19247.0 19332.9 19378.4 19384.5 19498.2 7665.2 7950.8 7982.4 7995.8 8088.9 894.7 1011.7 1016.4 1040.9 1062.5 27683.3 28092.0 28094.7 28334.4 28439.3 988.8 1022.0 1028.2 1030.0 1127.8 14708.7 15024.2 15872.9 16972.9 16997.6 373501.3 377947.7 378772.0 379335.0 379399.0 52745.7 52868.2 53214.7 53692.5 56158.7 1285.3 1318.0 1324.1 1328.8 1334.2 25908.0 26265.7 26360.3 26399.7 27293.0 41797.6 42280.6 42292.0 46189.5 47394.8 197126.0 198135.0 198916.0 199653.0 200384.0 31733.4 32073.0 32086.4 32091.5 32159.8 40743.0 41360.4 41541.8 41885.2 42036.8 34959.1 35056.5 35243.4 35429.8 35470.3 35486.3 35921.8 36511.3 36728.8 36941.0 34676.0 35280.1 35310.5 35377.5 35423.6 29871.7 31578.0 32269.5 32320.7 32397.2 24513.6 26120.9 26217.2 26218.6 26703.2 14:22:08 INFO - PROCESS | 5301 | 14:22:08 INFO - PROCESS | 5301 | [#2] jquery.html Cycles:180 Average:26667.97 Median:256194.94 stddev:86992.61 (34.0%) stddev-sans-first:87214.21 14:22:08 INFO - PROCESS | 5301 | Values: 358.6 360.3 361.8 362.3 366.1 13734.9 13841.6 15643.6 16722.2 18109.7 15904.7 16351.3 16720.2 16818.5 17001.7 5280.9 5498.5 5499.3 5505.2 5506.3 3987.7 4102.8 5350.2 5468.1 5770.5 5693.6 5865.6 5933.6 5942.0 5942.0 5738.2 5749.1 5767.3 5774.9 5784.7 4993.9 5111.3 5150.5 5207.0 5208.6 19490.4 19703.1 19794.0 19850.8 20083.7 2206.1 2227.4 2284.8 2326.9 2442.7 12740.0 12773.6 12813.8 12986.7 13270.4 1646.2 1728.8 1742.4 1816.0 1875.5 52738.0 54251.0 55044.4 55439.0 55940.0 9053.5 9102.6 9212.7 9219.1 9300.9 11768.9 11785.3 11820.3 11832.0 11850.7 6461.1 6559.3 6593.0 6605.0 6614.7 6129.4 6141.2 6189.9 6190.8 6201.2 5649.5 5728.1 5730.2 5783.7 5784.4 1540.5 1600.1 1648.7 1723.3 1742.2 963.9 997.7 1016.2 1055.6 1061.0 16300.5 16716.2 16774.8 16918.5 17121.1 830.8 841.0 911.2 934.3 1016.8 8480.4 9071.7 9077.2 9287.6 9366.6 507396.0 522103.0 534510.0 535985.0 566156.0 45372.8 45904.5 46109.3 69982.3 70109.9 1149.9 1150.9 1193.8 1200.1 1216.1 13861.6 14005.4 14038.9 14083.0 14349.1 30727.0 30763.4 30906.4 31635.4 32101.0 42791.0 42791.4 44092.9 44393.3 45760.8 6697.3 6842.8 7074.7 7137.6 7195.7 7787.6 10141.6 10315.5 10949.2 11183.0 9096.3 9304.2 9421.8 9424.9 9667.5 9466.9 9483.8 9692.5 9835.9 10574.0 3152.8 4303.1 9563.9 10136.8 10143.9 7281.7 7294.4 7328.2 7366.4 7389.0 9417.8 9665.3 9925.7 10048.5 10073.5 14:22:08 INFO - PROCESS | 5301 | 14:22:08 INFO - PROCESS | 5301 | [#3] mootools.html Cycles:180 Average:5321.97 Median:6589.78 stddev:2722.38 (41.3%) stddev-sans-first:2713.52 14:22:08 INFO - PROCESS | 5301 | Values: 1335.3 1439.6 1449.3 1585.2 1759.6 6675.0 7339.3 7424.8 7426.4 7431.9 7166.0 7259.9 7307.9 7317.2 7335.1 1960.4 2007.2 2009.7 2230.7 2258.8 1966.4 2237.0 2267.4 2267.5 2274.0 2205.8 2232.7 2236.4 2240.8 2265.5 2227.1 2229.0 2231.7 2232.3 2232.7 2197.2 2249.4 2253.4 2253.8 2272.7 7637.7 7690.2 7722.2 7729.1 7739.9 4489.2 4618.0 4620.2 4624.9 4652.2 3020.4 3071.2 3085.0 3085.8 3115.5 976.0 1000.0 1001.8 1008.7 1083.6 9947.8 9949.8 9958.8 9969.1 9982.5 4186.2 4224.1 4236.9 4261.6 4290.0 8677.4 8679.3 8687.2 8693.4 8696.2 4591.3 4609.9 4616.0 4618.2 4624.2 4150.5 4154.5 4158.4 4161.6 4162.6 3370.1 3639.1 3642.7 3659.4 3669.6 1116.3 1179.3 1200.0 1203.5 1211.1 1093.1 1115.5 1116.2 1118.8 1145.6 6916.8 6974.0 7006.1 7015.8 7018.3 1078.3 1088.9 1120.3 1123.5 1132.3 5576.0 5675.6 5710.7 5759.7 5774.1 9043.7 9174.8 9267.2 9276.1 9283.6 8953.2 9094.0 9094.0 9114.7 9224.6 7248.4 7262.3 7318.1 7322.4 7343.8 6939.4 6994.5 7018.1 7069.7 7083.6 8121.8 8169.6 8371.5 8378.7 8380.0 8347.6 8451.7 8565.0 8599.3 8609.4 6846.7 6909.6 6909.7 6924.3 6930.7 6517.8 6625.3 7291.3 7348.0 7382.9 6754.0 6800.8 6812.6 6910.6 6922.7 6599.9 6670.0 6718.3 6795.4 6799.6 6756.4 6952.6 6957.8 6964.3 6975.6 6365.0 6371.8 6378.8 6406.3 6419.5 6415.9 6585.4 6594.1 6607.9 6609.8 14:22:08 INFO - PROCESS | 5301 | 14:22:08 INFO - PROCESS | 5301 | [#4] prototype.html Cycles:180 Average:5153.81 Median:5870.28 stddev:1572.10 (26.8%) stddev-sans-first:1533.98 14:22:08 INFO - PROCESS | 5301 | Values: 314.9 320.7 322.4 324.9 328.6 5805.4 5823.2 5837.0 5839.7 5848.2 5766.1 5781.1 5784.9 5785.8 5798.3 4242.8 4306.2 4350.1 4441.7 4444.8 4183.5 4359.3 4366.1 4366.1 4392.8 4338.6 4360.3 4364.3 4367.5 4379.5 4352.8 4359.5 4367.4 4369.3 4385.5 3710.6 3778.2 3786.3 3828.4 3868.7 5413.1 5462.3 5465.9 5470.1 5483.7 5111.8 5122.4 5123.6 5123.8 5124.7 5931.0 6084.0 6089.8 6091.9 6097.3 4283.9 4315.3 4317.4 4320.8 4320.8 6423.5 6423.9 6426.0 6429.5 6431.0 4415.2 4418.7 4420.5 4422.5 4428.7 4256.5 4464.1 4465.9 4466.7 4469.3 5042.8 5045.1 5052.6 5059.6 5062.8 6112.6 6171.4 6176.0 6179.7 6183.7 1512.8 1547.4 1547.7 1549.0 1549.3 1003.4 1022.4 1026.3 1029.5 1030.6 5865.0 5880.8 5882.2 5882.9 5886.3 6346.3 6356.3 6357.0 6357.8 6368.5 5875.6 5876.4 5879.6 5879.8 5883.5 3326.7 3419.0 3425.3 3433.4 3436.7 6437.6 6510.4 6684.4 6693.3 6715.6 6521.4 6551.5 6553.1 6555.2 6567.0 6536.9 6672.9 6744.0 6776.3 6777.5 6409.3 6411.8 6412.3 6412.8 6415.1 6327.2 6329.9 6332.4 6336.2 6339.4 6418.6 6561.6 6566.2 6569.6 6578.2 4375.0 4399.1 4403.7 4405.2 4408.0 6402.2 6406.2 6411.7 6415.8 6416.2 6197.3 6246.8 6250.5 6254.4 6254.8 6102.4 6230.2 6233.7 6236.1 6239.0 6115.3 6125.2 6126.7 6127.9 6130.9 6255.2 6263.5 6264.2 6264.3 6266.6 5941.9 6101.1 6101.2 6101.9 6102.5 14:22:08 INFO - PROCESS | 5301 | 14:22:08 INFO - PROCESS | 5301 | [#5] yui.html Cycles:180 Average:13260.17 Median:43859.67 stddev:15143.34 (34.5%) stddev-sans-first:15156.35 14:22:08 INFO - PROCESS | 5301 | Values: 679.7 689.7 735.8 759.9 762.5 12507.6 12699.2 12705.4 12735.1 12754.2 11953.6 11994.3 12001.7 12010.2 12021.5 651.8 659.7 778.4 786.2 805.0 781.4 790.4 794.9 799.8 800.0 815.0 827.6 828.5 829.9 830.6 693.3 701.4 822.2 835.4 839.7 614.5 616.6 617.9 618.2 619.6 11190.3 11391.4 11567.8 11599.1 11634.7 12398.8 12540.5 12623.1 12638.8 12727.2 10513.5 10565.8 10670.1 10675.8 10777.0 3580.9 3644.0 3655.3 3736.8 3751.7 47654.0 47887.0 47940.8 48206.0 48643.5 9668.2 9848.0 10023.6 10026.5 10332.7 17400.1 17428.1 17530.1 17739.1 17745.0 7288.0 7352.0 7376.5 7438.9 7504.4 3973.7 4092.7 4104.8 4124.2 4173.9 2904.2 2908.2 2910.5 2917.0 2920.0 536.5 549.2 549.5 550.1 554.9 484.5 534.9 560.9 564.3 665.4 8337.4 8347.7 8459.2 8499.6 8613.9 568.3 659.0 687.1 702.3 734.8 3912.1 3948.2 3998.0 4107.7 4120.4 51437.0 53199.5 53472.5 53537.5 53652.5 48342.8 49449.0 49773.5 50077.7 50252.5 43161.0 43345.0 43662.6 43742.6 43976.8 8065.0 8218.8 8244.7 8282.1 8514.4 31938.0 32159.0 32706.0 33156.4 33287.7 39781.6 41562.8 42228.6 42323.6 44756.1 10825.7 10955.4 11129.1 11345.4 11575.2 12253.0 12332.4 12452.9 12455.0 12511.1 10434.2 10681.4 10908.5 10929.3 10948.7 11970.8 12106.5 12194.3 12465.5 12496.8 10162.4 11101.8 11109.6 11197.8 11632.0 9390.6 9465.2 9519.2 9709.5 9775.5 9008.2 9035.0 9050.3 9054.4 9382.9 14:22:08 INFO - PROCESS | 5301 | -------- Summary: end -------- 14:22:08 INFO - PROCESS | 5301 | 14:22:08 INFO - TEST-INFO | 5301: exit 0 14:22:08 INFO - TEST-OK | dromaeo_css | took 1113143ms 14:22:08 INFO - TEST-START | kraken 14:22:08 INFO - operating with platform_type : linux_ 14:22:08 INFO - Initialising browser for kraken test... 14:22:08 INFO - TEST-INFO | started process 5500 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkPzQXZ/profile http://localhost:47738/getInfo.html) 14:22:13 INFO - PROCESS | 5500 | __metrics Screen width/height:1600/1200 14:22:13 INFO - PROCESS | 5500 | colorDepth:24 14:22:13 INFO - PROCESS | 5500 | Browser inner width/height: 1024/697 14:22:13 INFO - PROCESS | 5500 | __metrics 14:22:13 INFO - PROCESS | 5500 | 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:22:13 INFO - PROCESS | 5500 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:22:14 INFO - TEST-INFO | 5500: exit 0 14:22:14 INFO - Browser initialized. 14:22:14 INFO - Running cycle 1/1 for kraken test... 14:22:14 INFO - TEST-INFO | started process 5584 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkPzQXZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:26 INFO - PROCESS | 5584 | RSS: Main: 148086784 14:22:26 INFO - PROCESS | 5584 | 14:22:28 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47738/tests/kraken/driver.html?testName=audio-beat-detection) 14:22:29 INFO - PROCESS | 5584 | RSS: Main: 187895808 14:22:29 INFO - PROCESS | 5584 | 14:22:31 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47738/tests/kraken/driver.html?testName=audio-dft) 14:22:32 INFO - PROCESS | 5584 | RSS: Main: 178515968 14:22:32 INFO - PROCESS | 5584 | 14:22:35 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47738/tests/kraken/driver.html?testName=audio-fft) 14:22:35 INFO - PROCESS | 5584 | RSS: Main: 162623488 14:22:35 INFO - PROCESS | 5584 | 14:22:37 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47738/tests/kraken/driver.html?testName=audio-oscillator) 14:22:38 INFO - PROCESS | 5584 | RSS: Main: 165785600 14:22:38 INFO - PROCESS | 5584 | 14:22:40 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47738/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:41 INFO - PROCESS | 5584 | RSS: Main: 167882752 14:22:41 INFO - PROCESS | 5584 | 14:22:44 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47738/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:44 INFO - PROCESS | 5584 | RSS: Main: 166854656 14:22:44 INFO - PROCESS | 5584 | 14:22:48 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47738/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:48 INFO - PROCESS | 5584 | RSS: Main: 168685568 14:22:48 INFO - PROCESS | 5584 | 14:22:51 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47738/tests/kraken/driver.html?testName=json-parse-financial) 14:22:51 INFO - PROCESS | 5584 | RSS: Main: 167256064 14:22:51 INFO - PROCESS | 5584 | 14:22:53 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47738/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:54 INFO - PROCESS | 5584 | RSS: Main: 179662848 14:22:54 INFO - PROCESS | 5584 | 14:22:55 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47738/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:22:56 INFO - PROCESS | 5584 | RSS: Main: 178503680 14:22:56 INFO - PROCESS | 5584 | 14:22:58 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47738/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:22:59 INFO - PROCESS | 5584 | RSS: Main: 188198912 14:22:59 INFO - PROCESS | 5584 | 14:23:01 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:23:02 INFO - PROCESS | 5584 | RSS: Main: 194195456 14:23:02 INFO - PROCESS | 5584 | 14:23:04 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:23:05 INFO - PROCESS | 5584 | RSS: Main: 192237568 14:23:05 INFO - PROCESS | 5584 | 14:23:06 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:47738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47738/tests/kraken/driver.html?testName=ai-astar) 14:23:07 INFO - PROCESS | 5584 | RSS: Main: 251760640 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | __start_tp_report 14:23:07 INFO - PROCESS | 5584 | _x_x_mozilla_page_load 14:23:07 INFO - PROCESS | 5584 | _x_x_mozilla_page_load_details 14:23:07 INFO - PROCESS | 5584 | |i|pagename|runs| 14:23:07 INFO - PROCESS | 5584 | |0;ai-astar;112;111;106;109;110;111;112;111;105;111 14:23:07 INFO - PROCESS | 5584 | |1;audio-beat-detection;152;127;154;178;132;148;149;138;162;128 14:23:07 INFO - PROCESS | 5584 | |2;audio-dft;161;160;163;161;161;164;160;160;162;162 14:23:07 INFO - PROCESS | 5584 | |3;audio-fft;75;77;99;100;73;73;72;112;95;76 14:23:07 INFO - PROCESS | 5584 | |4;audio-oscillator;96;97;150;95;95;96;140;95;96;136 14:23:07 INFO - PROCESS | 5584 | |5;imaging-gaussian-blur;110;109;110;110;109;109;109;110;109;109 14:23:07 INFO - PROCESS | 5584 | |6;imaging-darkroom;147;145;146;146;146;145;145;145;145;145 14:23:07 INFO - PROCESS | 5584 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;96 14:23:07 INFO - PROCESS | 5584 | |8;json-parse-financial;57;55;55;56;56;57;59;55;58;53 14:23:07 INFO - PROCESS | 5584 | |9;json-stringify-tinderbox;67;68;67;68;67;68;67;67;67;67 14:23:07 INFO - PROCESS | 5584 | |10;stanford-crypto-aes;83;83;83;82;82;83;85;83;91;84 14:23:07 INFO - PROCESS | 5584 | |11;stanford-crypto-ccm;115;122;114;113;126;121;122;115;113;122 14:23:07 INFO - PROCESS | 5584 | |12;stanford-crypto-pbkdf2;135;137;142;142;134;133;143;154;136;149 14:23:07 INFO - PROCESS | 5584 | |13;stanford-crypto-sha256-iterative;65;67;69;69;66;66;68;67;67;66 14:23:07 INFO - PROCESS | 5584 | __end_tp_report 14:23:07 INFO - PROCESS | 5584 | __start_cc_report 14:23:07 INFO - PROCESS | 5584 | _x_x_mozilla_cycle_collect,953 14:23:07 INFO - PROCESS | 5584 | __end_cc_report 14:23:07 INFO - PROCESS | 5584 | __startTimestamp1453501387088__endTimestamp 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | ------- Summary: start ------- 14:23:07 INFO - PROCESS | 5584 | Number of tests: 14 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:2.44 (2.2%) stddev-sans-first:2.46 14:23:07 INFO - PROCESS | 5584 | Values: 112.0 111.0 106.0 109.0 110.0 111.0 112.0 111.0 105.0 111.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:150.50 stddev:16.10 (10.7%) stddev-sans-first:16.96 14:23:07 INFO - PROCESS | 5584 | Values: 152.0 127.0 154.0 178.0 132.0 148.0 149.0 138.0 162.0 128.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.42 14:23:07 INFO - PROCESS | 5584 | Values: 161.0 160.0 163.0 161.0 161.0 164.0 160.0 160.0 162.0 162.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#3] audio-fft Cycles:10 Average:85.20 Median:75.50 stddev:14.73 (19.5%) stddev-sans-first:15.15 14:23:07 INFO - PROCESS | 5584 | Values: 75.0 77.0 99.0 100.0 73.0 73.0 72.0 112.0 95.0 76.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:95.50 stddev:22.62 (23.7%) stddev-sans-first:23.45 14:23:07 INFO - PROCESS | 5584 | Values: 96.0 97.0 150.0 95.0 95.0 96.0 140.0 95.0 96.0 136.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:23:07 INFO - PROCESS | 5584 | Values: 110.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 14:23:07 INFO - PROCESS | 5584 | Values: 147.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:23:07 INFO - PROCESS | 5584 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:1.73 (3.1%) stddev-sans-first:1.80 14:23:07 INFO - PROCESS | 5584 | Values: 57.0 55.0 55.0 56.0 56.0 57.0 59.0 55.0 58.0 53.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 14:23:07 INFO - PROCESS | 5584 | Values: 67.0 68.0 67.0 68.0 67.0 68.0 67.0 67.0 67.0 67.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:2.64 (3.2%) stddev-sans-first:2.78 14:23:07 INFO - PROCESS | 5584 | Values: 83.0 83.0 83.0 82.0 82.0 83.0 85.0 83.0 91.0 84.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:121.50 stddev:4.76 (3.9%) stddev-sans-first:4.90 14:23:07 INFO - PROCESS | 5584 | Values: 115.0 122.0 114.0 113.0 126.0 121.0 122.0 115.0 113.0 122.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:142.00 stddev:6.88 (4.8%) stddev-sans-first:7.01 14:23:07 INFO - PROCESS | 5584 | Values: 135.0 137.0 142.0 142.0 134.0 133.0 143.0 154.0 136.0 149.0 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - PROCESS | 5584 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.33 (2.0%) stddev-sans-first:1.20 14:23:07 INFO - PROCESS | 5584 | Values: 65.0 67.0 69.0 69.0 66.0 66.0 68.0 67.0 67.0 66.0 14:23:07 INFO - PROCESS | 5584 | -------- Summary: end -------- 14:23:07 INFO - PROCESS | 5584 | 14:23:07 INFO - TEST-INFO | 5584: exit 0 14:23:08 INFO - TEST-OK | kraken | took 59217ms 14:23:08 INFO - TEST-START | v8_7 14:23:08 INFO - operating with platform_type : linux_ 14:23:08 INFO - Initialising browser for v8_7 test... 14:23:08 INFO - TEST-INFO | started process 5834 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEKtM9I/profile http://localhost:47738/getInfo.html) 14:23:12 INFO - PROCESS | 5834 | __metrics Screen width/height:1600/1200 14:23:12 INFO - PROCESS | 5834 | colorDepth:24 14:23:12 INFO - PROCESS | 5834 | Browser inner width/height: 1024/697 14:23:12 INFO - PROCESS | 5834 | __metrics 14:23:12 INFO - PROCESS | 5834 | 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:23:12 INFO - PROCESS | 5834 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:23:13 INFO - TEST-INFO | 5834: exit 0 14:23:13 INFO - Browser initialized. 14:23:13 INFO - Running cycle 1/1 for v8_7 test... 14:23:13 INFO - TEST-INFO | started process 5913 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEKtM9I/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:25 INFO - PROCESS | 5913 | RSS: Main: 147869696 14:23:25 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:47738/tests/v8_7/run.html (next: http://localhost:47738/tests/v8_7/run.html) 14:23:47 INFO - PROCESS | 5913 | RSS: Main: 554278912 14:23:47 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | __start_tp_report 14:23:47 INFO - PROCESS | 5913 | _x_x_mozilla_page_load 14:23:47 INFO - PROCESS | 5913 | _x_x_mozilla_page_load_details 14:23:47 INFO - PROCESS | 5913 | |i|pagename|runs| 14:23:47 INFO - PROCESS | 5913 | |0;Richards;167.33601070950468 14:23:47 INFO - PROCESS | 5913 | |1;DeltaBlue;190.47619047619048 14:23:47 INFO - PROCESS | 5913 | |2;Encrypt;281.0567734682406 14:23:47 INFO - PROCESS | 5913 | |3;Decrypt;5263.1578947368425 14:23:47 INFO - PROCESS | 5913 | |4;RayTrace;1114.8272017837235 14:23:47 INFO - PROCESS | 5913 | |5;Earley;807.7544426494346 14:23:47 INFO - PROCESS | 5913 | |6;Boyer;12345.67901234568 14:23:47 INFO - PROCESS | 5913 | |7;RegExp;41000 14:23:47 INFO - PROCESS | 5913 | |8;Splay;582.5635103926097 14:23:47 INFO - PROCESS | 5913 | |9;NavierStokes;4840.579710144928 14:23:47 INFO - PROCESS | 5913 | __end_tp_report 14:23:47 INFO - PROCESS | 5913 | __startTimestamp1453501427879__endTimestamp 14:23:47 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | ------- Summary: start ------- 14:23:47 INFO - PROCESS | 5913 | Number of tests: 10 14:23:47 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 14:23:47 INFO - PROCESS | 5913 | Values: 167.3 14:23:47 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | [#1] DeltaBlue Cycles:1 Average:190.48 Median:190.48 stddev:0.00 (0.0%) 14:23:47 INFO - PROCESS | 5913 | Values: 190.5 14:23:47 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 14:23:47 INFO - PROCESS | 5913 | Values: 281.1 14:23:47 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 14:23:47 INFO - PROCESS | 5913 | Values: 5263.2 14:23:47 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | [#4] RayTrace Cycles:1 Average:1114.83 Median:1114.83 stddev:0.00 (0.0%) 14:23:47 INFO - PROCESS | 5913 | Values: 1114.8 14:23:47 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | [#5] Earley Cycles:1 Average:807.75 Median:807.75 stddev:0.00 (0.0%) 14:23:47 INFO - PROCESS | 5913 | Values: 807.8 14:23:47 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 14:23:47 INFO - PROCESS | 5913 | Values: 12345.7 14:23:47 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | [#7] RegExp Cycles:1 Average:41000.00 Median:41000.00 stddev:0.00 (0.0%) 14:23:47 INFO - PROCESS | 5913 | Values: 41000.0 14:23:47 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | [#8] Splay Cycles:1 Average:582.56 Median:582.56 stddev:0.00 (0.0%) 14:23:47 INFO - PROCESS | 5913 | Values: 582.6 14:23:47 INFO - PROCESS | 5913 | 14:23:47 INFO - PROCESS | 5913 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 14:23:47 INFO - PROCESS | 5913 | Values: 4840.6 14:23:47 INFO - PROCESS | 5913 | -------- Summary: end -------- 14:23:47 INFO - PROCESS | 5913 | 14:23:48 INFO - TEST-INFO | 5913: exit 0 14:23:48 INFO - TEST-OK | v8_7 | took 40646ms 14:23:48 INFO - SUITE-END | took 1213s 14:23:48 INFO - Completed test suite (00:20:13) 14:23:48 INFO - Working with test: dromaeo_css 14:23:48 INFO - Generating results file: dromaeo_css 14:23:48 INFO - Working with test: kraken 14:23:48 INFO - Generating results file: kraken 14:23:48 INFO - javascript benchmark 14:23:48 INFO - Working with test: v8_7 14:23:48 INFO - Generating results file: v8_7 14:23:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 14:23:48 INFO - process_Request line: dromaeo_css 6664.25 graph.html#tests=[[72,201,35]] 14:23:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:49 INFO - process_Request line: kraken 1496.80 graph.html#tests=[[232,201,35]] 14:23:49 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:49 INFO - process_Request line: v8_7 20036.55 graph.html#tests=[[230,201,35]] 14:23:49 INFO - RETURN: dromaeo_css: 6664.25 14:23:49 INFO - RETURN: kraken: 1496.80 14:23:49 INFO - RETURN: v8_7: 20036.55 14:23:49 INFO - javascript benchmark 14:23:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3078.6305643322803, 3087.9536806947895, 3158.9368212635763, 3160.8103513789174, 3173.9206519837007, 4886.096072226641, 4991.326170966919, 5013.899722005558, 5052.418971818242, 5060.645754797161, 4952.3561936948145, 4964.056829202449, 5054.444011158769, 5102.285680004802, 5130.486951304868, 4592.74739889306, 4617.976910115444, 4629.791659375336, 4665.650076244278, 4710.528947105279, 4623.606993405548, 4688.038952014829, 4723.07899959508, 4724.1260366832075, 4759.714417134983, 4518.796654150571, 4589.632829373642, 4670.9065818683775, 4677.836275730333, 4775.90448191036, 4569.771511424448, 4628.352030715669, 4630.652701047401, 4643.024964757405, 4646.976765116153, 4588.197065513556, 4597.7241365518175, 4607.838725644587, 4610.723356598614, 4651.348811166439, 4815.157347464215, 4841.564259216652, 4857.0, 4890.070886531547, 4908.9263661045115, 5266.552343050846, 5295.682259064469, 5296.788128474856, 5318.175682769177, 5344.091504444254, 5325.520703136697, 5345.251664766935, 5350.518453339179, 5351.438098999627, 5380.91928621071, 5022.67352622082, 5024.472430394792, 5081.390233172006, 5102.489751024942, 5166.5866730661455, 5476.205950137208, 5483.890322193533, 5488.396276409591, 5499.175123731472, 5525.502704756591, 5271.578273738091, 5272.156454967187, 5276.762545685453, 5283.894322113536, 5289.841304760864, 5327.547158491494, 5349.679019258857, 5402.216678581583, 5418.2685337479725, 5430.456954304538, 5313.362396512366, 5317.2024196370085, 5319.175527793198, 5344.4922732340365, 5347.572194224453, 5315.867103322371, 5323.600729945269, 5330.573554115739, 5332.973335133377, 5371.677699338053, 4129.855455059059, 4187.853425130106, 4192.0, 4214.936775948363, 4281.678874084394, 3719.256148770257, 3720.479132921393, 3731.029932217643, 3758.4174452959833, 3763.41667041609, 4923.335349727812, 4930.161872481687, 4939.185034469344, 4944.505549445099, 4949.282354058713, 5313.6811791291875, 5385.488378604026, 5395.595330350161, 5413.648112872651, 5490.862728431741, 5036.194208926554, 5050.520200580939, 5054.418741844662, 5057.620678449131, 5065.746712664352, 4658.557437043475, 4664.65015123867, 4674.11191873543, 4683.320918466871, 4706.505816889246, 5445.59158063139, 5511.476409741068, 5578.832635020955, 5642.125470551989, 5682.204491371212, 5420.972895135499, 5437.592180586551, 5437.918431223614, 5445.59158063139, 5445.782168713207, 5588.748506317144, 5643.068893632505, 5657.60396772222, 5664.631798933056, 5713.857153571194, 5269.394019687785, 5326.547243484192, 5351.518363347317, 5358.544523715528, 5365.543928765943, 5351.518363347317, 5358.758855851418, 5361.169018802092, 5367.651102678469, 5369.758360873848, 5205.349331333583, 5214.9478505214465, 5249.291345668286, 5259.39516955555, 5305.336832895888, 5141.53726164647, 5273.736313184402, 5299.655522391032, 5302.2046692996355, 5341.813036543703, 5204.271402003798, 5204.895902082013, 5215.4002289735645, 5216.530512253916, 5268.841934741964, 5125.923111153261, 5196.038732834287, 5261.158214685632, 5320.06898792702, 5328.4671532846405, 5143.048536020848, 5149.201873709581, 5179.922301165561, 5188.325517682677, 5237.738113094406], "unit": "score", "name": "dojo.html", "value": 4978.844885311349}, {"lowerIsBetter": false, "replicates": [528.1865926473231, 536.6404508978984, 538.6175815171229, 556.2629515891444, 559.7872808332833, 27962.860185699068, 28756.281092972687, 34542.23662107032, 34923.825380873124, 35114.648853511455, 37753.622463775355, 38208.0, 38237.61762382375, 38328.233435331276, 38477.61522384775, 8362.623681934312, 8555.95722021392, 8556.0, 8558.486490810541, 8561.972563292413, 8235.670573177065, 8346.123657015987, 8348.248657620812, 8362.16378362165, 8363.83272334553, 8537.743867683948, 8565.057843637225, 8595.140485951417, 8603.096674849145, 8603.096674849145, 8460.957695211515, 8514.914850851535, 8521.488710677379, 8523.57382130891, 8528.57357132144, 8449.662013519452, 8565.186307300797, 8581.785455363603, 8585.871211931764, 8592.269657079156, 37611.0, 37912.43131353032, 37990.24019519622, 38059.61940380588, 38066.80966595177, 3127.5934128563367, 3172.793768405046, 3230.499272612749, 3745.7190710696805, 3828.406596977473, 26609.600855987177, 27149.1855244343, 27164.320891977663, 27313.590296145572, 27524.58713119305, 3776.7356285060055, 3889.533256009297, 3903.4535165076913, 3991.2616166009093, 3996.760194388317, 261229.0, 262216.0, 262508.0, 263293.0, 265947.0, 51641.225381619304, 53167.46832531702, 58847.0, 60098.0, 61494.385056148865, 53289.73355133277, 53421.73289133607, 53600.731996340546, 53650.7317463418, 53657.73171134198, 12718.554850580185, 13263.469461221635, 13360.198388096745, 13416.664583385298, 13428.395722192525, 9029.954850225708, 9107.408018478778, 9126.680566180152, 9169.266458683423, 9178.613560474325, 19247.0, 19332.90333548323, 19378.418647440598, 19384.515387115152, 19498.220071197276, 7665.23347665229, 7950.801229969297, 7982.401319901031, 7995.800104997305, 8088.8786668198845, 894.7449976756593, 1011.6762635956424, 1016.4409574733867, 1040.9167266618651, 1062.5059347403494, 27683.307917301827, 28092.0, 28094.719052809618, 28334.433311333658, 28439.28901777472, 988.7923536057365, 1021.9744506387251, 1028.177845902714, 1030.0317701360698, 1127.768807394482, 14708.705825883422, 15024.173670448012, 15872.92063539675, 16972.915135424242, 16997.575060623585, 373501.26498734666, 377947.6615701533, 378772.0, 379335.0, 379399.0, 52745.7362713184, 52868.20697689538, 53214.73392633012, 53692.46307536953, 56158.71920640452, 1285.2802430638872, 1317.953871614489, 1324.0863803975033, 1328.8006798980036, 1334.2261488336742, 25908.0, 26265.73734262633, 26360.3409914746, 26399.73600263973, 27293.0, 41797.58202417937, 42280.57719422766, 42292.0, 46189.53810461987, 47394.76302618465, 197126.0, 198135.0, 198916.0, 199653.0, 200384.0, 31733.36533269368, 32073.0, 32086.358272833946, 32091.518627220143, 32159.839200803846, 40743.0, 41360.37959430551, 41541.79229103835, 41885.162296754504, 42036.789816050725, 34959.12602184864, 35056.47415288824, 35243.39859888638, 35429.82285088558, 35470.29059418849, 35486.29027419385, 35921.820390897876, 36511.26977460489, 36728.816355919116, 36941.0, 34676.0, 35280.11799705028, 35310.47034294436, 35377.469337960465, 35423.64576354204, 29871.70128298689, 31578.0, 32269.51595726113, 32320.676793231767, 32397.19007024843, 24513.632295515938, 26120.8693956529, 26217.213483594758, 26218.606720899585, 26703.19890403291], "unit": "score", "name": "ext.html", "value": 17716.966529882222}, {"lowerIsBetter": false, "replicates": [358.64673296802647, 360.3046120986496, 361.7738913179263, 362.27725687253934, 366.10852573982373, 13734.862651373483, 13841.584752457442, 15643.608909777262, 16722.163891805405, 18109.732318737693, 15904.681906361866, 16351.264193111308, 16720.163991800422, 16818.495445136665, 17001.74497382537, 5280.894382112365, 5498.532624726903, 5499.285092937933, 5505.201745746865, 5506.256655351536, 3987.7208595398333, 4102.815373308194, 5350.170723537838, 5468.0977638689565, 5770.4518070783415, 5693.572982026344, 5865.648061116325, 5933.643981361132, 5942.0, 5942.019566771478, 5738.196652468679, 5749.0514065179195, 5767.33675627304, 5774.942250577525, 5784.652920824764, 4993.875153121165, 5111.335526381584, 5150.510701483353, 5207.0366982108435, 5208.609354298443, 19490.415287541255, 19703.113359898696, 19794.0, 19850.80149198504, 20083.698744518842, 2206.095500844646, 2227.354067320475, 2284.805791507724, 2326.8836558172193, 2442.7312995570474, 12740.0, 12773.616791496177, 12813.807792883114, 12986.740265194738, 13270.402831872589, 1646.1851383565092, 1728.8357606027407, 1742.4162905426697, 1815.9649000069965, 1875.5404925793132, 52738.0, 54251.0, 55044.44955550433, 55439.0, 55940.0, 9053.502057386775, 9102.635894564275, 9212.677556285498, 9219.078092190728, 9300.90699093014, 11768.88231117695, 11785.292882427082, 11820.349880756641, 11832.0, 11850.703732406759, 6461.0631458438265, 6559.278479367265, 6592.967035164794, 6604.966975165094, 6614.7023383947835, 6129.35641757609, 6141.232345956755, 6189.876202475925, 6190.81427557174, 6201.193844800147, 5649.463300986482, 5728.112142617901, 5730.169125476783, 5783.710814459344, 5784.3926387729525, 1540.5224380442098, 1600.0559669794645, 1648.69499142659, 1723.258998630576, 1742.2421246757701, 963.9277054220961, 997.7261355698797, 1016.207358260558, 1055.630529314749, 1060.9787804243872, 16300.510984670478, 16716.24776885043, 16774.832251677326, 16918.492445226417, 17121.1166771655, 830.8379865926207, 841.0202114536496, 911.2300106410073, 934.2712684106408, 1016.7661437869332, 8480.406371553932, 9071.727848164566, 9077.228435583049, 9287.628494860264, 9366.62533498666, 507396.0, 522103.0, 534510.0, 535985.0, 566156.0, 45372.77313613477, 45904.540954590026, 46109.30836037462, 69982.30017699758, 70109.94835077478, 1149.9022583080532, 1150.8618965724, 1193.8328633991248, 1200.087933170779, 1216.0697066743949, 13861.584152475441, 14005.439782408997, 14038.859611404163, 14083.0, 14349.139051656934, 30727.0, 30763.38473230478, 30906.381872361977, 31635.36729265448, 32101.03696889097, 42791.0, 42791.3581296287, 44092.897677558314, 44393.33409998788, 45760.7711961438, 6697.296783837627, 6842.7605033823575, 7074.717011319695, 7137.571745695275, 7195.676194571152, 7787.649555769891, 10141.645042423479, 10315.535800889129, 10949.178811589321, 11183.0, 9096.317776166681, 9304.209142222986, 9421.81156376855, 9424.905750942677, 9667.46828924416, 9466.905330946878, 9483.810323793623, 9692.466914319499, 9835.93536697356, 10574.0, 3152.8265945373223, 4303.1393721255245, 9563.90436095658, 10136.847947280648, 10143.949280253551, 7281.708731650675, 7294.416446684359, 7328.230535793665, 7366.373858221897, 7389.0, 9417.811643767223, 9665.3234273603, 9925.702228933143, 10048.547815348473, 10073.546690399096], "unit": "score", "name": "jquery.html", "value": 8011.875579830888}, {"lowerIsBetter": false, "replicates": [1335.254610816659, 1439.6041088700606, 1449.3405500497279, 1585.231162886, 1759.6392739488406, 6675.0, 7339.302766237212, 7424.777256682295, 7426.405887528998, 7431.851362972738, 7165.964170179142, 7259.891101633467, 7307.926920730791, 7317.19510853807, 7335.119785625732, 1960.3530834824473, 2007.1770574064637, 2009.7186393904865, 2230.654248591467, 2258.7515373308925, 1966.429735376739, 2236.9776302237015, 2267.38780529257, 2267.5351552931693, 2273.96534576768, 2205.8014778669917, 2232.7320721513443, 2236.37381533171, 2240.843140980132, 2265.4676151104477, 2227.086894373307, 2229.0, 2231.6764069209953, 2232.3414592695112, 2232.6651002349613, 2197.230969160797, 2249.403907964391, 2253.4028482452163, 2253.808426283768, 2272.693186419845, 7637.656305466212, 7690.15408305086, 7722.1891701371105, 7729.149793522708, 7739.883901741478, 4489.169503641837, 4618.030213655136, 4620.214563524209, 4624.884377890546, 4652.209124448852, 3020.3808219315206, 3071.1707838883376, 3084.9691503084905, 3085.7531397488146, 3115.4859448191023, 975.9951200244025, 999.9850002249972, 1001.8296889528798, 1008.6620981971048, 1083.5611577311201, 9947.80104397908, 9949.801003979952, 9958.800823983553, 9969.102780749767, 9982.450965196911, 4186.1836941796055, 4224.070704445017, 4236.915261694749, 4261.595148460891, 4289.978550107229, 8677.435966662148, 8679.349048821363, 8687.174718401742, 8693.434926729742, 8696.17386348296, 4591.334256532851, 4609.884752881205, 4615.976920115378, 4618.1918164321105, 4624.190766615829, 4150.460440142762, 4154.543000269968, 4158.438610787505, 4161.563035881189, 4162.583741625874, 3370.1406141433777, 3639.053846000006, 3642.7450078494253, 3659.4144936809985, 3669.614690457517, 1116.330201878866, 1179.3042105157997, 1200.0459634590522, 1203.4704729918808, 1211.1158854036603, 1093.1254996003165, 1115.5482029777952, 1116.1963386361806, 1118.8433619293305, 1145.6162185667895, 6916.792496225121, 6974.0, 7006.089208402875, 7015.789526314219, 7018.298170182941, 1078.336822853939, 1088.907442867365, 1120.3445984099394, 1123.5112725964068, 1132.3262658718215, 5575.972120139373, 5675.602707810413, 5710.7430165642645, 5759.740811663485, 5774.105013722879, 9043.68347107848, 9174.770630734285, 9267.192897384944, 9276.07239276067, 9283.62865485373, 8953.194212520904, 9093.954530227438, 9093.99966003739, 9114.680986165453, 9224.584893679801, 7248.383887369527, 7262.257058306074, 7318.085239345082, 7322.3775979042375, 7343.77968660941, 6939.410150137295, 6994.510384273052, 7018.122734658168, 7069.681864316221, 7083.574985500886, 8121.796955075934, 8169.632366543401, 8371.497710137412, 8378.706745263886, 8380.0, 8347.624356904076, 8451.66193352259, 8565.0, 8599.26906212979, 8609.354298427517, 6846.657667116724, 6909.585424874524, 6909.689063992032, 6924.3421874923815, 6930.653467326714, 6517.837054073686, 6625.337466253336, 7291.270872912666, 7348.0, 7382.889256661262, 6754.0, 6800.761973330909, 6812.591244525344, 6910.619915904674, 6922.723091076301, 6599.934000659932, 6670.0, 6718.260991291052, 6795.437049478549, 6799.558028728117, 6756.391924726799, 6952.582845029315, 6957.826054348682, 6964.338387853146, 6975.616341101085, 6365.0, 6371.808845734636, 6378.77674281398, 6406.295307516077, 6419.518536109717, 6415.903761443676, 6585.4073133416305, 6594.142761440982, 6607.933920660732, 6609.801705948829], "unit": "score", "name": "mootools.html", "value": 4388.052910614444}, {"lowerIsBetter": false, "replicates": [314.8551666233533, 320.67291362809937, 322.3842460899682, 324.9155219642895, 328.58762253372, 5805.419458054193, 5823.242978412811, 5837.036888913324, 5839.708014599269, 5848.210491583635, 5766.077427611583, 5781.13283007549, 5784.884302313952, 5785.82642520724, 5798.275215598051, 4242.766647834368, 4306.181825453154, 4350.064736081742, 4441.666874984373, 4444.755538445384, 4183.477065366829, 4359.346098085281, 4366.061296821183, 4366.104948485553, 4392.758398288093, 4338.609525142737, 4360.324149756792, 4364.323529852878, 4367.475902891641, 4379.496357918848, 4352.782360881959, 4359.476862776455, 4367.388565600819, 4369.3227549729845, 4385.539518350591, 3710.573284072312, 3778.1876896467393, 3786.318462676717, 3828.3683192273243, 3868.6905047596124, 5413.079776437976, 5462.289902312714, 5465.863353416196, 5470.070088085035, 5483.725813709299, 5111.821086262, 5122.436531981479, 5123.641345105844, 5123.820666276662, 5124.718140502271, 5930.970345148246, 6084.0, 6089.786857460012, 6091.908621370683, 6097.3292937776805, 4283.87148385549, 4315.30955047194, 4317.41714868495, 4320.805563749639, 4320.848770293056, 6423.454006409461, 6423.93576064238, 6426.0, 6429.485641148697, 6431.035344698239, 4415.2494076006515, 4418.734875907456, 4420.535843736361, 4422.49141348749, 4428.7121337112985, 4256.531781504032, 4464.129494748558, 4465.888352791141, 4466.709663871903, 4469.307257375112, 5042.773075211624, 5045.066662667418, 5052.5705315048635, 5059.595232381401, 5062.82280120194, 6112.633242005405, 6171.382861713792, 6176.042713379434, 6179.660118693425, 6183.659898705614, 1512.7882096506498, 1547.365580112171, 1547.7136729705041, 1549.0241148076639, 1549.3182999480193, 1003.4079892863246, 1022.4018948914968, 1026.3226270661328, 1029.5469993202967, 1030.5620111452602, 5864.970675146597, 5880.764769409261, 5882.176495290662, 5882.882342353129, 5886.264216972879, 6346.270178929482, 6356.269029061625, 6357.046443033582, 6357.809265722036, 6368.4586810121655, 5875.588708790344, 5876.44173803488, 5879.647221166743, 5879.794207202813, 5883.529317654577, 3326.6673332667024, 3419.042668052949, 3425.3491836550975, 3433.3819912415506, 3436.742244331685, 6437.613743175424, 6510.414062734377, 6684.364985326386, 6693.297203793629, 6715.597064176165, 6521.413072823469, 6551.475881929434, 6553.148090748267, 6555.180602424697, 6567.047778072153, 6536.901946470902, 6672.9332706673285, 6744.0, 6776.2546119926765, 6777.491688123312, 6409.294977552372, 6411.807645770635, 6412.294647588668, 6412.807615771534, 6415.06981487691, 6327.17746692927, 6329.92391293472, 6332.430081292706, 6336.239651241696, 6339.366063393623, 6418.550701450854, 6561.606303621798, 6566.212054553484, 6569.605823650596, 6578.210614726264, 4375.037491751809, 4399.098184872158, 4403.735775853459, 4405.163019026375, 4407.9861631824215, 6402.231732192166, 6406.23125224976, 6411.743530258737, 6415.839604009937, 6416.165898433173, 6197.256329240339, 6246.781362652286, 6250.531210159165, 6254.436390902274, 6254.843628909313, 6102.389761023862, 6230.221222347207, 6233.688315584293, 6236.064590311489, 6239.0, 6115.327313995368, 6125.203723515914, 6126.724297406538, 6127.908081378872, 6130.938690613037, 6255.218097737783, 6263.498920086473, 6264.154339164337, 6264.310925798068, 6266.561340706106, 5941.881162376815, 6101.115338275837, 6101.206843110367, 6101.938980610137, 6102.542309326907], "unit": "score", "name": "prototype.html", "value": 4639.468368417887}, {"lowerIsBetter": false, "replicates": [679.6839469646613, 689.6758523493959, 735.779266220134, 759.9468037237392, 762.5348537392191, 12507.624771256866, 12699.238045717264, 12705.36473176342, 12735.108542402035, 12754.234745915252, 11953.581624643139, 11994.280343179393, 12001.739817319187, 12010.21933574317, 12021.459034343454, 651.7849109793781, 659.6866488418011, 778.4356341652314, 786.19807796048, 805.0098378993841, 781.394419325022, 790.3953475591177, 794.9046114466244, 799.8120441696196, 800.0, 815.0016230118117, 827.6192951242435, 828.4615000249855, 829.9004119505638, 830.5805568188086, 693.2893783871522, 701.4003027411566, 822.1696086952162, 835.4444294544121, 839.7102999465175, 614.4684847606833, 616.5776443136466, 617.8826023055605, 618.2117799805239, 619.5910698938724, 11190.272632278877, 11391.373474458902, 11567.76864462706, 11599.130065245055, 11634.6509604712, 12398.75202495945, 12540.498380064786, 12623.116381853273, 12638.810417843739, 12727.23636581808, 10513.474326283731, 10565.841512377321, 10670.093042091432, 10675.83986240207, 10777.0, 3580.874669386585, 3644.034330902313, 3655.342038433081, 3736.8131593420494, 3751.737378383514, 47654.0, 47887.0, 47940.7602961983, 48206.0, 48643.51356486425, 9668.226541876633, 9847.950760246153, 10023.649172278936, 10026.548805303779, 10332.690019299433, 17400.140468327572, 17428.12859357027, 17530.12349382551, 17739.11304434773, 17745.0, 7288.0, 7352.0, 7376.483646144826, 7438.851222975511, 7504.437167212481, 3973.6821054315587, 4092.6725861930972, 4104.774237416911, 4124.1957818225155, 4173.8956526087095, 2904.215861717367, 2908.2293192304055, 2910.54886492594, 2916.9562456563167, 2920.036387991958, 536.495694047594, 549.1570439375539, 549.5219159331407, 550.0758725341465, 554.9472800083986, 484.4501490807888, 534.8769782949944, 560.9046462101453, 564.2523656155611, 665.3845193196274, 8337.374696897758, 8347.66609335632, 8459.154084591615, 8499.61751721174, 8613.913860861312, 568.3435631845225, 658.9670516474157, 687.1033301541536, 702.2766550453042, 734.797930569087, 3912.1197730510976, 3948.230095131422, 3997.9721871552183, 4107.732997355162, 4120.363221574134, 51437.0, 53199.46800531945, 53472.465275346745, 53537.46462535325, 53652.46347536475, 48342.75828620905, 49449.0, 49773.50226497761, 50077.74961125171, 50252.49747502478, 43161.0, 43345.0, 43662.56337436649, 43742.56257437512, 43976.78011609922, 8064.959675201587, 8218.83562328762, 8244.670213191404, 8282.1303763104, 8514.446560973516, 31938.0, 32159.03522894317, 32706.0, 33156.363418218476, 33287.667123329426, 39781.60218397779, 41562.792186038874, 42228.57771422246, 42323.57676423196, 44756.10487790291, 10825.729356766144, 10955.397453139834, 11129.054030407506, 11345.376004319842, 11575.247608905394, 12253.0, 12332.383380831103, 12452.875471245172, 12455.0, 12511.12422130442, 10434.24827921113, 10681.412522311348, 10908.509117089592, 10929.344239345664, 10948.726281843017, 11970.76058478843, 12106.455209515769, 12194.329311887932, 12465.5013799447, 12496.812547811609, 10162.39025658463, 11101.833472498081, 11109.555617775199, 11197.832032519356, 11632.0, 9390.624375024923, 9465.242780577675, 9519.190868776232, 9709.50418383914, 9775.511224438607, 9008.189262966365, 9035.0, 9050.275977921881, 9054.366194366332, 9382.859257111013], "unit": "score", "name": "yui.html", "value": 6088.025417240604}], "name": "dromaeo_css", "value": 6664.249616697965}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 106.0, 109.0, 110.0, 111.0, 112.0, 111.0, 105.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 154.0, 178.0, 132.0, 148.0, 149.0, 138.0, 162.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 163.0, 161.0, 161.0, 164.0, 160.0, 160.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 99.0, 100.0, 73.0, 73.0, 72.0, 112.0, 95.0, 76.0], "unit": "score", "name": "audio-fft", "value": 85.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 150.0, 95.0, 95.0, 96.0, 140.0, 95.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 56.0, 56.0, 57.0, 59.0, 55.0, 58.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 82.0, 82.0, 83.0, 85.0, 83.0, 91.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [115.0, 122.0, 114.0, 113.0, 126.0, 121.0, 122.0, 115.0, 113.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [135.0, 137.0, 142.0, 142.0, 134.0, 133.0, 143.0, 154.0, 136.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 69.0, 69.0, 66.0, 66.0, 68.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1496.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [190.47619047619048], "unit": "score", "name": "DeltaBlue", "value": 347.1194999999999}, {"lowerIsBetter": false, "replicates": [281.0567734682406], "unit": "score", "name": "Encrypt", "value": 947.0719979999998}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1114.8272017837235], "unit": "score", "name": "RayTrace", "value": 663.7701329999999}, {"lowerIsBetter": false, "replicates": [807.7544426494346], "unit": "score", "name": "Earley", "value": 825.0811940000001}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [41000.0], "unit": "score", "name": "RegExp", "value": 22.219146341463418}, {"lowerIsBetter": false, "replicates": [582.5635103926097], "unit": "score", "name": "Splay", "value": 139.883460852329}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20036.552278481544}]} 14:23:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20036.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1496.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6664.25"}}} 14:23:49 INFO - Return code: 0 14:23:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:23:49 INFO - # TBPL SUCCESS # 14:23:49 INFO - Running post-action listener: _resource_record_post_action 14:23:49 INFO - Running post-run listener: _resource_record_post_run 14:23:50 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 566034432; Read time: 0; Write time: 477396 14:23:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236122112; Read time: 0; Write time: 264848 14:23:50 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 313147392; Read time: 0; Write time: 202540 14:23:50 INFO - Running post-run listener: _upload_blobber_files 14:23:50 INFO - Blob upload gear active. 14:23:50 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:23:50 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:23:50 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:23:50 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:23:51 INFO - (blobuploader) - INFO - Open directory for files ... 14:23:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:23:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:23:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:52 INFO - (blobuploader) - INFO - Done attempting. 14:23:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:23:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:23:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:53 INFO - (blobuploader) - INFO - Done attempting. 14:23:53 INFO - (blobuploader) - INFO - Iteration through files over. 14:23:53 INFO - Return code: 0 14:23:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:23:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:23:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a678e53ef83ec53c776b6e990daacce28ee66b2bbe7d30ba82e13a1466328938e4e3f0aa33b2336368682ed9f84a0f6f3a25bd5cd3169606b7915a7417359449", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f8efa488ed060ee01982dacaa5cc10e084f927c2eebd7a344df7a0b837570056347f555dc0beb6cfdbe1a22431b34af25e35114e0558945923b1abccfdba6f46"} 14:23:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:23:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:23:53 INFO - Contents: 14:23:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a678e53ef83ec53c776b6e990daacce28ee66b2bbe7d30ba82e13a1466328938e4e3f0aa33b2336368682ed9f84a0f6f3a25bd5cd3169606b7915a7417359449", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f8efa488ed060ee01982dacaa5cc10e084f927c2eebd7a344df7a0b837570056347f555dc0beb6cfdbe1a22431b34af25e35114e0558945923b1abccfdba6f46"} 14:23:53 INFO - Running post-run listener: copy_logs_to_upload_dir 14:23:53 INFO - Copying logs to upload dir... 14:23:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:23:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.326752 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-22 14:23:53.807961) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 14:23:53.811102) ========= 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=7de08804244eb36560b44971000001c3-1453496720.768728-1029133726 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/a678e53ef83ec53c776b6e990daacce28ee66b2bbe7d30ba82e13a1466328938e4e3f0aa33b2336368682ed9f84a0f6f3a25bd5cd3169606b7915a7417359449", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f8efa488ed060ee01982dacaa5cc10e084f927c2eebd7a344df7a0b837570056347f555dc0beb6cfdbe1a22431b34af25e35114e0558945923b1abccfdba6f46"} build_url:https://queue.taskcluster.net/v1/task/X3d0aoJKSzSVxKkGfkihUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/X3d0aoJKSzSVxKkGfkihUQ/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/a678e53ef83ec53c776b6e990daacce28ee66b2bbe7d30ba82e13a1466328938e4e3f0aa33b2336368682ed9f84a0f6f3a25bd5cd3169606b7915a7417359449", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f8efa488ed060ee01982dacaa5cc10e084f927c2eebd7a344df7a0b837570056347f555dc0beb6cfdbe1a22431b34af25e35114e0558945923b1abccfdba6f46"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 14:23:53.910060) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 14:23:53.910390) ========= 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=7de08804244eb36560b44971000001c3-1453496720.768728-1029133726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 14:23:54.039953) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 14:23:54.040264) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 14:23:54.040549) ========= ========= Total master_lag: 0.41 =========