builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1457258010.41 results: success (0) buildid: 20160305004010 builduid: 78e98833bf764a6db674705445841f3a revision: 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.406616) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.407013) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.407327) ========= 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=af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008937 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.482985) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.483286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.686276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.686579) ========= 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=af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013758 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.747838) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.748134) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.748518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.748838) ========= 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=af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-06 01:53:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-03-06 01:53:31 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.374612 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:31.140374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:31.141106) ========= 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=af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.080148 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:31.233161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:31.233964) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 --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=af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-06 01:53:31,759 truncating revision to first 12 chars 2016-03-06 01:53:31,759 Setting DEBUG logging. 2016-03-06 01:53:31,759 attempt 1/10 2016-03-06 01:53:31,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/383d2c72f4c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-06 01:53:32,264 unpacking tar archive at: mozilla-aurora-383d2c72f4c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.823699 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:32.075272) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:32.076005) ========= echo 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'383d2c72f4c77a81d44704272dcfbbe3c8cafca8'] 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=af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 program finished with exit code 0 elapsedTime=0.004610 script_repo_revision: '383d2c72f4c77a81d44704272dcfbbe3c8cafca8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:32.129605) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:32.129944) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:32.143860) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-03-06 01:53:32.144183) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:53:32 INFO - MultiFileLogger online at 20160306 01:53:32 in /builds/slave/test-pgo 01:53:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:53:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:53:32 INFO - {'append_to_log': False, 01:53:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:53:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:53:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:53:32 INFO - 'branch': 'Mozilla-Aurora', 01:53:32 INFO - 'buildbot_json_path': 'buildprops.json', 01:53:32 INFO - 'config_files': ('talos/linux_config.py',), 01:53:32 INFO - 'default_actions': ('clobber', 01:53:32 INFO - 'read-buildbot-config', 01:53:32 INFO - 'download-and-extract', 01:53:32 INFO - 'populate-webroot', 01:53:32 INFO - 'create-virtualenv', 01:53:32 INFO - 'install', 01:53:32 INFO - 'run-tests'), 01:53:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:53:32 INFO - 'download_minidump_stackwalk': True, 01:53:32 INFO - 'download_symbols': 'ondemand', 01:53:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:53:32 INFO - 'tooltool.py': '/tools/tooltool.py', 01:53:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:53:32 INFO - '/tools/misc-python/virtualenv.py')}, 01:53:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:53:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:53:32 INFO - 'installer_path': 'installer.exe', 01:53:32 INFO - 'log_level': 'info', 01:53:32 INFO - 'log_name': 'talos', 01:53:32 INFO - 'log_to_console': True, 01:53:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:53:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:53:32 INFO - 'opt_config_files': (), 01:53:32 INFO - 'pip_index': False, 01:53:32 INFO - 'sps_profile': False, 01:53:32 INFO - 'sps_profile_interval': 0, 01:53:32 INFO - 'suite': 'dromaeojs-e10s', 01:53:32 INFO - 'system_bits': '32', 01:53:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:53:32 INFO - 'title': 'talos-linux64-ix-020', 01:53:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:53:32 INFO - 'use_talos_json': True, 01:53:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:53:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:53:32 INFO - 'work_dir': 'build'} 01:53:32 INFO - ##### 01:53:32 INFO - ##### Running clobber step. 01:53:32 INFO - ##### 01:53:32 INFO - Running pre-action listener: _resource_record_pre_action 01:53:32 INFO - Running main action method: clobber 01:53:32 INFO - rmtree: /builds/slave/test-pgo/build 01:53:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:53:34 INFO - Running post-action listener: _resource_record_post_action 01:53:34 INFO - ##### 01:53:34 INFO - ##### Running read-buildbot-config step. 01:53:34 INFO - ##### 01:53:34 INFO - Running pre-action listener: _resource_record_pre_action 01:53:34 INFO - Running main action method: read_buildbot_config 01:53:34 INFO - Using buildbot properties: 01:53:34 INFO - { 01:53:34 INFO - "project": "", 01:53:34 INFO - "product": "firefox", 01:53:34 INFO - "script_repo_revision": "production", 01:53:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 01:53:34 INFO - "repository": "", 01:53:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 01:53:34 INFO - "buildid": "20160305004010", 01:53:34 INFO - "stage_platform": "linux64-pgo", 01:53:34 INFO - "basedir": "/builds/slave/test-pgo", 01:53:34 INFO - "nightly_build": "True", 01:53:34 INFO - "buildnumber": 210, 01:53:34 INFO - "slavename": "talos-linux64-ix-020", 01:53:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:53:34 INFO - "platform": "ubuntu64_hw", 01:53:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:53:34 INFO - "branch": "mozilla-aurora", 01:53:34 INFO - "repo_path": "releases/mozilla-aurora", 01:53:34 INFO - "revision": "383d2c72f4c77a81d44704272dcfbbe3c8cafca8", 01:53:34 INFO - "pgo_build": "True", 01:53:34 INFO - "builduid": "78e98833bf764a6db674705445841f3a", 01:53:34 INFO - "slavebuilddir": "test" 01:53:34 INFO - } 01:53:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 01:53:34 INFO - Running post-action listener: _resource_record_post_action 01:53:34 INFO - ##### 01:53:34 INFO - ##### Running download-and-extract step. 01:53:34 INFO - ##### 01:53:34 INFO - Running pre-action listener: _resource_record_pre_action 01:53:34 INFO - Running main action method: download_and_extract 01:53:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:53: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')]} 01:53:34 INFO - https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/test_packages.json 01:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/test_packages.json 01:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:53:38 INFO - Downloaded 1448 bytes. 01:53:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:53:38 INFO - Using the following test package requirements: 01:53:38 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 01:53:38 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:53:38 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:53:38 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'jsshell-linux-x86_64.zip'], 01:53:38 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:53:38 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 01:53:38 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:53:38 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:53:38 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:53:38 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 01:53:38 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:53:38 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:38 INFO - https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:53:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 01:53:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 01:53:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 01:53:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:53:40 INFO - Downloaded 23097249 bytes. 01:53:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:53:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:53:41 INFO - Return code: 0 01:53:41 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:53:41 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')]} 01:53:41 INFO - https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:53:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 01:53:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 01:53:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 01:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:53:43 INFO - Downloaded 23097249 bytes. 01:53:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:53:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:53:45 INFO - Return code: 0 01:53:45 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')]} 01:53:45 INFO - https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:53:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 01:53:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 01:53:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 01:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:53:45 INFO - Downloaded 10801536 bytes. 01:53:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:53:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 01:53:46 INFO - Return code: 0 01:53:46 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')]} 01:53:46 INFO - https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:53:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 01:53:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 01:53:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 01:53:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:53:48 INFO - Downloaded 59965510 bytes. 01:53:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 01:53:48 INFO - mkdir: /builds/slave/test-pgo/properties 01:53:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:53:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:53:48 INFO - Contents: 01:53:48 INFO - build_url:https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 01:53:49 INFO - Running post-action listener: _resource_record_post_action 01:53:49 INFO - Running post-action listener: set_extra_try_arguments 01:53:49 INFO - ##### 01:53:49 INFO - ##### Running populate-webroot step. 01:53:49 INFO - ##### 01:53:49 INFO - Running pre-action listener: _resource_record_pre_action 01:53:49 INFO - Running main action method: populate_webroot 01:53:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:53:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:53:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:53:49 INFO - '--tppagecycles', 01:53:49 INFO - '7'], 01:53:49 INFO - 'tests': ['tsvgm']}}, 01:53:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:53:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:53:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:53:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:53:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:53:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:53:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'tests': ['damp', 'tps']}, 01:53:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['damp', 'tps']}, 01:53:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:53:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:53:49 INFO - 'other': {'tests': ['a11yr', 01:53:49 INFO - 'ts_paint', 01:53:49 INFO - 'tpaint', 01:53:49 INFO - 'sessionrestore', 01:53:49 INFO - 'sessionrestore_no_auto_restore']}, 01:53:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['a11yr', 01:53:49 INFO - 'ts_paint', 01:53:49 INFO - 'tpaint', 01:53:49 INFO - 'sessionrestore', 01:53:49 INFO - 'sessionrestore_no_auto_restore']}, 01:53:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['a11yr', 01:53:49 INFO - 'ts_paint', 01:53:49 INFO - 'tpaint', 01:53:49 INFO - 'sessionrestore', 01:53:49 INFO - 'sessionrestore_no_auto_restore']}, 01:53:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['a11yr', 01:53:49 INFO - 'ts_paint', 01:53:49 INFO - 'tpaint', 01:53:49 INFO - 'sessionrestore', 01:53:49 INFO - 'sessionrestore_no_auto_restore']}, 01:53:49 INFO - 'other_l64': {'tests': ['a11yr', 01:53:49 INFO - 'ts_paint', 01:53:49 INFO - 'tpaint', 01:53:49 INFO - 'sessionrestore', 01:53:49 INFO - 'sessionrestore_no_auto_restore']}, 01:53:49 INFO - 'other_nol64': {'tests': ['a11yr', 01:53:49 INFO - 'ts_paint', 01:53:49 INFO - 'tpaint', 01:53:49 INFO - 'sessionrestore', 01:53:49 INFO - 'sessionrestore_no_auto_restore']}, 01:53:49 INFO - 'svgr': {'tests': ['tsvgx', 01:53:49 INFO - 'tsvgr_opacity', 01:53:49 INFO - 'tart', 01:53:49 INFO - 'tscrollx', 01:53:49 INFO - 'cart']}, 01:53:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['tsvgx', 01:53:49 INFO - 'tsvgr_opacity', 01:53:49 INFO - 'tart', 01:53:49 INFO - 'tscrollx', 01:53:49 INFO - 'cart']}, 01:53:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'tests': ['tp5o']}, 01:53:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['tp5o']}, 01:53:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'talos_options': ['--xperf_path', 01:53:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:53:49 INFO - 'tests': ['tp5n']}, 01:53:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'talos_options': ['--e10s', 01:53:49 INFO - '--xperf_path', 01:53:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:53:49 INFO - 'tests': ['tp5n']}}, 01:53:49 INFO - 'talos.zip': {'path': '', 01:53:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:53:49 INFO - Running post-action listener: _resource_record_post_action 01:53:49 INFO - ##### 01:53:49 INFO - ##### Running create-virtualenv step. 01:53:49 INFO - ##### 01:53:49 INFO - Running pre-action listener: _resource_record_pre_action 01:53:49 INFO - Running main action method: create_virtualenv 01:53:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:53:49 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 01:53:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:53:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:53:49 INFO - Using real prefix '/usr' 01:53:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:53:50 INFO - Installing distribute.............................................................................................................................................................................................done. 01:53:52 INFO - Installing pip.................done. 01:53:52 INFO - Return code: 0 01:53:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:52 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 0x7fe73d4e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6850>, '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 0x2c52330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c527c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', '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 01:53:52 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 01:53:52 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 01:53:52 INFO - Using env: {'DISPLAY': ':0', 01:53:52 INFO - 'HOME': '/home/cltbld', 01:53:52 INFO - 'LANG': 'en_US.UTF-8', 01:53:52 INFO - 'LANGUAGE': 'en_US:en', 01:53:52 INFO - 'LOGNAME': 'cltbld', 01:53:52 INFO - 'MAIL': '/var/mail/cltbld', 01:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:52 INFO - 'MOZ_NO_REMOTE': '1', 01:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:52 INFO - 'NO_EM_RESTART': '1', 01:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:52 INFO - 'SHELL': '/bin/bash', 01:53:52 INFO - 'SHLVL': '1', 01:53:52 INFO - 'TERM': 'linux', 01:53:52 INFO - 'TMOUT': '86400', 01:53:52 INFO - 'USER': 'cltbld', 01:53:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', 01:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:52 INFO - '_': '/tools/buildbot/bin/python'} 01:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:52 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 01:53:52 INFO - Cleaning up... 01:53:52 INFO - Return code: 0 01:53:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:52 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 0x7fe73d4e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6850>, '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 0x2c52330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c527c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', '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 01:53:52 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 01:53:52 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 01:53:52 INFO - Using env: {'DISPLAY': ':0', 01:53:52 INFO - 'HOME': '/home/cltbld', 01:53:52 INFO - 'LANG': 'en_US.UTF-8', 01:53:52 INFO - 'LANGUAGE': 'en_US:en', 01:53:52 INFO - 'LOGNAME': 'cltbld', 01:53:52 INFO - 'MAIL': '/var/mail/cltbld', 01:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:52 INFO - 'MOZ_NO_REMOTE': '1', 01:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:52 INFO - 'NO_EM_RESTART': '1', 01:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:52 INFO - 'SHELL': '/bin/bash', 01:53:52 INFO - 'SHLVL': '1', 01:53:52 INFO - 'TERM': 'linux', 01:53:52 INFO - 'TMOUT': '86400', 01:53:52 INFO - 'USER': 'cltbld', 01:53:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', 01:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:52 INFO - '_': '/tools/buildbot/bin/python'} 01:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:52 INFO - Downloading/unpacking psutil>=0.7.1 01:53:52 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 01:53:52 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 01:53:52 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 01:53:52 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 01:53:52 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 01:53:52 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 01:53:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:53:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:53:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:53:54 INFO - Installing collected packages: psutil 01:53:54 INFO - Running setup.py install for psutil 01:53:54 INFO - building 'psutil._psutil_linux' extension 01:53:54 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 01:53:54 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 01:53:54 INFO - building 'psutil._psutil_posix' extension 01:53:54 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 01:53:54 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 01:53:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:53:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:53:55 INFO - Successfully installed psutil 01:53:55 INFO - Cleaning up... 01:53:55 INFO - Return code: 0 01:53:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:55 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 0x7fe73d4e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6850>, '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 0x2c52330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c527c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', '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 01:53:55 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 01:53:55 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 01:53:55 INFO - Using env: {'DISPLAY': ':0', 01:53:55 INFO - 'HOME': '/home/cltbld', 01:53:55 INFO - 'LANG': 'en_US.UTF-8', 01:53:55 INFO - 'LANGUAGE': 'en_US:en', 01:53:55 INFO - 'LOGNAME': 'cltbld', 01:53:55 INFO - 'MAIL': '/var/mail/cltbld', 01:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:55 INFO - 'MOZ_NO_REMOTE': '1', 01:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:55 INFO - 'NO_EM_RESTART': '1', 01:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:55 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:55 INFO - 'SHELL': '/bin/bash', 01:53:55 INFO - 'SHLVL': '1', 01:53:55 INFO - 'TERM': 'linux', 01:53:55 INFO - 'TMOUT': '86400', 01:53:55 INFO - 'USER': 'cltbld', 01:53:55 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', 01:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:55 INFO - '_': '/tools/buildbot/bin/python'} 01:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:53:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:53:57 INFO - Installing collected packages: mozsystemmonitor 01:53:57 INFO - Running setup.py install for mozsystemmonitor 01:53:57 INFO - Successfully installed mozsystemmonitor 01:53:57 INFO - Cleaning up... 01:53:57 INFO - Return code: 0 01:53:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:53: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')]} 01:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53: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')]} 01:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53: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', '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 0x7fe73d4e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6850>, '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 0x2c52330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c527c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', '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 01:53: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:53: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 blobuploader==1.2.4 01:53:57 INFO - Using env: {'DISPLAY': ':0', 01:53:57 INFO - 'HOME': '/home/cltbld', 01:53:57 INFO - 'LANG': 'en_US.UTF-8', 01:53:57 INFO - 'LANGUAGE': 'en_US:en', 01:53:57 INFO - 'LOGNAME': 'cltbld', 01:53:57 INFO - 'MAIL': '/var/mail/cltbld', 01:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:57 INFO - 'MOZ_NO_REMOTE': '1', 01:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:57 INFO - 'NO_EM_RESTART': '1', 01:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:57 INFO - 'SHELL': '/bin/bash', 01:53:57 INFO - 'SHLVL': '1', 01:53:57 INFO - 'TERM': 'linux', 01:53:57 INFO - 'TMOUT': '86400', 01:53:57 INFO - 'USER': 'cltbld', 01:53:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', 01:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:57 INFO - '_': '/tools/buildbot/bin/python'} 01:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:57 INFO - Downloading/unpacking blobuploader==1.2.4 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53:59 INFO - Downloading blobuploader-1.2.4.tar.gz 01:53:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:53:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:53:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:00 INFO - Downloading docopt-0.6.1.tar.gz 01:54:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:54:00 INFO - Installing collected packages: blobuploader, requests, docopt 01:54:00 INFO - Running setup.py install for blobuploader 01:54:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:54:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:54:00 INFO - Running setup.py install for requests 01:54:00 INFO - Running setup.py install for docopt 01:54:00 INFO - Successfully installed blobuploader requests docopt 01:54:00 INFO - Cleaning up... 01:54:00 INFO - Return code: 0 01:54:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:54: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')]} 01:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:00 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 0x7fe73d4e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6850>, '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 0x2c52330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c527c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', '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 01:54:00 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 01:54:00 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 01:54:00 INFO - Using env: {'DISPLAY': ':0', 01:54:00 INFO - 'HOME': '/home/cltbld', 01:54:00 INFO - 'LANG': 'en_US.UTF-8', 01:54:00 INFO - 'LANGUAGE': 'en_US:en', 01:54:00 INFO - 'LOGNAME': 'cltbld', 01:54:00 INFO - 'MAIL': '/var/mail/cltbld', 01:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:00 INFO - 'MOZ_NO_REMOTE': '1', 01:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:00 INFO - 'NO_EM_RESTART': '1', 01:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:00 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:00 INFO - 'SHELL': '/bin/bash', 01:54:00 INFO - 'SHLVL': '1', 01:54:00 INFO - 'TERM': 'linux', 01:54:00 INFO - 'TMOUT': '86400', 01:54:00 INFO - 'USER': 'cltbld', 01:54:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', 01:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:00 INFO - '_': '/tools/buildbot/bin/python'} 01:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:54:00 INFO - Running setup.py (path:/tmp/pip-areF17-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:54:01 INFO - Running setup.py (path:/tmp/pip-U7khgy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:54:01 INFO - Running setup.py (path:/tmp/pip-CYv_rg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:54:01 INFO - Running setup.py (path:/tmp/pip-jZDv6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:54:01 INFO - Running setup.py (path:/tmp/pip-38vPX3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:54:01 INFO - Running setup.py (path:/tmp/pip-78KDyG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:54:01 INFO - Running setup.py (path:/tmp/pip-CGQ9H8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:54:01 INFO - Running setup.py (path:/tmp/pip-TjMZbC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:54:01 INFO - Running setup.py (path:/tmp/pip-dZEVkg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:54:01 INFO - Running setup.py (path:/tmp/pip-REEfK4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:54:01 INFO - Running setup.py (path:/tmp/pip-LHM2bC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:54:01 INFO - Running setup.py (path:/tmp/pip-rXJ5K_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:54:01 INFO - Running setup.py (path:/tmp/pip-JkiTVZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:54:01 INFO - Running setup.py (path:/tmp/pip-WOzXOq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:54:01 INFO - Running setup.py (path:/tmp/pip-2fBSQQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:54:01 INFO - Running setup.py (path:/tmp/pip-OE0WMV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:54:02 INFO - Running setup.py (path:/tmp/pip-gSLksr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:54:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:54:02 INFO - Running setup.py install for manifestparser 01:54:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Running setup.py install for mozcrash 01:54:02 INFO - Running setup.py install for mozdebug 01:54:02 INFO - Running setup.py install for mozdevice 01:54:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Running setup.py install for mozfile 01:54:02 INFO - Running setup.py install for mozhttpd 01:54:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Running setup.py install for mozinfo 01:54:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Running setup.py install for mozInstall 01:54:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Running setup.py install for mozleak 01:54:03 INFO - Running setup.py install for mozlog 01:54:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Running setup.py install for moznetwork 01:54:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Running setup.py install for mozprocess 01:54:03 INFO - Running setup.py install for mozprofile 01:54:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Running setup.py install for mozrunner 01:54:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Running setup.py install for mozscreenshot 01:54:03 INFO - Running setup.py install for moztest 01:54:03 INFO - Running setup.py install for mozversion 01:54:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:54:03 INFO - Cleaning up... 01:54:03 INFO - Return code: 0 01:54:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:03 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 0x7fe73d4e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6850>, '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 0x2c52330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c527c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', '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 01:54:03 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 01:54:03 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 01:54:03 INFO - Using env: {'DISPLAY': ':0', 01:54:03 INFO - 'HOME': '/home/cltbld', 01:54:03 INFO - 'LANG': 'en_US.UTF-8', 01:54:03 INFO - 'LANGUAGE': 'en_US:en', 01:54:03 INFO - 'LOGNAME': 'cltbld', 01:54:03 INFO - 'MAIL': '/var/mail/cltbld', 01:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:03 INFO - 'MOZ_NO_REMOTE': '1', 01:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:03 INFO - 'NO_EM_RESTART': '1', 01:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:03 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:03 INFO - 'SHELL': '/bin/bash', 01:54:03 INFO - 'SHLVL': '1', 01:54:03 INFO - 'TERM': 'linux', 01:54:03 INFO - 'TMOUT': '86400', 01:54:03 INFO - 'USER': 'cltbld', 01:54:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', 01:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:03 INFO - '_': '/tools/buildbot/bin/python'} 01:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:54:04 INFO - Running setup.py (path:/tmp/pip-zKkh20-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:54:04 INFO - Running setup.py (path:/tmp/pip-YMGw5J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:54:04 INFO - Running setup.py (path:/tmp/pip-6AqnG_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:54:04 INFO - Running setup.py (path:/tmp/pip-UnTdWG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:54:04 INFO - Running setup.py (path:/tmp/pip-6jBwko-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:54:04 INFO - Running setup.py (path:/tmp/pip-cPij_p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:54:04 INFO - Running setup.py (path:/tmp/pip-ay_kuQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:54:04 INFO - Running setup.py (path:/tmp/pip-ecTEo9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:54:04 INFO - Running setup.py (path:/tmp/pip-v81yKj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:54:04 INFO - Running setup.py (path:/tmp/pip-59A5OP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:54:04 INFO - Running setup.py (path:/tmp/pip-gto2wk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:54:04 INFO - Running setup.py (path:/tmp/pip-r30rYx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:54:05 INFO - Running setup.py (path:/tmp/pip-sQMRdr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:54:05 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)) 01:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:54:05 INFO - Running setup.py (path:/tmp/pip-a63OjZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:54:05 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)) 01:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:54:05 INFO - Running setup.py (path:/tmp/pip-0dEkg9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:54:05 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)) 01:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:54:05 INFO - Running setup.py (path:/tmp/pip-nAVOsm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:54:05 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)) 01:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:54:05 INFO - Running setup.py (path:/tmp/pip-A5o8DS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:54:05 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)) 01:54:05 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)) 01:54:05 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)) 01:54:05 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)) 01:54:05 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)) 01:54:05 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)) 01:54:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:07 INFO - Downloading blessings-1.6.tar.gz 01:54:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:54:07 INFO - Installing collected packages: blessings 01:54:07 INFO - Running setup.py install for blessings 01:54:07 INFO - Successfully installed blessings 01:54:07 INFO - Cleaning up... 01:54:07 INFO - Return code: 0 01:54:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:54:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:54:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:54:07 INFO - Reading from file tmpfile_stdout 01:54:07 INFO - Current package versions: 01:54:07 INFO - argparse == 1.2.1 01:54:07 INFO - blessings == 1.6 01:54:07 INFO - blobuploader == 1.2.4 01:54:07 INFO - docopt == 0.6.1 01:54:07 INFO - manifestparser == 1.1 01:54:07 INFO - mozInstall == 1.12 01:54:07 INFO - mozcrash == 0.16 01:54:07 INFO - mozdebug == 0.1 01:54:07 INFO - mozdevice == 0.48 01:54:07 INFO - mozfile == 1.2 01:54:07 INFO - mozhttpd == 0.7 01:54:07 INFO - mozinfo == 0.9 01:54:07 INFO - mozleak == 0.1 01:54:07 INFO - mozlog == 3.1 01:54:07 INFO - moznetwork == 0.27 01:54:07 INFO - mozprocess == 0.22 01:54:07 INFO - mozprofile == 0.28 01:54:07 INFO - mozrunner == 6.11 01:54:07 INFO - mozscreenshot == 0.1 01:54:07 INFO - mozsystemmonitor == 0.0 01:54:07 INFO - moztest == 0.7 01:54:07 INFO - mozversion == 1.4 01:54:07 INFO - psutil == 3.1.1 01:54:07 INFO - requests == 1.2.3 01:54:07 INFO - wsgiref == 0.1.2 01:54:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fe73d4e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6850>, '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 0x2c52330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c527c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', '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 01:54:07 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 01:54:07 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 01:54:07 INFO - Using env: {'DISPLAY': ':0', 01:54:07 INFO - 'HOME': '/home/cltbld', 01:54:07 INFO - 'LANG': 'en_US.UTF-8', 01:54:07 INFO - 'LANGUAGE': 'en_US:en', 01:54:07 INFO - 'LOGNAME': 'cltbld', 01:54:07 INFO - 'MAIL': '/var/mail/cltbld', 01:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:07 INFO - 'MOZ_NO_REMOTE': '1', 01:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:07 INFO - 'NO_EM_RESTART': '1', 01:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:07 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:07 INFO - 'SHELL': '/bin/bash', 01:54:07 INFO - 'SHLVL': '1', 01:54:07 INFO - 'TERM': 'linux', 01:54:07 INFO - 'TMOUT': '86400', 01:54:07 INFO - 'USER': 'cltbld', 01:54:07 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', 01:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:07 INFO - '_': '/tools/buildbot/bin/python'} 01:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 INFO - Cleaning up... 01:54:07 INFO - Return code: 0 01:54:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:07 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 0x7fe73d4e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6850>, '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 0x2c52330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c527c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', '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 01:54:07 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 01:54:07 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 01:54:07 INFO - Using env: {'DISPLAY': ':0', 01:54:07 INFO - 'HOME': '/home/cltbld', 01:54:07 INFO - 'LANG': 'en_US.UTF-8', 01:54:07 INFO - 'LANGUAGE': 'en_US:en', 01:54:07 INFO - 'LOGNAME': 'cltbld', 01:54:07 INFO - 'MAIL': '/var/mail/cltbld', 01:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:07 INFO - 'MOZ_NO_REMOTE': '1', 01:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:07 INFO - 'NO_EM_RESTART': '1', 01:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:07 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:07 INFO - 'SHELL': '/bin/bash', 01:54:07 INFO - 'SHLVL': '1', 01:54:07 INFO - 'TERM': 'linux', 01:54:07 INFO - 'TMOUT': '86400', 01:54:07 INFO - 'USER': 'cltbld', 01:54:07 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', 01:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:07 INFO - '_': '/tools/buildbot/bin/python'} 01:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:08 INFO - Downloading/unpacking jsonschema 01:54:08 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 01:54:08 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 01:54:08 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 01:54:08 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 01:54:08 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 01:54:08 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 01:54:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:54:09 INFO - Downloading/unpacking functools32 (from jsonschema) 01:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:10 INFO - Downloading functools32-3.2.3-2.tar.gz 01:54:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:54:10 INFO - warning: no files found matching '*.txt' 01:54:10 INFO - no previously-included directories found matching 'build' 01:54:10 INFO - no previously-included directories found matching 'dist' 01:54:10 INFO - no previously-included directories found matching '.git*' 01:54:10 INFO - Installing collected packages: jsonschema, functools32 01:54:10 INFO - Running setup.py install for functools32 01:54:10 INFO - warning: no files found matching '*.txt' 01:54:10 INFO - no previously-included directories found matching 'build' 01:54:10 INFO - no previously-included directories found matching 'dist' 01:54:10 INFO - no previously-included directories found matching '.git*' 01:54:10 INFO - Successfully installed jsonschema functools32 01:54:10 INFO - Cleaning up... 01:54:10 INFO - Return code: 0 01:54:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:54:10 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')]} 01:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:10 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')]} 01:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:10 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 0x7fe73d4e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6850>, '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 0x2c52330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c527c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', '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 01:54:10 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 01:54:10 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 01:54:10 INFO - Using env: {'DISPLAY': ':0', 01:54:10 INFO - 'HOME': '/home/cltbld', 01:54:10 INFO - 'LANG': 'en_US.UTF-8', 01:54:10 INFO - 'LANGUAGE': 'en_US:en', 01:54:10 INFO - 'LOGNAME': 'cltbld', 01:54:10 INFO - 'MAIL': '/var/mail/cltbld', 01:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:10 INFO - 'MOZ_NO_REMOTE': '1', 01:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:10 INFO - 'NO_EM_RESTART': '1', 01:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:10 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:10 INFO - 'SHELL': '/bin/bash', 01:54:10 INFO - 'SHLVL': '1', 01:54:10 INFO - 'TERM': 'linux', 01:54:10 INFO - 'TMOUT': '86400', 01:54:10 INFO - 'USER': 'cltbld', 01:54:10 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', 01:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:10 INFO - '_': '/tools/buildbot/bin/python'} 01:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:10 INFO - Downloading/unpacking flake8 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:54:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:54:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:54:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:54:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:54:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:54:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:54:13 INFO - no previously-included directories found matching 'docs/_build' 01:54:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:54:13 INFO - Running setup.py install for pep8 01:54:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:54:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:54:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:54:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:54:13 INFO - no previously-included directories found matching 'docs/_build' 01:54:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:54:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:54:13 INFO - Cleaning up... 01:54:13 INFO - Return code: 0 01:54:13 INFO - Running post-action listener: _resource_record_post_action 01:54:13 INFO - Running post-action listener: _start_resource_monitoring 01:54:13 INFO - Starting resource monitoring. 01:54:13 INFO - ##### 01:54:13 INFO - ##### Running install step. 01:54:13 INFO - ##### 01:54:13 INFO - Running pre-action listener: _resource_record_pre_action 01:54:13 INFO - Running main action method: install 01:54:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:54:13 INFO - Reading from file tmpfile_stdout 01:54:13 INFO - Detecting whether we're running mozinstall >=1.0... 01:54:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:54:13 INFO - Reading from file tmpfile_stdout 01:54:13 INFO - Output received: 01:54:13 INFO - Usage: mozinstall [options] installer 01:54:13 INFO - Options: 01:54:13 INFO - -h, --help show this help message and exit 01:54:13 INFO - -d DEST, --destination=DEST 01:54:13 INFO - Directory to install application into. [default: 01:54:13 INFO - "/builds/slave/test-pgo"] 01:54:13 INFO - --app=APP Application being installed. [default: firefox] 01:54:13 INFO - mkdir: /builds/slave/test-pgo/build/application 01:54:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:54:28 INFO - Reading from file tmpfile_stdout 01:54:28 INFO - Output received: 01:54:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:54:28 INFO - Running post-action listener: _resource_record_post_action 01:54:28 INFO - ##### 01:54:28 INFO - ##### Running run-tests step. 01:54:28 INFO - ##### 01:54:28 INFO - Running pre-action listener: _resource_record_pre_action 01:54:28 INFO - Running main action method: run_tests 01:54:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:54:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:54:28 INFO - Python 2.7.3 01:54:28 INFO - Return code: 0 01:54:28 INFO - grabbing minidump binary from tooltool 01:54:28 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')]} 01:54:28 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 0x2ce6850>, '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 0x2c52330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c527c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:54:28 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 01:54:28 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 01:54:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:54:28 INFO - Return code: 0 01:54:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:54:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:54:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:54:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:54:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:54:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:54:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:54:29 INFO - Return code: 0 01:54:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 01:54:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:54:29 INFO - Using env: {'DISPLAY': ':0', 01:54:29 INFO - 'HOME': '/home/cltbld', 01:54:29 INFO - 'LANG': 'en_US.UTF-8', 01:54:29 INFO - 'LANGUAGE': 'en_US:en', 01:54:29 INFO - 'LOGNAME': 'cltbld', 01:54:29 INFO - 'MAIL': '/var/mail/cltbld', 01:54:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:54:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:29 INFO - 'MOZ_NO_REMOTE': '1', 01:54:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:29 INFO - 'NO_EM_RESTART': '1', 01:54:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:29 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:54:29 INFO - 'SHELL': '/bin/bash', 01:54:29 INFO - 'SHLVL': '1', 01:54:29 INFO - 'TERM': 'linux', 01:54:29 INFO - 'TMOUT': '86400', 01:54:29 INFO - 'USER': 'cltbld', 01:54:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944', 01:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:29 INFO - '_': '/tools/buildbot/bin/python'} 01:54:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:54:30 INFO - mozversion application_buildid: 20160305004010 01:54:30 INFO - mozversion application_changeset: 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 01:54:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:54:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:54:30 INFO - mozversion application_name: Firefox 01:54:30 INFO - mozversion application_remotingname: firefox-dev 01:54:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:54:30 INFO - mozversion application_vendor: Mozilla 01:54:30 INFO - mozversion application_version: 46.0a2 01:54:30 INFO - mozversion platform_buildid: 20160305004010 01:54:30 INFO - mozversion platform_changeset: 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 01:54:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:54:30 INFO - mozversion platform_version: 46.0a2 01:54:30 INFO - using testdate: 1457258070 01:54:30 INFO - actual date: 1457258070 01:54:30 INFO - starting webserver on 'localhost:38191' 01:54:30 INFO - SUITE-START | Running 3 tests 01:54:30 INFO - TEST-START | dromaeo_css 01:54:30 INFO - operating with platform_type : linux_ 01:54:30 INFO - Initialising browser for dromaeo_css test... 01:54:30 INFO - TEST-INFO | started process 9967 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCXiDM3/profile http://localhost:38191/getInfo.html) 01:54:34 INFO - PROCESS | 9967 | 01:54:34 INFO - PROCESS | 9967 | (process:10046): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:54:35 INFO - PROCESS | 9967 | __metrics Screen width/height:1600/1200 01:54:35 INFO - PROCESS | 9967 | colorDepth:24 01:54:35 INFO - PROCESS | 9967 | Browser inner width/height: 1024/697 01:54:35 INFO - PROCESS | 9967 | __metrics 01:54:35 INFO - PROCESS | 9967 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 01:54:36 INFO - TEST-INFO | 9967: exit 0 01:54:36 INFO - Browser initialized. 01:54:36 INFO - Running cycle 1/1 for dromaeo_css test... 01:54:36 INFO - TEST-INFO | started process 10095 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCXiDM3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:54:37 INFO - PROCESS | 10095 | 01:54:37 INFO - PROCESS | 10095 | (process:10160): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:54:48 INFO - PROCESS | 10095 | RSS: Main: 141484032 01:54:48 INFO - PROCESS | 10095 | 01:55:37 INFO - PROCESS | 10095 | 1457258137886 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] 01:57:45 INFO - PROCESS | 10095 | Cycle 1(1): loaded http://localhost:38191/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38191/tests/dromaeo/cssquery-ext.html) 01:57:46 INFO - PROCESS | 10095 | RSS: Main: 145326080 01:57:46 INFO - PROCESS | 10095 | 02:00:48 INFO - PROCESS | 10095 | Cycle 1(1): loaded http://localhost:38191/tests/dromaeo/cssquery-ext.html (next: http://localhost:38191/tests/dromaeo/cssquery-jquery.html) 02:00:49 INFO - PROCESS | 10095 | RSS: Main: 144670720 02:00:49 INFO - PROCESS | 10095 | 02:03:50 INFO - PROCESS | 10095 | Cycle 1(1): loaded http://localhost:38191/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38191/tests/dromaeo/cssquery-mootools.html) 02:03:51 INFO - PROCESS | 10095 | RSS: Main: 144707584 02:03:51 INFO - PROCESS | 10095 | 02:06:53 INFO - PROCESS | 10095 | Cycle 1(1): loaded http://localhost:38191/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38191/tests/dromaeo/cssquery-prototype.html) 02:06:53 INFO - PROCESS | 10095 | RSS: Main: 142741504 02:06:53 INFO - PROCESS | 10095 | 02:09:56 INFO - PROCESS | 10095 | Cycle 1(1): loaded http://localhost:38191/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38191/tests/dromaeo/cssquery-yui.html) 02:09:56 INFO - PROCESS | 10095 | RSS: Main: 144203776 02:09:56 INFO - PROCESS | 10095 | 02:12:58 INFO - PROCESS | 10095 | Cycle 1(1): loaded http://localhost:38191/tests/dromaeo/cssquery-yui.html (next: http://localhost:38191/tests/dromaeo/cssquery-dojo.html) 02:12:59 INFO - PROCESS | 10095 | RSS: Main: 145686528 02:12:59 INFO - PROCESS | 10095 | 02:12:59 INFO - PROCESS | 10095 | __start_tp_report 02:12:59 INFO - PROCESS | 10095 | _x_x_mozilla_page_load 02:12:59 INFO - PROCESS | 10095 | _x_x_mozilla_page_load_details 02:12:59 INFO - PROCESS | 10095 | |i|pagename|runs| 02:12:59 INFO - PROCESS | 10095 | |0;dojo.html;3352.2792599591085;3355.3624811285854;3368.461046232603;3393.660633936606;3397.9150521236966;5439.5104440600335;5478.068728316186;5490;5498.340199176099;5508.338999320083;5441.347038355403;5461.9453805461935;5508.834734957948;5520.972395138018;5557.249771280876;4978.825741099071;5031.949680503203;5092.745362731867;5127.128388174001;5180.818671346504;4842.709437433748;5015.673981191229;5041.445441001487;5072.644914855961;5188.195829646411;5066.544011039005;5092.9236061459105;5100.056489549445;5102.081625307444;5126.102931986906;5085.821996230115;5124.846254612367;5136.024155410498;5137.666051706646;5147.382314122329;4907.337509436252;4915.992221594564;4989.775460104304;5005.199168133081;5057.595392368602;5179.870503237412;5240.842774716726;5259.737013149365;5317.335333083364;5337.626366154371;5960.344362120163;5988.550858685572;5988.610740301867;5997.940020599782;6010.459058684695;5844.590878638497;5948.851278718023;6007.7596896124105;6013.939860601382;6021.09683547467;5592.245046918654;5634.802781902614;5636.999999999959;5643.887122257532;5674.517665998395;5990.281166260077;6011.849703757441;6015.789447369321;6021.819345419644;6028.728707208186;5765;5812.099124635688;5855.209546711225;5928.436798504222;5928.940710592925;5926.170336152942;5936.287645482484;5938.851528711731;5955.166276721263;5962.433568810956;5844.912326315109;5901.616394934315;5904.4685978261305;5908.881822363529;5916.2013128228;5844.9415505845245;5891.469767720926;5943.5839491236065;5956.6723830188885;6002.189704389939;4536.56902594253;4549.476810166873;4554.271316589396;4557.225271703818;4581.198290299184;4096.09885825118;4098.610631989956;4099.8360065597635;4100.159467309194;4134.090500089976;5519.254900588449;5563.36021357541;5586.804461843816;5665.518430933417;5682.147677848356;5866.67733274674;5870.383609720918;5906.055031194988;5946.226990491295;5950.077737950624;5578.525825304813;5605.635633683797;5615.606907516435;5630.380658127603;5634.4365563443325;5002.374703162105;5152.871178220575;5159.071367153873;5203.401608814959;5249.238860365225;6027.517798576104;6036.8188954331445;6046.334903160737;6052.334243233241;6073.1497590337385;5740.253767010262;5917.881642367129;5952.404759524013;5955.851103722442;5978.282606087298;5922.763089476372;6069.36271691466;6157;6162.506999439945;6187.81436556886;5841.795537156179;5886.764529418775;5889.057750759858;5907.261592300963;5914.290285165807;5961.701914904324;5964.165016897725;5974.40255974399;5992.161097446448;6048.697565121638;5770.2498675171955;5826.417358264309;5829.737661805144;5853.502452291603;5857.26784151981;5745.454181852718;5759.1649210865025;5795.217645617956;5815.563832712479;5843.328017277898;5578.163275508706;5626.943730562642;5662.7734890603915;5668.26312579362;5676.290463692038;5752.453516915886;5778.422157784356;5811.128330750421;5848.181254624441;5852.209951656642;5648;5693.914591281051;5716.228309178207;5722.656640601577;5726.9713651431475 02:12:59 INFO - PROCESS | 10095 | |1;ext.html;516.2230842581916;549.5136803928523;552.5055075707245;574.1158615731773;596.6569222696947;30618.693813061862;36880.44679329809;37495.8751237463;37710.622893771055;37758.056048598795;40760.38859417104;40939.79530102353;41126.79436602813;41163.38254926171;41383;8534.786630334245;8787.78030549235;8819.470831750115;8822.294216462667;8845.20393164615;8476.872846907301;8563.400561960665;8592.398532102756;8599.699010534632;8617.741467755977;8593.312534997216;8932.374733768638;8939.95530022349;8941.105889411072;9009.459432434074;8827.602757875879;8926;8941.731748047569;8963.462192268486;8968.820623587491;8811.647534098629;8845.557722113934;8969.641214351419;8983.32625053117;8989.056149104315;41374;41675.37486937698;41675.58324416747;41783.37324940128;42009.57990420087;3557.3596752584526;3568.50040994261;3653.4337177737493;3830.157365379612;4282.914341713179;28464.28839279014;28689;28834.27914302159;28887.855560722062;29217.123486295444;3862.014274385397;3904.7657140571373;3905.4141878718137;3918.294706952747;3978.5424676162324;292662;293451;294757;295002;295778.99999999785;47111.5288847114;48069.5193048072;59744.70127649334;59903.70048149731;60088.098678519855;46257.768711156226;46507.53492465032;46521.76739116283;46702;46914.53085469102;17252.396166134124;17262.65474690499;17423.73864392035;17446.825531744773;17457.47627571175;13843.16940983524;13903.30483475822;13905.4437822488;13936.930315348358;13949.511767088103;15384.846151538566;15500.379984800482;15526.301316440788;15542.378304867678;15774.68450630981;5974.641521508636;6016.397455946205;6078.75684972605;6140.078988151724;6150.876982460326;1053.1574740207957;1062.3148069495287;1079.379356869803;1111.349860331715;1179.6402097360387;30985.380292394027;31140.844295778377;31266.687333126378;31692.524612130837;31909.361812763615;1122.8371886076472;1134.8241022641503;1162.976740465186;1233.6730766346925;1257.3084803358117;15093.24533773307;15453.768193476883;15600.765988510182;15955.601109972344;15966.201689915457;491264;494925;496655;521086;801800;54302.45697543053;54642.72678636581;54989.450105499236;55009.724951374985;55153.72423137858;1439.6760728835927;1464.8901332400112;1470.5588323502907;1487.2043456750587;1555.7977462929746;29970.850145749133;30359.089227323217;30651.2337191572;31129.8443507781;31555.36889262248;50163.993440261984;50376.244356333955;50458.24312635387;50644.49355506398;50925.745371272904;337673;339962;340955;342469;343591;35106.64893351136;46079.07841843077;46130.76934615306;46263.537364625925;46796.7660161697;42555.148897022504;42630.14739705127;42729.35905961351;43112;43319;36122.63877361298;36187.63812361948;36666.866219668285;37617.4357384634;39954;39654.80172599119;39694;39794.60205398025;39999.20001599893;40710.389344159266;40021;40136.39795403013;40423.59576404316;40574.59425405826;40731.185376291716;34334.82832585821;34727.305453891284;34741.65258347384;35177.824110880305;35295.647043529236;27041.72958270392;27194.45611087807;27832.582511262754;28113;28203.57694634623 02:12:59 INFO - PROCESS | 10095 | |2;jquery.html;371.1297008515033;374.305662995144;374.44955914805234;376.2963258706218;379.2415169660679;15508;16135;17174;18425.262989480423;19109.331173408915;11173.273737207075;11425.143114266422;17436.56408589786;17453.650926981452;17568.20943057562;5114.258432527272;5129.0767661820855;5296.470352964711;5630.127330263796;5658.377578466366;5338.412774594811;5534.0592099343;5534.446555344473;5597.188407680884;5635.774569017234;5351.277577527023;5467.972660136694;5509.807156749514;5525.198846167304;5531.778728850841;5618.381977982398;5633.971830140844;5642.097264437712;5644.814588936329;5697.6011679182475;5385.892282154374;5472.589555783332;5573.219749235111;5573.470520300565;5577.776888924438;20689.27587534444;20805.5838883223;21467.463313417134;21482.355529334145;21497;2190.123950419829;2308.783632426506;2327.1622216002224;2366.372911178522;2450.8774561271866;10505.4222017789;12980.610581682564;13402.396892139877;14087.71824563503;14239.857601423957;1869.5513076861455;1910.1977169588806;1933.9323123690745;1940.194819150065;1991.4125333026648;60002;60475.69762151161;62456.68771656113;63210.68394657997;63707.681461592394;10814.026737593655;11104.111671066295;11131.610393636183;11260;11300.491477883515;14725.558233252805;14737.852621473863;14823;14907.850921490863;14922.552323430315;8278.958605206935;8386.454880432875;8592.8711069334;8645.135486451305;8663.870041949376;8320.542370169698;8338.874916876252;8364.414490985573;8423.199796019368;8447.281981031558;4627.8611641650805;4773.188557945088;4835.95164048355;4837.685550439211;4845.079434907427;1964.4106767969552;1975.3086419752972;1982.0783335748945;2006.147387360366;2018.8485863560293;958.3339578992673;980.2256217588025;1025.261811495722;1029.9279050466396;1093.9945300273607;16288.918555407385;17048;17051.658966820843;17190.226439810238;17701.557461063578;1000.5897581991494;1058.4760543531002;1149.1898211760688;1168.2231316174818;1178.5933852820763;10169.694909152737;10386.636467723594;10436.947815260875;10481.790364192673;10517.684469465928;599313;600477;604628;640631;649956;77450.22549774543;77984.44031119345;78830.21169788344;80919.19080809117;82334;1225.785487539677;1225.8038713805747;1231.6305108467425;1242.9875701243052;1243.7015116372186;16148.434804781777;16196.919015404848;16199;16325.428609998593;16704.665906681555;34532.65467345295;35330.1167470805;35411.64588354187;35620.46569301515;35838.46242306315;45408.772956135006;46516.53483465122;46759.76620117014;47533;47805.76097119492;7832.84334313322;8028.586785579406;8214.13751556078;8326.6669333226;8339.95830020846;10620.89379106199;10864.565417383215;11779.823302650295;11807.173497855068;11842.585509507126;10181.74545636365;10640.095591874468;10857.294275872044;10863.782724345627;11258.268212566158;10734.141268698642;10746.301490403412;10959.56161753521;11030.834537481784;11035.558577657124;7966.681332746857;8273.793155171168;8409.411341206056;8645.308375330083;10768.838467422838;10695.465226738788;11082.61210857616;11359.375234361858;11392.54429822831;11454.599089031844;8175.591220439073;8328.417010809186;8339.666413343399;8370.707025254087;8512.063672995842 02:12:59 INFO - PROCESS | 10095 | |3;mootools.html;1537.4311504743243;1560.1185330288386;1777.3423833181726;1863.1522657190962;1895.3176856331727;8014.519128852273;8213.096559378464;8264.380171487148;8413.70552030679;8431.156884311566;8194.754157375288;8278.089410164877;8319.875201871962;8334;8350.832983340344;2466.235467005225;2474.4927289905527;2482.118847809029;2491.7632824881607;2493.763092506209;2512.811539134563;2536.175742883561;2548.120898290087;2550.3624093976505;2553.706323772762;2421.1646981791255;2461.310832966772;2476.3932836455006;2478.6529885816;2500.8874600643016;2511.3219430753684;2530.8228424010326;2543.0972004938258;2548.808839337057;2552.604346326304;2476.3809047738064;2497.4505608766044;2516.7231604523486;2522.810789190818;2534.619807028942;8242.340612750966;8434.072252052269;8437.240648341618;8446.028706698748;8467.110953349933;5229.686218826882;5378.19327100938;5390.1914712793005;5399.271098401705;5405.675659460445;3227.0480208338595;3244.043007312848;3281.5241789940565;3309.983450082734;3362.4451965425674;1068.439069488517;1077.4020418667637;1081.0756802933458;1081.0918828184363;1101.4657890922897;11827.645170644808;11853.170278080537;11905.16663833532;11963.700907477296;11991.880081199164;4631.8378856739855;4673.626109911199;4739.928901066487;4745.169595320874;4884.438289596671;9571.712848614552;9689.41863488179;9696;9696.418214907128;9743.561539730728;5389.649672771336;5395.649282796606;5425.538829199562;5443.129099344086;5485.61600687956;4988.975055124701;4995.150824359867;5004.3494345734825;5016.046951079284;5027.4469808321055;3863.5943225961432;3896.3960586109197;3913.412988051758;3922.646961773397;3952.7628342299554;1168.9824652630218;1224.5958833584896;1228.1955319265894;1239.2378687107544;1254.6047994881583;1230.772307123185;1250.87491250876;1333.153447560806;1479.0903594289434;1491.2692780537675;7595.3164215220895;7822.374210063182;7827.9608601956625;7846.372290216769;7851.371890248766;1208.9032877369789;1210.1166148711313;1217.3748046358212;1234.2841152131741;1246.9812952805714;6212.534059945522;6267.623942563369;6307.873842523124;6312.936870631327;6344.49244060474;10338;10614.469276536141;10619.787604247871;10659.253852230424;10826.458677066115;10320.12278956297;10509.84235236472;10517.684469465928;10557.524911379007;10589.682309530726;8094.392920530984;8099.149589293157;8099.757007289791;8124.634391452399;8145.104038555754;7710.807229819299;7756.961215193888;7764.961175194087;7902.644381002754;7910;9090.909090909006;9193;9342.252619790264;9511.857322140311;9517.286203534624;9547.809043819223;9584.233261338937;9599.520023998912;9619.615215391306;9647.517624118906;7177.784666460015;7191.101112360955;7269.672864720995;7295.416366690758;7362.153352364547;7787.92212077872;7797.298243158143;7815.804604884924;7857.332126769289;7868.331191848757;6898.344657257552;6914.55055421396;7805.063392392949;7869.960650196713;8017.8396432072195;7274.927250727425;7331.303526165006;7337.486375953632;7386.741464048732;7409.073865766779;7466.626668666437;7496.662650180646;7534.472586918863;7541.283578060075;7699.153093159636;6670.499712521678;6682.231543372574;6689.163854518185;6702.765403210864;6725.159355080615;7135.286471352823;7211.927880721336;7232.385247254042;7251.202367739439;7258.237885021997 02:12:59 INFO - PROCESS | 10095 | |4;prototype.html;355.6710043210032;361.5336216280997;363.49837224630005;364.17332654873456;364.5843738138521;6373.840653983652;6403.5197360197935;6479.514036447267;6532.47740180785;6562.245341785696;6316.147320111783;6421.197350331208;6462.256840463348;6488.545801793876;6491.8377040574005;4897.4123105227245;4898.559129678329;4912.606991440694;4918.901621967568;4924.089043526941;4916;4918.114739346916;4920.7785649645675;4923.7291948942975;4934.358533390654;4729.361536192621;4836.250381190904;4870.464248932614;4882.316475693406;4904.386951631046;4856.951430485685;4894.779734911902;4900.607951363882;4909;4913.680610760307;4338.631216346615;4367.148406060819;4370.300751879716;4377.868663940087;4381.715188512737;6111.388861113897;6122.265328160604;6126.387361263838;6129.570930034854;6142.293636231801;5621.971890140523;5746.511546518551;5750.683712395817;5763.077907534816;5829.970850145764;6772.187337519529;6793.932060679429;6805.795826125224;6810.387065164109;6820.3861652451515;4773.212419950739;4777.80888764449;4785.928211076836;4787.13831510328;4790.640701947368;6989.475789315771;7060.611666358348;7111.751088711922;7155.3202445767565;7166.713331466735;4980.576650984707;4981.825636102719;4992.126377883928;5004.749762511859;5007.12375334315;5081.974590127025;5083.186690129635;5084.237364395296;5087.236914462786;5104.4895510449405;5759.827205183851;5793.681347525842;5794.927938331422;5801.9419805802245;5812.88374232513;6672.9332706673285;6871.553349032297;6908.896366554506;6917.273686262971;6946.79159625212;1757.6924038293248;1777.0403981849915;1783.3401641392768;1785.4018903667418;1786.0623172834107;1202.3627477436971;1217.2635555488803;1235.5552001279532;1249.1505776072177;1261.7981123020272;6576.704048317742;6632.966835165793;6639.668016599151;6641.601503909781;6666.266710661824;7037.859242815115;7061.752838650623;7072.787816365517;7103.254158313406;7111.111111111111;6514.413702766774;6619.735210591619;6699.732010719516;6717.093192419059;6719.563228390237;3857.9228415431535;3858.5176852893387;3873.341531939577;3883.165119499321;3893.124047089439;7397.667104980289;7462.029936108272;7465.402767778564;7480.47636665439;7486.288802563748;7165.6417179140835;7372.373348265458;7375.114986201583;7382.741604043833;7385.778426647209;7410.777676669601;7413.703451861865;7440.255974402517;7458.962705186548;7462;7088.113985751781;7145.64271786419;7173.713051477883;7204.891926621;7213.422926165999;6965.756198533027;7045.436365090678;7050.506464547432;7057.188423331382;7058.082449281561;7377.815554610963;7399.8150046249275;7436;7454.888176677463;7457.2542745724995;4723.385959825201;4858.319835223142;4876.390451193601;4899.951000489949;4947.183714687037;7069.081019467642;7084.22073571917;7091.60996145217;7100.076989991268;7112.253213412517;6899.75850845218;6924.930750692429;6930.306969303029;6952.617606031515;6953.756618518328;6803.89794153098;6906.758263460956;6907.033015377951;6911.412529934811;6931.064306318583;6756.560823546453;6799.082123913407;6836.829079272859;6836.931630683828;6861.416779573792;6903.5167538271835;6909.239983601699;6940.444764418733;6944.201416837129;6945.444364450933;6630.569013014138;6711.697973591103;6763.93236067633;6767.1879374475375;6781.830454238683 02:12:59 INFO - PROCESS | 10095 | |5;yui.html;901.1889299630334;902.300716944368;926.9443833370002;936.8735220745198;958.5063692198519;14452.060616059962;14545.418183272683;14691.559253222395;14803;14825.406983720652;12899.16155449895;13264;13276.867231327684;13286.800697989514;13327.400266987985;722.598957578545;748.120957874498;841.3563623827777;856.610242339737;859.0292968945083;851.6806197675871;856;856.0583358305876;856.6616186606287;858.2018722587991;899.1592860675257;902.1700035966893;904.3624244907325;904.683360823713;908.7591788176138;894.0121166111484;894.4901406198469;895.6686026170358;896.7623579751371;901.3690416708298;664.9401553860176;671.6507416143627;671.9529632925697;672.9764458243937;674.7065026713346;14022.859771402258;14082.366293516816;14092.154470731788;14103.365348559339;14129.717405651829;13542.86457135426;13861.86138138626;14014.369353379123;14320.856791432056;14351.497697580535;10795.08241799448;10829.83755243672;10833.29583577065;10969.506372213269;11028.669139925814;3859.4403811447464;3879.12719638082;3886.047918260016;3919.3533067043904;3920.882373528799;50256.49743502555;51279.230811537855;51497.99999999963;51500;52303;10787.244892857581;10889.237753357347;10936.234463587472;10984.505697243643;11032.227744058;18390.356337528123;18451.538711532317;18532.722009169873;18584.81415185858;18594;8390.664373425117;8481.83036339282;8577.399582029198;8634.309255259564;8842.159994800484;4492.752898590544;4551.954480455153;4581.839635612804;4643.814247430132;4695.669428046972;3228.2252259458032;3278.622958359819;3286.359159963784;3314.0554941841942;3315.5855518060243;580.2196046317696;580.5268706004592;584.2346526050887;587.7296443635976;597.4384078965759;614.732591322776;635.1615867055442;681.8704446155215;701.2636731431976;754.6340025087828;8758.211760941545;9148.954255228682;9215.400998935182;9248.630054797868;9554.235661147091;622.4708997352304;653.9732619786889;735.338195623932;783.7178615698344;797.7128233835814;4434.623057040188;4516.254817955067;4526.162659907927;4527;4711.243922305421;64744.676276619255;65209.673951629935;65456.67271663611;65518.34481655122;65722.34277657258;55023.449765502635;57302.426975730545;58008.709956449944;58122;58218;47907;50029.74985125051;50073;52414;52598.73700631549;8765.737027889174;8796.824063518821;8981.371304008919;9070.002299746891;9150.542472876463;36969.63030369662;37416.81291593525;37666.24667506689;37791.433128503646;38591.228175435775;46223.53776462327;49814.50185498098;50004.74997625134;50028.749856250484;50767;12004.579839705917;12099.637010889688;12205.816912746139;12260.38698065111;12465.875341246472;14073.718525629634;14221.928890355483;14248.786268206193;14385.712285754436;14457.132572045712;12443.25340479538;12829.166104203197;12968.221906685629;13163.144395614254;13350.465981361025;11906.166568340133;12138.271703697807;12193.085518586318;12235.32705701195;12465.252084874937;12573.308468034345;12998.545050923172;13288.136271142344;13416.597502074954;13577.932110339385;10563.683089507327;10680.519376627915;10749.086327662237;11001.22991390627;11156.609518667132;11488.94255528717;11532.538698451968;11615.361155136548;11667.183297169116;11728.120390970882 02:12:59 INFO - PROCESS | 10095 | __end_tp_report 02:12:59 INFO - PROCESS | 10095 | __start_cc_report 02:12:59 INFO - PROCESS | 10095 | _x_x_mozilla_cycle_collect,284 02:12:59 INFO - PROCESS | 10095 | __end_cc_report 02:12:59 INFO - PROCESS | 10095 | __startTimestamp1457259179023__endTimestamp 02:12:59 INFO - PROCESS | 10095 | 02:12:59 INFO - PROCESS | 10095 | ------- Summary: start ------- 02:12:59 INFO - PROCESS | 10095 | Number of tests: 6 02:12:59 INFO - PROCESS | 10095 | 02:12:59 INFO - PROCESS | 10095 | [#0] dojo.html Cycles:165 Average:5509.37 Median:5716.23 stddev:598.17 (10.5%) stddev-sans-first:575.57 02:12:59 INFO - PROCESS | 10095 | Values: 3352.3 3355.4 3368.5 3393.7 3397.9 5439.5 5478.1 5490.0 5498.3 5508.3 5441.3 5461.9 5508.8 5521.0 5557.2 4978.8 5031.9 5092.7 5127.1 5180.8 4842.7 5015.7 5041.4 5072.6 5188.2 5066.5 5092.9 5100.1 5102.1 5126.1 5085.8 5124.8 5136.0 5137.7 5147.4 4907.3 4916.0 4989.8 5005.2 5057.6 5179.9 5240.8 5259.7 5317.3 5337.6 5960.3 5988.6 5988.6 5997.9 6010.5 5844.6 5948.9 6007.8 6013.9 6021.1 5592.2 5634.8 5637.0 5643.9 5674.5 5990.3 6011.8 6015.8 6021.8 6028.7 5765.0 5812.1 5855.2 5928.4 5928.9 5926.2 5936.3 5938.9 5955.2 5962.4 5844.9 5901.6 5904.5 5908.9 5916.2 5844.9 5891.5 5943.6 5956.7 6002.2 4536.6 4549.5 4554.3 4557.2 4581.2 4096.1 4098.6 4099.8 4100.2 4134.1 5519.3 5563.4 5586.8 5665.5 5682.1 5866.7 5870.4 5906.1 5946.2 5950.1 5578.5 5605.6 5615.6 5630.4 5634.4 5002.4 5152.9 5159.1 5203.4 5249.2 6027.5 6036.8 6046.3 6052.3 6073.1 5740.3 5917.9 5952.4 5955.9 5978.3 5922.8 6069.4 6157.0 6162.5 6187.8 5841.8 5886.8 5889.1 5907.3 5914.3 5961.7 5964.2 5974.4 5992.2 6048.7 5770.2 5826.4 5829.7 5853.5 5857.3 5745.5 5759.2 5795.2 5815.6 5843.3 5578.2 5626.9 5662.8 5668.3 5676.3 5752.5 5778.4 5811.1 5848.2 5852.2 5648.0 5693.9 5716.2 5722.7 5727.0 02:12:59 INFO - PROCESS | 10095 | 02:12:59 INFO - PROCESS | 10095 | [#1] ext.html Cycles:180 Average:55690.06 Median:21886.57 stddev:112217.74 (512.7%) stddev-sans-first:112456.08 02:12:59 INFO - PROCESS | 10095 | Values: 516.2 549.5 552.5 574.1 596.7 30618.7 36880.4 37495.9 37710.6 37758.1 40760.4 40939.8 41126.8 41163.4 41383.0 8534.8 8787.8 8819.5 8822.3 8845.2 8476.9 8563.4 8592.4 8599.7 8617.7 8593.3 8932.4 8940.0 8941.1 9009.5 8827.6 8926.0 8941.7 8963.5 8968.8 8811.6 8845.6 8969.6 8983.3 8989.1 41374.0 41675.4 41675.6 41783.4 42009.6 3557.4 3568.5 3653.4 3830.2 4282.9 28464.3 28689.0 28834.3 28887.9 29217.1 3862.0 3904.8 3905.4 3918.3 3978.5 292662.0 293451.0 294757.0 295002.0 295779.0 47111.5 48069.5 59744.7 59903.7 60088.1 46257.8 46507.5 46521.8 46702.0 46914.5 17252.4 17262.7 17423.7 17446.8 17457.5 13843.2 13903.3 13905.4 13936.9 13949.5 15384.8 15500.4 15526.3 15542.4 15774.7 5974.6 6016.4 6078.8 6140.1 6150.9 1053.2 1062.3 1079.4 1111.3 1179.6 30985.4 31140.8 31266.7 31692.5 31909.4 1122.8 1134.8 1163.0 1233.7 1257.3 15093.2 15453.8 15600.8 15955.6 15966.2 491264.0 494925.0 496655.0 521086.0 801800.0 54302.5 54642.7 54989.5 55009.7 55153.7 1439.7 1464.9 1470.6 1487.2 1555.8 29970.9 30359.1 30651.2 31129.8 31555.4 50164.0 50376.2 50458.2 50644.5 50925.7 337673.0 339962.0 340955.0 342469.0 343591.0 35106.6 46079.1 46130.8 46263.5 46796.8 42555.1 42630.1 42729.4 43112.0 43319.0 36122.6 36187.6 36666.9 37617.4 39954.0 39654.8 39694.0 39794.6 39999.2 40710.4 40021.0 40136.4 40423.6 40574.6 40731.2 34334.8 34727.3 34741.7 35177.8 35295.6 27041.7 27194.5 27832.6 28113.0 28203.6 02:12:59 INFO - PROCESS | 10095 | 02:12:59 INFO - PROCESS | 10095 | [#2] jquery.html Cycles:180 Average:30766.63 Median:2317.97 stddev:101162.16 (4364.3%) stddev-sans-first:101420.20 02:12:59 INFO - PROCESS | 10095 | Values: 371.1 374.3 374.4 376.3 379.2 15508.0 16135.0 17174.0 18425.3 19109.3 11173.3 11425.1 17436.6 17453.7 17568.2 5114.3 5129.1 5296.5 5630.1 5658.4 5338.4 5534.1 5534.4 5597.2 5635.8 5351.3 5468.0 5509.8 5525.2 5531.8 5618.4 5634.0 5642.1 5644.8 5697.6 5385.9 5472.6 5573.2 5573.5 5577.8 20689.3 20805.6 21467.5 21482.4 21497.0 2190.1 2308.8 2327.2 2366.4 2450.9 10505.4 12980.6 13402.4 14087.7 14239.9 1869.6 1910.2 1933.9 1940.2 1991.4 60002.0 60475.7 62456.7 63210.7 63707.7 10814.0 11104.1 11131.6 11260.0 11300.5 14725.6 14737.9 14823.0 14907.9 14922.6 8279.0 8386.5 8592.9 8645.1 8663.9 8320.5 8338.9 8364.4 8423.2 8447.3 4627.9 4773.2 4836.0 4837.7 4845.1 1964.4 1975.3 1982.1 2006.1 2018.8 958.3 980.2 1025.3 1029.9 1094.0 16288.9 17048.0 17051.7 17190.2 17701.6 1000.6 1058.5 1149.2 1168.2 1178.6 10169.7 10386.6 10436.9 10481.8 10517.7 599313.0 600477.0 604628.0 640631.0 649956.0 77450.2 77984.4 78830.2 80919.2 82334.0 1225.8 1225.8 1231.6 1243.0 1243.7 16148.4 16196.9 16199.0 16325.4 16704.7 34532.7 35330.1 35411.6 35620.5 35838.5 45408.8 46516.5 46759.8 47533.0 47805.8 7832.8 8028.6 8214.1 8326.7 8340.0 10620.9 10864.6 11779.8 11807.2 11842.6 10181.7 10640.1 10857.3 10863.8 11258.3 10734.1 10746.3 10959.6 11030.8 11035.6 7966.7 8273.8 8409.4 8645.3 10768.8 10695.5 11082.6 11359.4 11392.5 11454.6 8175.6 8328.4 8339.7 8370.7 8512.1 02:12:59 INFO - PROCESS | 10095 | 02:12:59 INFO - PROCESS | 10095 | [#3] mootools.html Cycles:180 Average:5968.42 Median:5402.47 stddev:3084.79 (57.1%) stddev-sans-first:3075.46 02:12:59 INFO - PROCESS | 10095 | Values: 1537.4 1560.1 1777.3 1863.2 1895.3 8014.5 8213.1 8264.4 8413.7 8431.2 8194.8 8278.1 8319.9 8334.0 8350.8 2466.2 2474.5 2482.1 2491.8 2493.8 2512.8 2536.2 2548.1 2550.4 2553.7 2421.2 2461.3 2476.4 2478.7 2500.9 2511.3 2530.8 2543.1 2548.8 2552.6 2476.4 2497.5 2516.7 2522.8 2534.6 8242.3 8434.1 8437.2 8446.0 8467.1 5229.7 5378.2 5390.2 5399.3 5405.7 3227.0 3244.0 3281.5 3310.0 3362.4 1068.4 1077.4 1081.1 1081.1 1101.5 11827.6 11853.2 11905.2 11963.7 11991.9 4631.8 4673.6 4739.9 4745.2 4884.4 9571.7 9689.4 9696.0 9696.4 9743.6 5389.6 5395.6 5425.5 5443.1 5485.6 4989.0 4995.2 5004.3 5016.0 5027.4 3863.6 3896.4 3913.4 3922.6 3952.8 1169.0 1224.6 1228.2 1239.2 1254.6 1230.8 1250.9 1333.2 1479.1 1491.3 7595.3 7822.4 7828.0 7846.4 7851.4 1208.9 1210.1 1217.4 1234.3 1247.0 6212.5 6267.6 6307.9 6312.9 6344.5 10338.0 10614.5 10619.8 10659.3 10826.5 10320.1 10509.8 10517.7 10557.5 10589.7 8094.4 8099.1 8099.8 8124.6 8145.1 7710.8 7757.0 7765.0 7902.6 7910.0 9090.9 9193.0 9342.3 9511.9 9517.3 9547.8 9584.2 9599.5 9619.6 9647.5 7177.8 7191.1 7269.7 7295.4 7362.2 7787.9 7797.3 7815.8 7857.3 7868.3 6898.3 6914.6 7805.1 7870.0 8017.8 7274.9 7331.3 7337.5 7386.7 7409.1 7466.6 7496.7 7534.5 7541.3 7699.2 6670.5 6682.2 6689.2 6702.8 6725.2 7135.3 7211.9 7232.4 7251.2 7258.2 02:12:59 INFO - PROCESS | 10095 | 02:12:59 INFO - PROCESS | 10095 | [#4] prototype.html Cycles:180 Average:5773.72 Median:6569.47 stddev:1734.89 (26.4%) stddev-sans-first:1691.42 02:12:59 INFO - PROCESS | 10095 | Values: 355.7 361.5 363.5 364.2 364.6 6373.8 6403.5 6479.5 6532.5 6562.2 6316.1 6421.2 6462.3 6488.5 6491.8 4897.4 4898.6 4912.6 4918.9 4924.1 4916.0 4918.1 4920.8 4923.7 4934.4 4729.4 4836.3 4870.5 4882.3 4904.4 4857.0 4894.8 4900.6 4909.0 4913.7 4338.6 4367.1 4370.3 4377.9 4381.7 6111.4 6122.3 6126.4 6129.6 6142.3 5622.0 5746.5 5750.7 5763.1 5830.0 6772.2 6793.9 6805.8 6810.4 6820.4 4773.2 4777.8 4785.9 4787.1 4790.6 6989.5 7060.6 7111.8 7155.3 7166.7 4980.6 4981.8 4992.1 5004.7 5007.1 5082.0 5083.2 5084.2 5087.2 5104.5 5759.8 5793.7 5794.9 5801.9 5812.9 6672.9 6871.6 6908.9 6917.3 6946.8 1757.7 1777.0 1783.3 1785.4 1786.1 1202.4 1217.3 1235.6 1249.2 1261.8 6576.7 6633.0 6639.7 6641.6 6666.3 7037.9 7061.8 7072.8 7103.3 7111.1 6514.4 6619.7 6699.7 6717.1 6719.6 3857.9 3858.5 3873.3 3883.2 3893.1 7397.7 7462.0 7465.4 7480.5 7486.3 7165.6 7372.4 7375.1 7382.7 7385.8 7410.8 7413.7 7440.3 7459.0 7462.0 7088.1 7145.6 7173.7 7204.9 7213.4 6965.8 7045.4 7050.5 7057.2 7058.1 7377.8 7399.8 7436.0 7454.9 7457.3 4723.4 4858.3 4876.4 4900.0 4947.2 7069.1 7084.2 7091.6 7100.1 7112.3 6899.8 6924.9 6930.3 6952.6 6953.8 6803.9 6906.8 6907.0 6911.4 6931.1 6756.6 6799.1 6836.8 6836.9 6861.4 6903.5 6909.2 6940.4 6944.2 6945.4 6630.6 6711.7 6763.9 6767.2 6781.8 02:12:59 INFO - PROCESS | 10095 | 02:12:59 INFO - PROCESS | 10095 | [#5] yui.html Cycles:180 Average:15147.40 Median:4566.90 stddev:17633.80 (386.1%) stddev-sans-first:17650.82 02:12:59 INFO - PROCESS | 10095 | Values: 901.2 902.3 926.9 936.9 958.5 14452.1 14545.4 14691.6 14803.0 14825.4 12899.2 13264.0 13276.9 13286.8 13327.4 722.6 748.1 841.4 856.6 859.0 851.7 856.0 856.1 856.7 858.2 899.2 902.2 904.4 904.7 908.8 894.0 894.5 895.7 896.8 901.4 664.9 671.7 672.0 673.0 674.7 14022.9 14082.4 14092.2 14103.4 14129.7 13542.9 13861.9 14014.4 14320.9 14351.5 10795.1 10829.8 10833.3 10969.5 11028.7 3859.4 3879.1 3886.0 3919.4 3920.9 50256.5 51279.2 51498.0 51500.0 52303.0 10787.2 10889.2 10936.2 10984.5 11032.2 18390.4 18451.5 18532.7 18584.8 18594.0 8390.7 8481.8 8577.4 8634.3 8842.2 4492.8 4552.0 4581.8 4643.8 4695.7 3228.2 3278.6 3286.4 3314.1 3315.6 580.2 580.5 584.2 587.7 597.4 614.7 635.2 681.9 701.3 754.6 8758.2 9149.0 9215.4 9248.6 9554.2 622.5 654.0 735.3 783.7 797.7 4434.6 4516.3 4526.2 4527.0 4711.2 64744.7 65209.7 65456.7 65518.3 65722.3 55023.4 57302.4 58008.7 58122.0 58218.0 47907.0 50029.7 50073.0 52414.0 52598.7 8765.7 8796.8 8981.4 9070.0 9150.5 36969.6 37416.8 37666.2 37791.4 38591.2 46223.5 49814.5 50004.7 50028.7 50767.0 12004.6 12099.6 12205.8 12260.4 12465.9 14073.7 14221.9 14248.8 14385.7 14457.1 12443.3 12829.2 12968.2 13163.1 13350.5 11906.2 12138.3 12193.1 12235.3 12465.3 12573.3 12998.5 13288.1 13416.6 13577.9 10563.7 10680.5 10749.1 11001.2 11156.6 11488.9 11532.5 11615.4 11667.2 11728.1 02:12:59 INFO - PROCESS | 10095 | -------- Summary: end -------- 02:12:59 INFO - PROCESS | 10095 | 02:12:59 INFO - TEST-INFO | 10095: exit 0 02:12:59 INFO - TEST-OK | dromaeo_css | took 1109447ms 02:12:59 INFO - TEST-START | kraken 02:12:59 INFO - operating with platform_type : linux_ 02:12:59 INFO - Initialising browser for kraken test... 02:12:59 INFO - TEST-INFO | started process 10354 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzLi45O/profile http://localhost:38191/getInfo.html) 02:13:03 INFO - PROCESS | 10354 | 02:13:03 INFO - PROCESS | 10354 | (process:10431): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:13:04 INFO - PROCESS | 10354 | __metrics Screen width/height:1600/1200 02:13:04 INFO - PROCESS | 10354 | colorDepth:24 02:13:04 INFO - PROCESS | 10354 | Browser inner width/height: 1024/697 02:13:04 INFO - PROCESS | 10354 | __metrics 02:13:05 INFO - TEST-INFO | 10354: exit 0 02:13:05 INFO - Browser initialized. 02:13:05 INFO - Running cycle 1/1 for kraken test... 02:13:05 INFO - TEST-INFO | started process 10480 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzLi45O/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:06 INFO - PROCESS | 10480 | 02:13:06 INFO - PROCESS | 10480 | (process:10546): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:13:17 INFO - PROCESS | 10480 | RSS: Main: 142008320 02:13:17 INFO - PROCESS | 10480 | 02:13:19 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38191/tests/kraken/driver.html?testName=audio-beat-detection) 02:13:20 INFO - PROCESS | 10480 | RSS: Main: 147120128 02:13:20 INFO - PROCESS | 10480 | 02:13:22 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38191/tests/kraken/driver.html?testName=audio-dft) 02:13:23 INFO - PROCESS | 10480 | RSS: Main: 145211392 02:13:23 INFO - PROCESS | 10480 | 02:13:26 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38191/tests/kraken/driver.html?testName=audio-fft) 02:13:26 INFO - PROCESS | 10480 | RSS: Main: 147431424 02:13:26 INFO - PROCESS | 10480 | 02:13:28 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38191/tests/kraken/driver.html?testName=audio-oscillator) 02:13:29 INFO - PROCESS | 10480 | RSS: Main: 147386368 02:13:29 INFO - PROCESS | 10480 | 02:13:31 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38191/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:13:32 INFO - PROCESS | 10480 | RSS: Main: 147402752 02:13:32 INFO - PROCESS | 10480 | 02:13:35 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38191/tests/kraken/driver.html?testName=imaging-darkroom) 02:13:35 INFO - PROCESS | 10480 | RSS: Main: 146321408 02:13:35 INFO - PROCESS | 10480 | 02:13:39 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38191/tests/kraken/driver.html?testName=imaging-desaturate) 02:13:39 INFO - PROCESS | 10480 | RSS: Main: 147070976 02:13:39 INFO - PROCESS | 10480 | 02:13:42 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38191/tests/kraken/driver.html?testName=json-parse-financial) 02:13:43 INFO - PROCESS | 10480 | RSS: Main: 146702336 02:13:43 INFO - PROCESS | 10480 | 02:13:44 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38191/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:13:45 INFO - PROCESS | 10480 | RSS: Main: 146055168 02:13:45 INFO - PROCESS | 10480 | 02:13:46 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38191/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:13:47 INFO - PROCESS | 10480 | RSS: Main: 147578880 02:13:47 INFO - PROCESS | 10480 | 02:13:49 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38191/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:13:50 INFO - PROCESS | 10480 | RSS: Main: 147152896 02:13:50 INFO - PROCESS | 10480 | 02:13:52 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38191/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:13:53 INFO - PROCESS | 10480 | RSS: Main: 148160512 02:13:53 INFO - PROCESS | 10480 | 02:13:55 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38191/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:13:56 INFO - PROCESS | 10480 | RSS: Main: 147578880 02:13:56 INFO - PROCESS | 10480 | 02:13:57 INFO - PROCESS | 10480 | Cycle 1(1): loaded http://localhost:38191/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38191/tests/kraken/driver.html?testName=ai-astar) 02:13:58 INFO - PROCESS | 10480 | RSS: Main: 148324352 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | __start_tp_report 02:13:58 INFO - PROCESS | 10480 | _x_x_mozilla_page_load 02:13:58 INFO - PROCESS | 10480 | _x_x_mozilla_page_load_details 02:13:58 INFO - PROCESS | 10480 | |i|pagename|runs| 02:13:58 INFO - PROCESS | 10480 | |0;ai-astar;112;106;114;112;112;121;111;111;110;112 02:13:58 INFO - PROCESS | 10480 | |1;audio-beat-detection;154;122;150;166;126;155;155;128;165;126 02:13:58 INFO - PROCESS | 10480 | |2;audio-dft;163;163;163;163;165;161;161;161;164;167 02:13:58 INFO - PROCESS | 10480 | |3;audio-fft;73;75;73;148;77;76;73;75;160;75 02:13:58 INFO - PROCESS | 10480 | |4;audio-oscillator;98;95;143;95;96;95;146;95;96;144 02:13:58 INFO - PROCESS | 10480 | |5;imaging-gaussian-blur;109;110;110;110;110;110;110;110;109;109 02:13:58 INFO - PROCESS | 10480 | |6;imaging-darkroom;150;146;146;148;146;147;146;148;146;147 02:13:58 INFO - PROCESS | 10480 | |7;imaging-desaturate;96;97;96;97;97;97;96;96;97;97 02:13:58 INFO - PROCESS | 10480 | |8;json-parse-financial;56;57;56;55;57;56;56;61;54;55 02:13:58 INFO - PROCESS | 10480 | |9;json-stringify-tinderbox;64;65;64;64;64;65;63;64;64;63 02:13:58 INFO - PROCESS | 10480 | |10;stanford-crypto-aes;77;79;86;79;79;86;81;79;80;79 02:13:58 INFO - PROCESS | 10480 | |11;stanford-crypto-ccm;109;112;113;115;117;118;115;110;109;114 02:13:58 INFO - PROCESS | 10480 | |12;stanford-crypto-pbkdf2;137;135;137;136;143;137;146;137;140;137 02:13:58 INFO - PROCESS | 10480 | |13;stanford-crypto-sha256-iterative;64;63;65;65;66;68;69;64;63;64 02:13:58 INFO - PROCESS | 10480 | __end_tp_report 02:13:58 INFO - PROCESS | 10480 | __start_cc_report 02:13:58 INFO - PROCESS | 10480 | _x_x_mozilla_cycle_collect,732 02:13:58 INFO - PROCESS | 10480 | __end_cc_report 02:13:58 INFO - PROCESS | 10480 | __startTimestamp1457259238090__endTimestamp 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | ------- Summary: start ------- 02:13:58 INFO - PROCESS | 10480 | Number of tests: 14 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:3.75 (3.4%) stddev-sans-first:3.98 02:13:58 INFO - PROCESS | 10480 | Values: 112.0 106.0 114.0 112.0 112.0 121.0 111.0 111.0 110.0 112.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:154.50 stddev:17.28 (11.2%) stddev-sans-first:17.99 02:13:58 INFO - PROCESS | 10480 | Values: 154.0 122.0 150.0 166.0 126.0 155.0 155.0 128.0 165.0 126.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.91 (1.2%) stddev-sans-first:2.03 02:13:58 INFO - PROCESS | 10480 | Values: 163.0 163.0 163.0 163.0 165.0 161.0 161.0 161.0 164.0 167.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#3] audio-fft Cycles:10 Average:90.50 Median:75.00 stddev:33.61 (44.8%) stddev-sans-first:35.05 02:13:58 INFO - PROCESS | 10480 | Values: 73.0 75.0 73.0 148.0 77.0 76.0 73.0 75.0 160.0 75.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:95.00 stddev:23.51 (24.8%) stddev-sans-first:24.52 02:13:58 INFO - PROCESS | 10480 | Values: 98.0 95.0 143.0 95.0 96.0 95.0 146.0 95.0 96.0 144.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 02:13:58 INFO - PROCESS | 10480 | Values: 109.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.33 (0.9%) stddev-sans-first:0.87 02:13:58 INFO - PROCESS | 10480 | Values: 150.0 146.0 146.0 148.0 146.0 147.0 146.0 148.0 146.0 147.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:13:58 INFO - PROCESS | 10480 | Values: 96.0 97.0 96.0 97.0 97.0 97.0 96.0 96.0 97.0 97.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:1.89 (3.4%) stddev-sans-first:2.00 02:13:58 INFO - PROCESS | 10480 | Values: 56.0 57.0 56.0 55.0 57.0 56.0 56.0 61.0 54.0 55.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 02:13:58 INFO - PROCESS | 10480 | Values: 64.0 65.0 64.0 64.0 64.0 65.0 63.0 64.0 64.0 63.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:79.50 stddev:3.06 (3.9%) stddev-sans-first:2.98 02:13:58 INFO - PROCESS | 10480 | Values: 77.0 79.0 86.0 79.0 79.0 86.0 81.0 79.0 80.0 79.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#11] stanford-crypto-ccm Cycles:10 Average:113.20 Median:114.50 stddev:3.19 (2.8%) stddev-sans-first:3.00 02:13:58 INFO - PROCESS | 10480 | Values: 109.0 112.0 113.0 115.0 117.0 118.0 115.0 110.0 109.0 114.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.50 Median:137.00 stddev:3.47 (2.5%) stddev-sans-first:3.64 02:13:58 INFO - PROCESS | 10480 | Values: 137.0 135.0 137.0 136.0 143.0 137.0 146.0 137.0 140.0 137.0 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - PROCESS | 10480 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:2.02 (3.1%) stddev-sans-first:2.11 02:13:58 INFO - PROCESS | 10480 | Values: 64.0 63.0 65.0 65.0 66.0 68.0 69.0 64.0 63.0 64.0 02:13:58 INFO - PROCESS | 10480 | -------- Summary: end -------- 02:13:58 INFO - PROCESS | 10480 | 02:13:58 INFO - TEST-INFO | 10480: exit 0 02:13:59 INFO - TEST-OK | kraken | took 59360ms 02:13:59 INFO - TEST-START | v8_7 02:13:59 INFO - operating with platform_type : linux_ 02:13:59 INFO - Initialising browser for v8_7 test... 02:13:59 INFO - TEST-INFO | started process 10774 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1pUu6z/profile http://localhost:38191/getInfo.html) 02:14:02 INFO - PROCESS | 10774 | 02:14:02 INFO - PROCESS | 10774 | (process:10857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:14:03 INFO - PROCESS | 10774 | __metrics Screen width/height:1600/1200 02:14:03 INFO - PROCESS | 10774 | colorDepth:24 02:14:03 INFO - PROCESS | 10774 | Browser inner width/height: 1024/697 02:14:03 INFO - PROCESS | 10774 | __metrics 02:14:04 INFO - TEST-INFO | 10774: exit 0 02:14:04 INFO - Browser initialized. 02:14:04 INFO - Running cycle 1/1 for v8_7 test... 02:14:04 INFO - TEST-INFO | started process 10906 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1pUu6z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:14:06 INFO - PROCESS | 10906 | 02:14:06 INFO - PROCESS | 10906 | (process:10972): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:14:16 INFO - PROCESS | 10906 | RSS: Main: 140709888 02:14:16 INFO - PROCESS | 10906 | 02:14:38 INFO - PROCESS | 10906 | Cycle 1(1): loaded http://localhost:38191/tests/v8_7/run.html (next: http://localhost:38191/tests/v8_7/run.html) 02:14:39 INFO - PROCESS | 10906 | RSS: Main: 144678912 02:14:39 INFO - PROCESS | 10906 | 02:14:39 INFO - PROCESS | 10906 | __start_tp_report 02:14:39 INFO - PROCESS | 10906 | _x_x_mozilla_page_load 02:14:39 INFO - PROCESS | 10906 | _x_x_mozilla_page_load_details 02:14:39 INFO - PROCESS | 10906 | |i|pagename|runs| 02:14:39 INFO - PROCESS | 10906 | |0;Richards;166.80567139282735 02:14:39 INFO - PROCESS | 10906 | |1;DeltaBlue;170.15484090522375 02:14:39 INFO - PROCESS | 10906 | |2;Encrypt;278.1641168289291 02:14:39 INFO - PROCESS | 10906 | |3;Decrypt;5208.333333333333 02:14:39 INFO - PROCESS | 10906 | |4;RayTrace;906.6183136899365 02:14:39 INFO - PROCESS | 10906 | |5;Earley;562.429696287964 02:14:39 INFO - PROCESS | 10906 | |6;Boyer;11188.888888888889 02:14:39 INFO - PROCESS | 10906 | |7;RegExp;38226.41509433962 02:14:39 INFO - PROCESS | 10906 | |8;Splay;520.2913631633714 02:14:39 INFO - PROCESS | 10906 | |9;NavierStokes;4822.115384615385 02:14:39 INFO - PROCESS | 10906 | __end_tp_report 02:14:39 INFO - PROCESS | 10906 | __startTimestamp1457259279174__endTimestamp 02:14:39 INFO - PROCESS | 10906 | 02:14:39 INFO - PROCESS | 10906 | ------- Summary: start ------- 02:14:39 INFO - PROCESS | 10906 | Number of tests: 10 02:14:39 INFO - PROCESS | 10906 | 02:14:39 INFO - PROCESS | 10906 | [#0] Richards Cycles:1 Average:166.81 Median:166.81 stddev:0.00 (0.0%) 02:14:39 INFO - PROCESS | 10906 | Values: 166.8 02:14:39 INFO - PROCESS | 10906 | 02:14:39 INFO - PROCESS | 10906 | [#1] DeltaBlue Cycles:1 Average:170.15 Median:170.15 stddev:0.00 (0.0%) 02:14:39 INFO - PROCESS | 10906 | Values: 170.2 02:14:39 INFO - PROCESS | 10906 | 02:14:39 INFO - PROCESS | 10906 | [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 02:14:39 INFO - PROCESS | 10906 | Values: 278.2 02:14:39 INFO - PROCESS | 10906 | 02:14:39 INFO - PROCESS | 10906 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 02:14:39 INFO - PROCESS | 10906 | Values: 5208.3 02:14:39 INFO - PROCESS | 10906 | 02:14:39 INFO - PROCESS | 10906 | [#4] RayTrace Cycles:1 Average:906.62 Median:906.62 stddev:0.00 (0.0%) 02:14:39 INFO - PROCESS | 10906 | Values: 906.6 02:14:39 INFO - PROCESS | 10906 | 02:14:39 INFO - PROCESS | 10906 | [#5] Earley Cycles:1 Average:562.43 Median:562.43 stddev:0.00 (0.0%) 02:14:39 INFO - PROCESS | 10906 | Values: 562.4 02:14:39 INFO - PROCESS | 10906 | 02:14:39 INFO - PROCESS | 10906 | [#6] Boyer Cycles:1 Average:11188.89 Median:11188.89 stddev:0.00 (0.0%) 02:14:39 INFO - PROCESS | 10906 | Values: 11188.9 02:14:39 INFO - PROCESS | 10906 | 02:14:39 INFO - PROCESS | 10906 | [#7] RegExp Cycles:1 Average:38226.42 Median:38226.42 stddev:0.00 (0.0%) 02:14:39 INFO - PROCESS | 10906 | Values: 38226.4 02:14:39 INFO - PROCESS | 10906 | 02:14:39 INFO - PROCESS | 10906 | [#8] Splay Cycles:1 Average:520.29 Median:520.29 stddev:0.00 (0.0%) 02:14:39 INFO - PROCESS | 10906 | Values: 520.3 02:14:39 INFO - PROCESS | 10906 | 02:14:39 INFO - PROCESS | 10906 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 02:14:39 INFO - PROCESS | 10906 | Values: 4822.1 02:14:39 INFO - PROCESS | 10906 | -------- Summary: end -------- 02:14:39 INFO - PROCESS | 10906 | 02:14:40 INFO - TEST-INFO | 10906: exit 0 02:14:40 INFO - TEST-OK | v8_7 | took 40990ms 02:14:40 INFO - SUITE-END | took 1209s 02:14:40 INFO - Completed test suite (00:20:10) 02:14:40 INFO - Working with test: dromaeo_css 02:14:40 INFO - Generating results file: dromaeo_css 02:14:40 INFO - Working with test: kraken 02:14:40 INFO - Generating results file: kraken 02:14:40 INFO - javascript benchmark 02:14:40 INFO - Working with test: v8_7 02:14:40 INFO - Generating results file: v8_7 02:14:40 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:14:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 02:14:40 INFO - process_Request line: dromaeo_css 7408.08 graph.html#tests=[[72,52,43]] 02:14:40 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:14:40 INFO - process_Request line: kraken 1491.60 graph.html#tests=[[232,52,43]] 02:14:40 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:14:40 INFO - process_Request line: v8_7 22119.33 graph.html#tests=[[230,52,43]] 02:14:40 INFO - RETURN: dromaeo_css: 7408.08 02:14:40 INFO - RETURN: kraken: 1491.60 02:14:40 INFO - RETURN: v8_7: 22119.33 02:14:40 INFO - javascript benchmark 02:14:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3352.2792599591085, 3355.3624811285854, 3368.461046232603, 3393.660633936606, 3397.9150521236966, 5439.5104440600335, 5478.068728316186, 5490.0, 5498.340199176099, 5508.338999320083, 5441.347038355403, 5461.9453805461935, 5508.834734957948, 5520.972395138018, 5557.249771280876, 4978.825741099071, 5031.949680503203, 5092.745362731867, 5127.128388174001, 5180.818671346504, 4842.709437433748, 5015.673981191229, 5041.445441001487, 5072.644914855961, 5188.195829646411, 5066.544011039005, 5092.9236061459105, 5100.056489549445, 5102.081625307444, 5126.102931986906, 5085.821996230115, 5124.846254612367, 5136.024155410498, 5137.666051706646, 5147.382314122329, 4907.337509436252, 4915.992221594564, 4989.775460104304, 5005.199168133081, 5057.595392368602, 5179.870503237412, 5240.842774716726, 5259.737013149365, 5317.335333083364, 5337.626366154371, 5960.344362120163, 5988.550858685572, 5988.610740301867, 5997.940020599782, 6010.459058684695, 5844.590878638497, 5948.851278718023, 6007.7596896124105, 6013.939860601382, 6021.09683547467, 5592.245046918654, 5634.802781902614, 5636.999999999959, 5643.887122257532, 5674.517665998395, 5990.281166260077, 6011.849703757441, 6015.789447369321, 6021.819345419644, 6028.728707208186, 5765.0, 5812.099124635688, 5855.209546711225, 5928.436798504222, 5928.940710592925, 5926.170336152942, 5936.287645482484, 5938.851528711731, 5955.166276721263, 5962.433568810956, 5844.912326315109, 5901.616394934315, 5904.4685978261305, 5908.881822363529, 5916.2013128228, 5844.9415505845245, 5891.469767720926, 5943.5839491236065, 5956.6723830188885, 6002.189704389939, 4536.56902594253, 4549.476810166873, 4554.271316589396, 4557.225271703818, 4581.198290299184, 4096.09885825118, 4098.610631989956, 4099.8360065597635, 4100.159467309194, 4134.090500089976, 5519.254900588449, 5563.36021357541, 5586.804461843816, 5665.518430933417, 5682.147677848356, 5866.67733274674, 5870.383609720918, 5906.055031194988, 5946.226990491295, 5950.077737950624, 5578.525825304813, 5605.635633683797, 5615.606907516435, 5630.380658127603, 5634.4365563443325, 5002.374703162105, 5152.871178220575, 5159.071367153873, 5203.401608814959, 5249.238860365225, 6027.517798576104, 6036.8188954331445, 6046.334903160737, 6052.334243233241, 6073.1497590337385, 5740.253767010262, 5917.881642367129, 5952.404759524013, 5955.851103722442, 5978.282606087298, 5922.763089476372, 6069.36271691466, 6157.0, 6162.506999439945, 6187.81436556886, 5841.795537156179, 5886.764529418775, 5889.057750759858, 5907.261592300963, 5914.290285165807, 5961.701914904324, 5964.165016897725, 5974.40255974399, 5992.161097446448, 6048.697565121638, 5770.2498675171955, 5826.417358264309, 5829.737661805144, 5853.502452291603, 5857.26784151981, 5745.454181852718, 5759.1649210865025, 5795.217645617956, 5815.563832712479, 5843.328017277898, 5578.163275508706, 5626.943730562642, 5662.7734890603915, 5668.26312579362, 5676.290463692038, 5752.453516915886, 5778.422157784356, 5811.128330750421, 5848.181254624441, 5852.209951656642, 5648.0, 5693.914591281051, 5716.228309178207, 5722.656640601577, 5726.9713651431475], "unit": "score", "name": "dojo.html", "value": 5471.590488914758}, {"lowerIsBetter": false, "replicates": [516.2230842581916, 549.5136803928523, 552.5055075707245, 574.1158615731773, 596.6569222696947, 30618.693813061862, 36880.44679329809, 37495.8751237463, 37710.622893771055, 37758.056048598795, 40760.38859417104, 40939.79530102353, 41126.79436602813, 41163.38254926171, 41383.0, 8534.786630334245, 8787.78030549235, 8819.470831750115, 8822.294216462667, 8845.20393164615, 8476.872846907301, 8563.400561960665, 8592.398532102756, 8599.699010534632, 8617.741467755977, 8593.312534997216, 8932.374733768638, 8939.95530022349, 8941.105889411072, 9009.459432434074, 8827.602757875879, 8926.0, 8941.731748047569, 8963.462192268486, 8968.820623587491, 8811.647534098629, 8845.557722113934, 8969.641214351419, 8983.32625053117, 8989.056149104315, 41374.0, 41675.37486937698, 41675.58324416747, 41783.37324940128, 42009.57990420087, 3557.3596752584526, 3568.50040994261, 3653.4337177737493, 3830.157365379612, 4282.914341713179, 28464.28839279014, 28689.0, 28834.27914302159, 28887.855560722062, 29217.123486295444, 3862.014274385397, 3904.7657140571373, 3905.4141878718137, 3918.294706952747, 3978.5424676162324, 292662.0, 293451.0, 294757.0, 295002.0, 295778.99999999785, 47111.5288847114, 48069.5193048072, 59744.70127649334, 59903.70048149731, 60088.098678519855, 46257.768711156226, 46507.53492465032, 46521.76739116283, 46702.0, 46914.53085469102, 17252.396166134124, 17262.65474690499, 17423.73864392035, 17446.825531744773, 17457.47627571175, 13843.16940983524, 13903.30483475822, 13905.4437822488, 13936.930315348358, 13949.511767088103, 15384.846151538566, 15500.379984800482, 15526.301316440788, 15542.378304867678, 15774.68450630981, 5974.641521508636, 6016.397455946205, 6078.75684972605, 6140.078988151724, 6150.876982460326, 1053.1574740207957, 1062.3148069495287, 1079.379356869803, 1111.349860331715, 1179.6402097360387, 30985.380292394027, 31140.844295778377, 31266.687333126378, 31692.524612130837, 31909.361812763615, 1122.8371886076472, 1134.8241022641503, 1162.976740465186, 1233.6730766346925, 1257.3084803358117, 15093.24533773307, 15453.768193476883, 15600.765988510182, 15955.601109972344, 15966.201689915457, 491264.0, 494925.0, 496655.0, 521086.0, 801800.0, 54302.45697543053, 54642.72678636581, 54989.450105499236, 55009.724951374985, 55153.72423137858, 1439.6760728835927, 1464.8901332400112, 1470.5588323502907, 1487.2043456750587, 1555.7977462929746, 29970.850145749133, 30359.089227323217, 30651.2337191572, 31129.8443507781, 31555.36889262248, 50163.993440261984, 50376.244356333955, 50458.24312635387, 50644.49355506398, 50925.745371272904, 337673.0, 339962.0, 340955.0, 342469.0, 343591.0, 35106.64893351136, 46079.07841843077, 46130.76934615306, 46263.537364625925, 46796.7660161697, 42555.148897022504, 42630.14739705127, 42729.35905961351, 43112.0, 43319.0, 36122.63877361298, 36187.63812361948, 36666.866219668285, 37617.4357384634, 39954.0, 39654.80172599119, 39694.0, 39794.60205398025, 39999.20001599893, 40710.389344159266, 40021.0, 40136.39795403013, 40423.59576404316, 40574.59425405826, 40731.185376291716, 34334.82832585821, 34727.305453891284, 34741.65258347384, 35177.824110880305, 35295.647043529236, 27041.72958270392, 27194.45611087807, 27832.582511262754, 28113.0, 28203.57694634623], "unit": "score", "name": "ext.html", "value": 19394.45287195001}, {"lowerIsBetter": false, "replicates": [371.1297008515033, 374.305662995144, 374.44955914805234, 376.2963258706218, 379.2415169660679, 15508.0, 16135.0, 17174.0, 18425.262989480423, 19109.331173408915, 11173.273737207075, 11425.143114266422, 17436.56408589786, 17453.650926981452, 17568.20943057562, 5114.258432527272, 5129.0767661820855, 5296.470352964711, 5630.127330263796, 5658.377578466366, 5338.412774594811, 5534.0592099343, 5534.446555344473, 5597.188407680884, 5635.774569017234, 5351.277577527023, 5467.972660136694, 5509.807156749514, 5525.198846167304, 5531.778728850841, 5618.381977982398, 5633.971830140844, 5642.097264437712, 5644.814588936329, 5697.6011679182475, 5385.892282154374, 5472.589555783332, 5573.219749235111, 5573.470520300565, 5577.776888924438, 20689.27587534444, 20805.5838883223, 21467.463313417134, 21482.355529334145, 21497.0, 2190.123950419829, 2308.783632426506, 2327.1622216002224, 2366.372911178522, 2450.8774561271866, 10505.4222017789, 12980.610581682564, 13402.396892139877, 14087.71824563503, 14239.857601423957, 1869.5513076861455, 1910.1977169588806, 1933.9323123690745, 1940.194819150065, 1991.4125333026648, 60002.0, 60475.69762151161, 62456.68771656113, 63210.68394657997, 63707.681461592394, 10814.026737593655, 11104.111671066295, 11131.610393636183, 11260.0, 11300.491477883515, 14725.558233252805, 14737.852621473863, 14823.0, 14907.850921490863, 14922.552323430315, 8278.958605206935, 8386.454880432875, 8592.8711069334, 8645.135486451305, 8663.870041949376, 8320.542370169698, 8338.874916876252, 8364.414490985573, 8423.199796019368, 8447.281981031558, 4627.8611641650805, 4773.188557945088, 4835.95164048355, 4837.685550439211, 4845.079434907427, 1964.4106767969552, 1975.3086419752972, 1982.0783335748945, 2006.147387360366, 2018.8485863560293, 958.3339578992673, 980.2256217588025, 1025.261811495722, 1029.9279050466396, 1093.9945300273607, 16288.918555407385, 17048.0, 17051.658966820843, 17190.226439810238, 17701.557461063578, 1000.5897581991494, 1058.4760543531002, 1149.1898211760688, 1168.2231316174818, 1178.5933852820763, 10169.694909152737, 10386.636467723594, 10436.947815260875, 10481.790364192673, 10517.684469465928, 599313.0, 600477.0, 604628.0, 640631.0, 649956.0, 77450.22549774543, 77984.44031119345, 78830.21169788344, 80919.19080809117, 82334.0, 1225.785487539677, 1225.8038713805747, 1231.6305108467425, 1242.9875701243052, 1243.7015116372186, 16148.434804781777, 16196.919015404848, 16199.0, 16325.428609998593, 16704.665906681555, 34532.65467345295, 35330.1167470805, 35411.64588354187, 35620.46569301515, 35838.46242306315, 45408.772956135006, 46516.53483465122, 46759.76620117014, 47533.0, 47805.76097119492, 7832.84334313322, 8028.586785579406, 8214.13751556078, 8326.6669333226, 8339.95830020846, 10620.89379106199, 10864.565417383215, 11779.823302650295, 11807.173497855068, 11842.585509507126, 10181.74545636365, 10640.095591874468, 10857.294275872044, 10863.782724345627, 11258.268212566158, 10734.141268698642, 10746.301490403412, 10959.56161753521, 11030.834537481784, 11035.558577657124, 7966.681332746857, 8273.793155171168, 8409.411341206056, 8645.308375330083, 10768.838467422838, 10695.465226738788, 11082.61210857616, 11359.375234361858, 11392.54429822831, 11454.599089031844, 8175.591220439073, 8328.417010809186, 8339.666413343399, 8370.707025254087, 8512.063672995842], "unit": "score", "name": "jquery.html", "value": 8854.87764663849}, {"lowerIsBetter": false, "replicates": [1537.4311504743243, 1560.1185330288386, 1777.3423833181726, 1863.1522657190962, 1895.3176856331727, 8014.519128852273, 8213.096559378464, 8264.380171487148, 8413.70552030679, 8431.156884311566, 8194.754157375288, 8278.089410164877, 8319.875201871962, 8334.0, 8350.832983340344, 2466.235467005225, 2474.4927289905527, 2482.118847809029, 2491.7632824881607, 2493.763092506209, 2512.811539134563, 2536.175742883561, 2548.120898290087, 2550.3624093976505, 2553.706323772762, 2421.1646981791255, 2461.310832966772, 2476.3932836455006, 2478.6529885816, 2500.8874600643016, 2511.3219430753684, 2530.8228424010326, 2543.0972004938258, 2548.808839337057, 2552.604346326304, 2476.3809047738064, 2497.4505608766044, 2516.7231604523486, 2522.810789190818, 2534.619807028942, 8242.340612750966, 8434.072252052269, 8437.240648341618, 8446.028706698748, 8467.110953349933, 5229.686218826882, 5378.19327100938, 5390.1914712793005, 5399.271098401705, 5405.675659460445, 3227.0480208338595, 3244.043007312848, 3281.5241789940565, 3309.983450082734, 3362.4451965425674, 1068.439069488517, 1077.4020418667637, 1081.0756802933458, 1081.0918828184363, 1101.4657890922897, 11827.645170644808, 11853.170278080537, 11905.16663833532, 11963.700907477296, 11991.880081199164, 4631.8378856739855, 4673.626109911199, 4739.928901066487, 4745.169595320874, 4884.438289596671, 9571.712848614552, 9689.41863488179, 9696.0, 9696.418214907128, 9743.561539730728, 5389.649672771336, 5395.649282796606, 5425.538829199562, 5443.129099344086, 5485.61600687956, 4988.975055124701, 4995.150824359867, 5004.3494345734825, 5016.046951079284, 5027.4469808321055, 3863.5943225961432, 3896.3960586109197, 3913.412988051758, 3922.646961773397, 3952.7628342299554, 1168.9824652630218, 1224.5958833584896, 1228.1955319265894, 1239.2378687107544, 1254.6047994881583, 1230.772307123185, 1250.87491250876, 1333.153447560806, 1479.0903594289434, 1491.2692780537675, 7595.3164215220895, 7822.374210063182, 7827.9608601956625, 7846.372290216769, 7851.371890248766, 1208.9032877369789, 1210.1166148711313, 1217.3748046358212, 1234.2841152131741, 1246.9812952805714, 6212.534059945522, 6267.623942563369, 6307.873842523124, 6312.936870631327, 6344.49244060474, 10338.0, 10614.469276536141, 10619.787604247871, 10659.253852230424, 10826.458677066115, 10320.12278956297, 10509.84235236472, 10517.684469465928, 10557.524911379007, 10589.682309530726, 8094.392920530984, 8099.149589293157, 8099.757007289791, 8124.634391452399, 8145.104038555754, 7710.807229819299, 7756.961215193888, 7764.961175194087, 7902.644381002754, 7910.0, 9090.909090909006, 9193.0, 9342.252619790264, 9511.857322140311, 9517.286203534624, 9547.809043819223, 9584.233261338937, 9599.520023998912, 9619.615215391306, 9647.517624118906, 7177.784666460015, 7191.101112360955, 7269.672864720995, 7295.416366690758, 7362.153352364547, 7787.92212077872, 7797.298243158143, 7815.804604884924, 7857.332126769289, 7868.331191848757, 6898.344657257552, 6914.55055421396, 7805.063392392949, 7869.960650196713, 8017.8396432072195, 7274.927250727425, 7331.303526165006, 7337.486375953632, 7386.741464048732, 7409.073865766779, 7466.626668666437, 7496.662650180646, 7534.472586918863, 7541.283578060075, 7699.153093159636, 6670.499712521678, 6682.231543372574, 6689.163854518185, 6702.765403210864, 6725.159355080615, 7135.286471352823, 7211.927880721336, 7232.385247254042, 7251.202367739439, 7258.237885021997], "unit": "score", "name": "mootools.html", "value": 4914.837726938235}, {"lowerIsBetter": false, "replicates": [355.6710043210032, 361.5336216280997, 363.49837224630005, 364.17332654873456, 364.5843738138521, 6373.840653983652, 6403.5197360197935, 6479.514036447267, 6532.47740180785, 6562.245341785696, 6316.147320111783, 6421.197350331208, 6462.256840463348, 6488.545801793876, 6491.8377040574005, 4897.4123105227245, 4898.559129678329, 4912.606991440694, 4918.901621967568, 4924.089043526941, 4916.0, 4918.114739346916, 4920.7785649645675, 4923.7291948942975, 4934.358533390654, 4729.361536192621, 4836.250381190904, 4870.464248932614, 4882.316475693406, 4904.386951631046, 4856.951430485685, 4894.779734911902, 4900.607951363882, 4909.0, 4913.680610760307, 4338.631216346615, 4367.148406060819, 4370.300751879716, 4377.868663940087, 4381.715188512737, 6111.388861113897, 6122.265328160604, 6126.387361263838, 6129.570930034854, 6142.293636231801, 5621.971890140523, 5746.511546518551, 5750.683712395817, 5763.077907534816, 5829.970850145764, 6772.187337519529, 6793.932060679429, 6805.795826125224, 6810.387065164109, 6820.3861652451515, 4773.212419950739, 4777.80888764449, 4785.928211076836, 4787.13831510328, 4790.640701947368, 6989.475789315771, 7060.611666358348, 7111.751088711922, 7155.3202445767565, 7166.713331466735, 4980.576650984707, 4981.825636102719, 4992.126377883928, 5004.749762511859, 5007.12375334315, 5081.974590127025, 5083.186690129635, 5084.237364395296, 5087.236914462786, 5104.4895510449405, 5759.827205183851, 5793.681347525842, 5794.927938331422, 5801.9419805802245, 5812.88374232513, 6672.9332706673285, 6871.553349032297, 6908.896366554506, 6917.273686262971, 6946.79159625212, 1757.6924038293248, 1777.0403981849915, 1783.3401641392768, 1785.4018903667418, 1786.0623172834107, 1202.3627477436971, 1217.2635555488803, 1235.5552001279532, 1249.1505776072177, 1261.7981123020272, 6576.704048317742, 6632.966835165793, 6639.668016599151, 6641.601503909781, 6666.266710661824, 7037.859242815115, 7061.752838650623, 7072.787816365517, 7103.254158313406, 7111.111111111111, 6514.413702766774, 6619.735210591619, 6699.732010719516, 6717.093192419059, 6719.563228390237, 3857.9228415431535, 3858.5176852893387, 3873.341531939577, 3883.165119499321, 3893.124047089439, 7397.667104980289, 7462.029936108272, 7465.402767778564, 7480.47636665439, 7486.288802563748, 7165.6417179140835, 7372.373348265458, 7375.114986201583, 7382.741604043833, 7385.778426647209, 7410.777676669601, 7413.703451861865, 7440.255974402517, 7458.962705186548, 7462.0, 7088.113985751781, 7145.64271786419, 7173.713051477883, 7204.891926621, 7213.422926165999, 6965.756198533027, 7045.436365090678, 7050.506464547432, 7057.188423331382, 7058.082449281561, 7377.815554610963, 7399.8150046249275, 7436.0, 7454.888176677463, 7457.2542745724995, 4723.385959825201, 4858.319835223142, 4876.390451193601, 4899.951000489949, 4947.183714687037, 7069.081019467642, 7084.22073571917, 7091.60996145217, 7100.076989991268, 7112.253213412517, 6899.75850845218, 6924.930750692429, 6930.306969303029, 6952.617606031515, 6953.756618518328, 6803.89794153098, 6906.758263460956, 6907.033015377951, 6911.412529934811, 6931.064306318583, 6756.560823546453, 6799.082123913407, 6836.829079272859, 6836.931630683828, 6861.416779573792, 6903.5167538271835, 6909.239983601699, 6940.444764418733, 6944.201416837129, 6945.444364450933, 6630.569013014138, 6711.697973591103, 6763.93236067633, 6767.1879374475375, 6781.830454238683], "unit": "score", "name": "prototype.html", "value": 5213.684367715}, {"lowerIsBetter": false, "replicates": [901.1889299630334, 902.300716944368, 926.9443833370002, 936.8735220745198, 958.5063692198519, 14452.060616059962, 14545.418183272683, 14691.559253222395, 14803.0, 14825.406983720652, 12899.16155449895, 13264.0, 13276.867231327684, 13286.800697989514, 13327.400266987985, 722.598957578545, 748.120957874498, 841.3563623827777, 856.610242339737, 859.0292968945083, 851.6806197675871, 856.0, 856.0583358305876, 856.6616186606287, 858.2018722587991, 899.1592860675257, 902.1700035966893, 904.3624244907325, 904.683360823713, 908.7591788176138, 894.0121166111484, 894.4901406198469, 895.6686026170358, 896.7623579751371, 901.3690416708298, 664.9401553860176, 671.6507416143627, 671.9529632925697, 672.9764458243937, 674.7065026713346, 14022.859771402258, 14082.366293516816, 14092.154470731788, 14103.365348559339, 14129.717405651829, 13542.86457135426, 13861.86138138626, 14014.369353379123, 14320.856791432056, 14351.497697580535, 10795.08241799448, 10829.83755243672, 10833.29583577065, 10969.506372213269, 11028.669139925814, 3859.4403811447464, 3879.12719638082, 3886.047918260016, 3919.3533067043904, 3920.882373528799, 50256.49743502555, 51279.230811537855, 51497.99999999963, 51500.0, 52303.0, 10787.244892857581, 10889.237753357347, 10936.234463587472, 10984.505697243643, 11032.227744058, 18390.356337528123, 18451.538711532317, 18532.722009169873, 18584.81415185858, 18594.0, 8390.664373425117, 8481.83036339282, 8577.399582029198, 8634.309255259564, 8842.159994800484, 4492.752898590544, 4551.954480455153, 4581.839635612804, 4643.814247430132, 4695.669428046972, 3228.2252259458032, 3278.622958359819, 3286.359159963784, 3314.0554941841942, 3315.5855518060243, 580.2196046317696, 580.5268706004592, 584.2346526050887, 587.7296443635976, 597.4384078965759, 614.732591322776, 635.1615867055442, 681.8704446155215, 701.2636731431976, 754.6340025087828, 8758.211760941545, 9148.954255228682, 9215.400998935182, 9248.630054797868, 9554.235661147091, 622.4708997352304, 653.9732619786889, 735.338195623932, 783.7178615698344, 797.7128233835814, 4434.623057040188, 4516.254817955067, 4526.162659907927, 4527.0, 4711.243922305421, 64744.676276619255, 65209.673951629935, 65456.67271663611, 65518.34481655122, 65722.34277657258, 55023.449765502635, 57302.426975730545, 58008.709956449944, 58122.0, 58218.0, 47907.0, 50029.74985125051, 50073.0, 52414.0, 52598.73700631549, 8765.737027889174, 8796.824063518821, 8981.371304008919, 9070.002299746891, 9150.542472876463, 36969.63030369662, 37416.81291593525, 37666.24667506689, 37791.433128503646, 38591.228175435775, 46223.53776462327, 49814.50185498098, 50004.74997625134, 50028.749856250484, 50767.0, 12004.579839705917, 12099.637010889688, 12205.816912746139, 12260.38698065111, 12465.875341246472, 14073.718525629634, 14221.928890355483, 14248.786268206193, 14385.712285754436, 14457.132572045712, 12443.25340479538, 12829.166104203197, 12968.221906685629, 13163.144395614254, 13350.465981361025, 11906.166568340133, 12138.271703697807, 12193.085518586318, 12235.32705701195, 12465.252084874937, 12573.308468034345, 12998.545050923172, 13288.136271142344, 13416.597502074954, 13577.932110339385, 10563.683089507327, 10680.519376627915, 10749.086327662237, 11001.22991390627, 11156.609518667132, 11488.94255528717, 11532.538698451968, 11615.361155136548, 11667.183297169116, 11728.120390970882], "unit": "score", "name": "yui.html", "value": 6863.901473281735}], "name": "dromaeo_css", "value": 7408.076168166803}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 114.0, 112.0, 112.0, 121.0, 111.0, 111.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [154.0, 122.0, 150.0, 166.0, 126.0, 155.0, 155.0, 128.0, 165.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 163.0, 165.0, 161.0, 161.0, 161.0, 164.0, 167.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 73.0, 148.0, 77.0, 76.0, 73.0, 75.0, 160.0, 75.0], "unit": "score", "name": "audio-fft", "value": 90.5}, {"lowerIsBetter": true, "replicates": [98.0, 95.0, 143.0, 95.0, 96.0, 95.0, 146.0, 95.0, 96.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [150.0, 146.0, 146.0, 148.0, 146.0, 147.0, 146.0, 148.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 55.0, 57.0, 56.0, 56.0, 61.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 63.0, 64.0, 64.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 86.0, 79.0, 79.0, 86.0, 81.0, 79.0, 80.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.5}, {"lowerIsBetter": true, "replicates": [109.0, 112.0, 113.0, 115.0, 117.0, 118.0, 115.0, 110.0, 109.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.2}, {"lowerIsBetter": true, "replicates": [137.0, 135.0, 137.0, 136.0, 143.0, 137.0, 146.0, 137.0, 140.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.5}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 65.0, 65.0, 66.0, 68.0, 69.0, 64.0, 63.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.1}], "name": "kraken", "value": 1491.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.80567139282735], "unit": "score", "name": "Richards", "value": 211.6354900000001}, {"lowerIsBetter": false, "replicates": [170.15484090522375], "unit": "score", "name": "DeltaBlue", "value": 388.57548600000007}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [906.6183136899365], "unit": "score", "name": "RayTrace", "value": 816.2078669999997}, {"lowerIsBetter": false, "replicates": [562.429696287964], "unit": "score", "name": "Earley", "value": 1184.9712139999995}, {"lowerIsBetter": false, "replicates": [11188.888888888889], "unit": "score", "name": "Boyer", "value": 59.56471698113206}, {"lowerIsBetter": false, "replicates": [38226.41509433962], "unit": "score", "name": "RegExp", "value": 23.831295656465933}, {"lowerIsBetter": false, "replicates": [520.2913631633714], "unit": "score", "name": "Splay", "value": 156.62570200000002}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 22119.326663051048}]} 02:14:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22119.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1491.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7408.08"}}} 02:14:40 INFO - Return code: 0 02:14:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:14:40 INFO - # TBPL SUCCESS # 02:14:40 INFO - Running post-action listener: _resource_record_post_action 02:14:40 INFO - Running post-run listener: _resource_record_post_run 02:14:41 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 360448; Write bytes: 513544192; Read time: 528; Write time: 743800 02:14:41 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 4096; Write bytes: 242049024; Read time: 216; Write time: 522316 02:14:41 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 356352; Write bytes: 270897152; Read time: 312; Write time: 221360 02:14:41 INFO - Running post-run listener: _upload_blobber_files 02:14:41 INFO - Blob upload gear active. 02:14:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:14:41 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 02:14:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:14:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:14:41 INFO - (blobuploader) - INFO - Open directory for files ... 02:14:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:14:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:14:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:43 INFO - (blobuploader) - INFO - Done attempting. 02:14:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:14:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:45 INFO - (blobuploader) - INFO - Done attempting. 02:14:45 INFO - (blobuploader) - INFO - Iteration through files over. 02:14:45 INFO - Return code: 0 02:14:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:14:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:14:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93b682871e1f58cbb526e24f36f3eb5fb3e23ffa3158cc5312bdca12b1a0976cbb3a31be21b7535c464ad0baa5bc6fa6f64a9472675a0deae3f4b9c333a2fbe7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd2bf02dee67e32058e0be87072f74f0278935eb069065905ccae704a1643b9876ec995171771b5cbbceab2fbbd612f36911d6eb95bb21c1ce6c6b83055aef79"} 02:14:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:14:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:14:45 INFO - Contents: 02:14:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93b682871e1f58cbb526e24f36f3eb5fb3e23ffa3158cc5312bdca12b1a0976cbb3a31be21b7535c464ad0baa5bc6fa6f64a9472675a0deae3f4b9c333a2fbe7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd2bf02dee67e32058e0be87072f74f0278935eb069065905ccae704a1643b9876ec995171771b5cbbceab2fbbd612f36911d6eb95bb21c1ce6c6b83055aef79"} 02:14:45 INFO - Running post-run listener: copy_logs_to_upload_dir 02:14:45 INFO - Copying logs to upload dir... 02:14:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:14:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.637966 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-03-06 02:14:44.800635) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 02:14:44.804109) ========= 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=af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93b682871e1f58cbb526e24f36f3eb5fb3e23ffa3158cc5312bdca12b1a0976cbb3a31be21b7535c464ad0baa5bc6fa6f64a9472675a0deae3f4b9c333a2fbe7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd2bf02dee67e32058e0be87072f74f0278935eb069065905ccae704a1643b9876ec995171771b5cbbceab2fbbd612f36911d6eb95bb21c1ce6c6b83055aef79"} build_url:https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93b682871e1f58cbb526e24f36f3eb5fb3e23ffa3158cc5312bdca12b1a0976cbb3a31be21b7535c464ad0baa5bc6fa6f64a9472675a0deae3f4b9c333a2fbe7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd2bf02dee67e32058e0be87072f74f0278935eb069065905ccae704a1643b9876ec995171771b5cbbceab2fbbd612f36911d6eb95bb21c1ce6c6b83055aef79"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 02:14:44.833397) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 02:14:44.834056) ========= 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=af724c981e2a0f424dbabf99000001e7-1457249567.873254-364257944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 02:14:44.913412) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 02:14:44.913793) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 02:14:44.914127) ========= ========= Total master_lag: 0.32 =========