builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 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.411903) ========= 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.412472) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.412802) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008898 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.488862) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.489158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.681270) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.681583) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.742442) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.742756) ========= 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.743128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.743434) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603 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% 95.8M=0s 2016-03-06 01:53:31 (95.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194972 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.952196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:30.952511) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016631 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:31.019887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:31.020271) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-06 01:53:31,756 truncating revision to first 12 chars 2016-03-06 01:53:31,756 Setting DEBUG logging. 2016-03-06 01:53:31,756 attempt 1/10 2016-03-06 01:53:31,756 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,146 unpacking tar archive at: mozilla-aurora-383d2c72f4c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.746477 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:31.781208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:31.781550) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 program finished with exit code 0 elapsedTime=0.004615 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:31.833199) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:31.833509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 01:53:31.846308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2016-03-06 01:53:31.846605) ========= /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=03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603 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-047', 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:33 INFO - Running post-action listener: _resource_record_post_action 01:53:33 INFO - ##### 01:53:33 INFO - ##### Running read-buildbot-config step. 01:53:33 INFO - ##### 01:53:33 INFO - Running pre-action listener: _resource_record_pre_action 01:53:33 INFO - Running main action method: read_buildbot_config 01:53:33 INFO - Using buildbot properties: 01:53:33 INFO - { 01:53:33 INFO - "project": "", 01:53:33 INFO - "product": "firefox", 01:53:33 INFO - "script_repo_revision": "production", 01:53:33 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 01:53:33 INFO - "repository": "", 01:53:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 01:53:33 INFO - "buildid": "20160305004010", 01:53:33 INFO - "stage_platform": "linux64-pgo", 01:53:33 INFO - "basedir": "/builds/slave/test-pgo", 01:53:33 INFO - "nightly_build": "True", 01:53:33 INFO - "buildnumber": 211, 01:53:33 INFO - "slavename": "talos-linux64-ix-047", 01:53:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:53:33 INFO - "platform": "ubuntu64_hw", 01:53:33 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:53:33 INFO - "branch": "mozilla-aurora", 01:53:33 INFO - "repo_path": "releases/mozilla-aurora", 01:53:33 INFO - "revision": "383d2c72f4c77a81d44704272dcfbbe3c8cafca8", 01:53:33 INFO - "pgo_build": "True", 01:53:33 INFO - "builduid": "78e98833bf764a6db674705445841f3a", 01:53:33 INFO - "slavebuilddir": "test" 01:53:33 INFO - } 01:53:33 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:33 INFO - Running post-action listener: _resource_record_post_action 01:53:33 INFO - ##### 01:53:33 INFO - ##### Running download-and-extract step. 01:53:33 INFO - ##### 01:53:33 INFO - Running pre-action listener: _resource_record_pre_action 01:53:33 INFO - Running main action method: download_and_extract 01:53:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:33 INFO - https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:53:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/test_packages.json 01:53:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/test_packages.json 01:53:33 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:33 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:40 INFO - Downloaded 1448 bytes. 01:53:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:53:40 INFO - Using the following test package requirements: 01:53:40 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 01:53:40 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:40 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:53:40 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:40 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:53:40 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:40 INFO - u'jsshell-linux-x86_64.zip'], 01:53:40 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:40 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:53:40 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 01:53:40 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:40 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:53:40 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:40 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:53:40 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:40 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:53:40 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 01:53:40 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 01:53:40 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:53:40 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:40 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:40 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:40 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:40 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:40 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:41 WARNING - Socket error when accessing 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: [Errno 104] Connection reset by peer 01:53:41 INFO - retry: attempt #1 caught exception: [Errno 104] Connection reset by peer 01:53:41 INFO - retry: Failed, sleeping 30 seconds before retrying 01:54:11 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 #2 01:54:12 INFO - Downloaded 23097249 bytes. 01:54:12 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:54:12 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:54:14 INFO - Return code: 0 01:54:14 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:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:14 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:54:14 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:54:14 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:54:14 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:54:14 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:54:43 INFO - Downloaded 23097249 bytes. 01:54: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:54: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:54:44 INFO - Return code: 0 01:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:44 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:54:44 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:54:44 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:54:44 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:54:44 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:54:52 INFO - Downloaded 10801536 bytes. 01:54:52 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:54:52 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:54:52 INFO - Return code: 0 01:54: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:54:52 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:54:52 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:54:52 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:54:52 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:54:52 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:54:54 INFO - Downloaded 59965510 bytes. 01:54:54 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:54:54 INFO - mkdir: /builds/slave/test-pgo/properties 01:54:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:54:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:54:54 INFO - Contents: 01:54:54 INFO - build_url:https://queue.taskcluster.net/v1/task/a5frBSqlT8qxhrAJulPpVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 01:54:54 INFO - Running post-action listener: _resource_record_post_action 01:54:54 INFO - Running post-action listener: set_extra_try_arguments 01:54:54 INFO - ##### 01:54:54 INFO - ##### Running populate-webroot step. 01:54:54 INFO - ##### 01:54:54 INFO - Running pre-action listener: _resource_record_pre_action 01:54:54 INFO - Running main action method: populate_webroot 01:54:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:54:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:54:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:54:54 INFO - '--tppagecycles', 01:54:54 INFO - '7'], 01:54:54 INFO - 'tests': ['tsvgm']}}, 01:54:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:54:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:54:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:54:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:54:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:54:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:54:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:54:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:54 INFO - 'talos_options': ['--e10s'], 01:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:54:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:54 INFO - 'tests': ['damp', 'tps']}, 01:54:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:54 INFO - 'talos_options': ['--e10s'], 01:54:54 INFO - 'tests': ['damp', 'tps']}, 01:54:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:54:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:54:54 INFO - 'other': {'tests': ['a11yr', 01:54:54 INFO - 'ts_paint', 01:54:54 INFO - 'tpaint', 01:54:54 INFO - 'sessionrestore', 01:54:54 INFO - 'sessionrestore_no_auto_restore']}, 01:54:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:54:54 INFO - 'tests': ['a11yr', 01:54:54 INFO - 'ts_paint', 01:54:54 INFO - 'tpaint', 01:54:54 INFO - 'sessionrestore', 01:54:54 INFO - 'sessionrestore_no_auto_restore']}, 01:54:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:54:54 INFO - 'tests': ['a11yr', 01:54:54 INFO - 'ts_paint', 01:54:54 INFO - 'tpaint', 01:54:54 INFO - 'sessionrestore', 01:54:54 INFO - 'sessionrestore_no_auto_restore']}, 01:54:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:54:54 INFO - 'tests': ['a11yr', 01:54:54 INFO - 'ts_paint', 01:54:54 INFO - 'tpaint', 01:54:54 INFO - 'sessionrestore', 01:54:54 INFO - 'sessionrestore_no_auto_restore']}, 01:54:54 INFO - 'other_l64': {'tests': ['a11yr', 01:54:54 INFO - 'ts_paint', 01:54:54 INFO - 'tpaint', 01:54:54 INFO - 'sessionrestore', 01:54:54 INFO - 'sessionrestore_no_auto_restore']}, 01:54:54 INFO - 'other_nol64': {'tests': ['a11yr', 01:54:54 INFO - 'ts_paint', 01:54:54 INFO - 'tpaint', 01:54:54 INFO - 'sessionrestore', 01:54:54 INFO - 'sessionrestore_no_auto_restore']}, 01:54:54 INFO - 'svgr': {'tests': ['tsvgx', 01:54:54 INFO - 'tsvgr_opacity', 01:54:54 INFO - 'tart', 01:54:54 INFO - 'tscrollx', 01:54:54 INFO - 'cart']}, 01:54:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:54:54 INFO - 'tests': ['tsvgx', 01:54:54 INFO - 'tsvgr_opacity', 01:54:54 INFO - 'tart', 01:54:54 INFO - 'tscrollx', 01:54:54 INFO - 'cart']}, 01:54:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:54 INFO - 'tests': ['tp5o']}, 01:54:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:54 INFO - 'talos_options': ['--e10s'], 01:54:54 INFO - 'tests': ['tp5o']}, 01:54:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:54 INFO - 'talos_options': ['--xperf_path', 01:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:54:54 INFO - 'tests': ['tp5n']}, 01:54:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:54:54 INFO - 'talos_options': ['--e10s', 01:54:54 INFO - '--xperf_path', 01:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:54:54 INFO - 'tests': ['tp5n']}}, 01:54:54 INFO - 'talos.zip': {'path': '', 01:54:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:54:54 INFO - Running post-action listener: _resource_record_post_action 01:54:54 INFO - ##### 01:54:54 INFO - ##### Running create-virtualenv step. 01:54:54 INFO - ##### 01:54:54 INFO - Running pre-action listener: _resource_record_pre_action 01:54:54 INFO - Running main action method: create_virtualenv 01:54:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:54:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 01:54:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:54:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:54:54 INFO - Using real prefix '/usr' 01:54:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:54:55 INFO - Installing distribute.............................................................................................................................................................................................done. 01:54:57 INFO - Installing pip.................done. 01:54:57 INFO - Return code: 0 01:54:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:54: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:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac88f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26544e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e36c0>, '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 0x26e45c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e4a70>, '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': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', '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:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 01:54:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:54:57 INFO - Using env: {'DISPLAY': ':0', 01:54:57 INFO - 'HOME': '/home/cltbld', 01:54:57 INFO - 'LANG': 'en_US.UTF-8', 01:54:57 INFO - 'LANGUAGE': 'en_US:en', 01:54:57 INFO - 'LOGNAME': 'cltbld', 01:54:57 INFO - 'MAIL': '/var/mail/cltbld', 01:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:57 INFO - 'MOZ_NO_REMOTE': '1', 01:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:57 INFO - 'NO_EM_RESTART': '1', 01:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:57 INFO - 'SHELL': '/bin/bash', 01:54:57 INFO - 'SHLVL': '1', 01:54:57 INFO - 'TERM': 'linux', 01:54:57 INFO - 'TMOUT': '86400', 01:54:57 INFO - 'USER': 'cltbld', 01:54:57 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', 01:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:57 INFO - '_': '/tools/buildbot/bin/python'} 01:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:54:57 INFO - Cleaning up... 01:54:57 INFO - Return code: 0 01:54:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:54: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:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac88f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26544e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e36c0>, '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 0x26e45c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e4a70>, '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': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', '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:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:54:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:54:57 INFO - Using env: {'DISPLAY': ':0', 01:54:57 INFO - 'HOME': '/home/cltbld', 01:54:57 INFO - 'LANG': 'en_US.UTF-8', 01:54:57 INFO - 'LANGUAGE': 'en_US:en', 01:54:57 INFO - 'LOGNAME': 'cltbld', 01:54:57 INFO - 'MAIL': '/var/mail/cltbld', 01:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:57 INFO - 'MOZ_NO_REMOTE': '1', 01:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:57 INFO - 'NO_EM_RESTART': '1', 01:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:57 INFO - 'SHELL': '/bin/bash', 01:54:57 INFO - 'SHLVL': '1', 01:54:57 INFO - 'TERM': 'linux', 01:54:57 INFO - 'TMOUT': '86400', 01:54:57 INFO - 'USER': 'cltbld', 01:54:57 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', 01:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:57 INFO - '_': '/tools/buildbot/bin/python'} 01:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:57 INFO - Downloading/unpacking psutil>=0.7.1 01:54: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:54: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:54: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:54: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:54: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:54: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:54:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:54:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:54:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:54:59 INFO - Installing collected packages: psutil 01:54:59 INFO - Running setup.py install for psutil 01:54:59 INFO - building 'psutil._psutil_linux' extension 01:54:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:54:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:55:00 INFO - building 'psutil._psutil_posix' extension 01:55:00 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:55:00 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:55:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:00 INFO - Successfully installed psutil 01:55:00 INFO - Cleaning up... 01:55:00 INFO - Return code: 0 01:55:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:55: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:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac88f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26544e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e36c0>, '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 0x26e45c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e4a70>, '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': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', '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:55:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:55:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:55:00 INFO - Using env: {'DISPLAY': ':0', 01:55:00 INFO - 'HOME': '/home/cltbld', 01:55:00 INFO - 'LANG': 'en_US.UTF-8', 01:55:00 INFO - 'LANGUAGE': 'en_US:en', 01:55:00 INFO - 'LOGNAME': 'cltbld', 01:55:00 INFO - 'MAIL': '/var/mail/cltbld', 01:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:00 INFO - 'MOZ_NO_REMOTE': '1', 01:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:00 INFO - 'NO_EM_RESTART': '1', 01:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:55:00 INFO - 'PWD': '/builds/slave/test-pgo', 01:55:00 INFO - 'SHELL': '/bin/bash', 01:55:00 INFO - 'SHLVL': '1', 01:55:00 INFO - 'TERM': 'linux', 01:55:00 INFO - 'TMOUT': '86400', 01:55:00 INFO - 'USER': 'cltbld', 01:55:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', 01:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:00 INFO - '_': '/tools/buildbot/bin/python'} 01:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:55:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:55:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:55:02 INFO - Installing collected packages: mozsystemmonitor 01:55:02 INFO - Running setup.py install for mozsystemmonitor 01:55:02 INFO - Successfully installed mozsystemmonitor 01:55:02 INFO - Cleaning up... 01:55:02 INFO - Return code: 0 01:55:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac88f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26544e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e36c0>, '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 0x26e45c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e4a70>, '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': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', '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:55:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:55:02 INFO - Using env: {'DISPLAY': ':0', 01:55:02 INFO - 'HOME': '/home/cltbld', 01:55:02 INFO - 'LANG': 'en_US.UTF-8', 01:55:02 INFO - 'LANGUAGE': 'en_US:en', 01:55:02 INFO - 'LOGNAME': 'cltbld', 01:55:02 INFO - 'MAIL': '/var/mail/cltbld', 01:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:02 INFO - 'MOZ_NO_REMOTE': '1', 01:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:02 INFO - 'NO_EM_RESTART': '1', 01:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:55:02 INFO - 'PWD': '/builds/slave/test-pgo', 01:55:02 INFO - 'SHELL': '/bin/bash', 01:55:02 INFO - 'SHLVL': '1', 01:55:02 INFO - 'TERM': 'linux', 01:55:02 INFO - 'TMOUT': '86400', 01:55:02 INFO - 'USER': 'cltbld', 01:55:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', 01:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:02 INFO - '_': '/tools/buildbot/bin/python'} 01:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:02 INFO - Downloading/unpacking blobuploader==1.2.4 01:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:04 INFO - Downloading blobuploader-1.2.4.tar.gz 01:55:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:55:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:55:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:55: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:55: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:55: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:55: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:55: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:55: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:55:05 INFO - Downloading docopt-0.6.1.tar.gz 01:55:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:55:05 INFO - Installing collected packages: blobuploader, requests, docopt 01:55:05 INFO - Running setup.py install for blobuploader 01:55:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:55:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:55:05 INFO - Running setup.py install for requests 01:55:05 INFO - Running setup.py install for docopt 01:55:05 INFO - Successfully installed blobuploader requests docopt 01:55:05 INFO - Cleaning up... 01:55:05 INFO - Return code: 0 01:55:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac88f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26544e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e36c0>, '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 0x26e45c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e4a70>, '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': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', '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:55:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:55:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:55:05 INFO - Using env: {'DISPLAY': ':0', 01:55:05 INFO - 'HOME': '/home/cltbld', 01:55:05 INFO - 'LANG': 'en_US.UTF-8', 01:55:05 INFO - 'LANGUAGE': 'en_US:en', 01:55:05 INFO - 'LOGNAME': 'cltbld', 01:55:05 INFO - 'MAIL': '/var/mail/cltbld', 01:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:05 INFO - 'MOZ_NO_REMOTE': '1', 01:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:05 INFO - 'NO_EM_RESTART': '1', 01:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:55:05 INFO - 'PWD': '/builds/slave/test-pgo', 01:55:05 INFO - 'SHELL': '/bin/bash', 01:55:05 INFO - 'SHLVL': '1', 01:55:05 INFO - 'TERM': 'linux', 01:55:05 INFO - 'TMOUT': '86400', 01:55:05 INFO - 'USER': 'cltbld', 01:55:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', 01:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:05 INFO - '_': '/tools/buildbot/bin/python'} 01:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:55:06 INFO - Running setup.py (path:/tmp/pip-d4Z4lt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:55:06 INFO - Running setup.py (path:/tmp/pip-rV2kg8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:55:06 INFO - Running setup.py (path:/tmp/pip-En6Vgp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:55:06 INFO - Running setup.py (path:/tmp/pip-y0fZnS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:55:06 INFO - Running setup.py (path:/tmp/pip-DzEXmR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:55:06 INFO - Running setup.py (path:/tmp/pip-PuvOCL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:55:06 INFO - Running setup.py (path:/tmp/pip-KRtfWJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:55:06 INFO - Running setup.py (path:/tmp/pip-Je0Wfp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:55:06 INFO - Running setup.py (path:/tmp/pip-sRs4bY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:55:06 INFO - Running setup.py (path:/tmp/pip-8LjidG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:55:06 INFO - Running setup.py (path:/tmp/pip-7XyKXt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:55:06 INFO - Running setup.py (path:/tmp/pip-ZLbQd6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:55:07 INFO - Running setup.py (path:/tmp/pip-qZP1hP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:55:07 INFO - Running setup.py (path:/tmp/pip-etRJYJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:55:07 INFO - Running setup.py (path:/tmp/pip-NBO8b1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:55:07 INFO - Running setup.py (path:/tmp/pip-Oetx8G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:55:07 INFO - Running setup.py (path:/tmp/pip-0BDCCn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:55:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:55:07 INFO - Running setup.py install for manifestparser 01:55:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:55:07 INFO - Running setup.py install for mozcrash 01:55:07 INFO - Running setup.py install for mozdebug 01:55:07 INFO - Running setup.py install for mozdevice 01:55:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:55:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:55:07 INFO - Running setup.py install for mozfile 01:55:07 INFO - Running setup.py install for mozhttpd 01:55:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:55:07 INFO - Running setup.py install for mozinfo 01:55:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:55:08 INFO - Running setup.py install for mozInstall 01:55:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:55:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:55:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:55:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:55:08 INFO - Running setup.py install for mozleak 01:55:08 INFO - Running setup.py install for mozlog 01:55:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:55:08 INFO - Running setup.py install for moznetwork 01:55:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:55:08 INFO - Running setup.py install for mozprocess 01:55:08 INFO - Running setup.py install for mozprofile 01:55:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:55:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:55:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:55:08 INFO - Running setup.py install for mozrunner 01:55:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:55:08 INFO - Running setup.py install for mozscreenshot 01:55:08 INFO - Running setup.py install for moztest 01:55:09 INFO - Running setup.py install for mozversion 01:55:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:55:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:55:09 INFO - Cleaning up... 01:55:09 INFO - Return code: 0 01:55:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:55:09 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:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:09 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:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:09 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 0x7fac88f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26544e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e36c0>, '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 0x26e45c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e4a70>, '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': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', '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:55:09 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:55:09 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:55:09 INFO - Using env: {'DISPLAY': ':0', 01:55:09 INFO - 'HOME': '/home/cltbld', 01:55:09 INFO - 'LANG': 'en_US.UTF-8', 01:55:09 INFO - 'LANGUAGE': 'en_US:en', 01:55:09 INFO - 'LOGNAME': 'cltbld', 01:55:09 INFO - 'MAIL': '/var/mail/cltbld', 01:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:09 INFO - 'MOZ_NO_REMOTE': '1', 01:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:09 INFO - 'NO_EM_RESTART': '1', 01:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:55:09 INFO - 'PWD': '/builds/slave/test-pgo', 01:55:09 INFO - 'SHELL': '/bin/bash', 01:55:09 INFO - 'SHLVL': '1', 01:55:09 INFO - 'TERM': 'linux', 01:55:09 INFO - 'TMOUT': '86400', 01:55:09 INFO - 'USER': 'cltbld', 01:55:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', 01:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:09 INFO - '_': '/tools/buildbot/bin/python'} 01:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:55:09 INFO - Running setup.py (path:/tmp/pip-FZ_Dt_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 01:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:55:09 INFO - Running setup.py (path:/tmp/pip-cGtgYD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:55:09 INFO - Running setup.py (path:/tmp/pip-DP5Pgo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 01:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:55:09 INFO - Running setup.py (path:/tmp/pip-uKFcZR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:55:09 INFO - Running setup.py (path:/tmp/pip-Sx3Ips-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 01:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:55:09 INFO - Running setup.py (path:/tmp/pip-kiqGOH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 01:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:55:09 INFO - Running setup.py (path:/tmp/pip-n6_mZd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 01:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:55:09 INFO - Running setup.py (path:/tmp/pip-psr0DA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 01:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:55:09 INFO - Running setup.py (path:/tmp/pip-AuhAsW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 01:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:55:09 INFO - Running setup.py (path:/tmp/pip-JkbjhG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:55:10 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:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:55:10 INFO - Running setup.py (path:/tmp/pip-ZXyR7l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:55:10 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:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:55:10 INFO - Running setup.py (path:/tmp/pip-jOtKTK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:55:10 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:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:55:10 INFO - Running setup.py (path:/tmp/pip-ujtF7v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:55:10 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:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:55:10 INFO - Running setup.py (path:/tmp/pip-hodcuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 01:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:55:10 INFO - Running setup.py (path:/tmp/pip-IQzlGB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 01:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:55:10 INFO - Running setup.py (path:/tmp/pip-A4iEkt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 01:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:55:10 INFO - Running setup.py (path:/tmp/pip-JOM4SX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 01:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 01:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:55:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:55: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:55: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:55: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:55: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:55: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:55: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:55:12 INFO - Downloading blessings-1.6.tar.gz 01:55:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:55:12 INFO - Installing collected packages: blessings 01:55:12 INFO - Running setup.py install for blessings 01:55:12 INFO - Successfully installed blessings 01:55:12 INFO - Cleaning up... 01:55:12 INFO - Return code: 0 01:55:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:55:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:55:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:55:12 INFO - Reading from file tmpfile_stdout 01:55:12 INFO - Current package versions: 01:55:12 INFO - argparse == 1.2.1 01:55:12 INFO - blessings == 1.6 01:55:12 INFO - blobuploader == 1.2.4 01:55:12 INFO - docopt == 0.6.1 01:55:12 INFO - manifestparser == 1.1 01:55:12 INFO - mozInstall == 1.12 01:55:12 INFO - mozcrash == 0.16 01:55:12 INFO - mozdebug == 0.1 01:55:12 INFO - mozdevice == 0.48 01:55:12 INFO - mozfile == 1.2 01:55:12 INFO - mozhttpd == 0.7 01:55:12 INFO - mozinfo == 0.9 01:55:12 INFO - mozleak == 0.1 01:55:12 INFO - mozlog == 3.1 01:55:12 INFO - moznetwork == 0.27 01:55:12 INFO - mozprocess == 0.22 01:55:12 INFO - mozprofile == 0.28 01:55:12 INFO - mozrunner == 6.11 01:55:12 INFO - mozscreenshot == 0.1 01:55:12 INFO - mozsystemmonitor == 0.0 01:55:12 INFO - moztest == 0.7 01:55:12 INFO - mozversion == 1.4 01:55:12 INFO - psutil == 3.1.1 01:55:12 INFO - requests == 1.2.3 01:55:12 INFO - wsgiref == 0.1.2 01:55:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac88f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26544e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e36c0>, '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 0x26e45c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e4a70>, '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': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', '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:55:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 01:55:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:55:12 INFO - Using env: {'DISPLAY': ':0', 01:55:12 INFO - 'HOME': '/home/cltbld', 01:55:12 INFO - 'LANG': 'en_US.UTF-8', 01:55:12 INFO - 'LANGUAGE': 'en_US:en', 01:55:12 INFO - 'LOGNAME': 'cltbld', 01:55:12 INFO - 'MAIL': '/var/mail/cltbld', 01:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:12 INFO - 'MOZ_NO_REMOTE': '1', 01:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:12 INFO - 'NO_EM_RESTART': '1', 01:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:55:12 INFO - 'PWD': '/builds/slave/test-pgo', 01:55:12 INFO - 'SHELL': '/bin/bash', 01:55:12 INFO - 'SHLVL': '1', 01:55:12 INFO - 'TERM': 'linux', 01:55:12 INFO - 'TMOUT': '86400', 01:55:12 INFO - 'USER': 'cltbld', 01:55:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', 01:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:12 INFO - '_': '/tools/buildbot/bin/python'} 01:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:13 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:55:13 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:55:13 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:55:13 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:55:13 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:55:13 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:55:13 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:55:13 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:55:13 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:55:13 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:55:13 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:55:13 INFO - Cleaning up... 01:55:13 INFO - Return code: 0 01:55:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:13 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 0x7fac88f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26544e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e36c0>, '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 0x26e45c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e4a70>, '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': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', '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:55:13 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:55:13 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:55:13 INFO - Using env: {'DISPLAY': ':0', 01:55:13 INFO - 'HOME': '/home/cltbld', 01:55:13 INFO - 'LANG': 'en_US.UTF-8', 01:55:13 INFO - 'LANGUAGE': 'en_US:en', 01:55:13 INFO - 'LOGNAME': 'cltbld', 01:55:13 INFO - 'MAIL': '/var/mail/cltbld', 01:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:13 INFO - 'MOZ_NO_REMOTE': '1', 01:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:13 INFO - 'NO_EM_RESTART': '1', 01:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:55:13 INFO - 'PWD': '/builds/slave/test-pgo', 01:55:13 INFO - 'SHELL': '/bin/bash', 01:55:13 INFO - 'SHLVL': '1', 01:55:13 INFO - 'TERM': 'linux', 01:55:13 INFO - 'TMOUT': '86400', 01:55:13 INFO - 'USER': 'cltbld', 01:55:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', 01:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:13 INFO - '_': '/tools/buildbot/bin/python'} 01:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:13 INFO - Downloading/unpacking jsonschema 01:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:55:15 INFO - Downloading/unpacking functools32 (from jsonschema) 01:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:15 INFO - Downloading functools32-3.2.3-2.tar.gz 01:55:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:55:15 INFO - warning: no files found matching '*.txt' 01:55:15 INFO - no previously-included directories found matching 'build' 01:55:15 INFO - no previously-included directories found matching 'dist' 01:55:15 INFO - no previously-included directories found matching '.git*' 01:55:15 INFO - Installing collected packages: jsonschema, functools32 01:55:15 INFO - Running setup.py install for functools32 01:55:15 INFO - warning: no files found matching '*.txt' 01:55:15 INFO - no previously-included directories found matching 'build' 01:55:15 INFO - no previously-included directories found matching 'dist' 01:55:15 INFO - no previously-included directories found matching '.git*' 01:55:15 INFO - Successfully installed jsonschema functools32 01:55:15 INFO - Cleaning up... 01:55:15 INFO - Return code: 0 01:55:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac88f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26544e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e36c0>, '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 0x26e45c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e4a70>, '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': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', '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:55:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 01:55:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:55:15 INFO - Using env: {'DISPLAY': ':0', 01:55:15 INFO - 'HOME': '/home/cltbld', 01:55:15 INFO - 'LANG': 'en_US.UTF-8', 01:55:15 INFO - 'LANGUAGE': 'en_US:en', 01:55:15 INFO - 'LOGNAME': 'cltbld', 01:55:15 INFO - 'MAIL': '/var/mail/cltbld', 01:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:15 INFO - 'MOZ_NO_REMOTE': '1', 01:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:15 INFO - 'NO_EM_RESTART': '1', 01:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:55:15 INFO - 'PWD': '/builds/slave/test-pgo', 01:55:15 INFO - 'SHELL': '/bin/bash', 01:55:15 INFO - 'SHLVL': '1', 01:55:15 INFO - 'TERM': 'linux', 01:55:15 INFO - 'TMOUT': '86400', 01:55:15 INFO - 'USER': 'cltbld', 01:55:15 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', 01:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:15 INFO - '_': '/tools/buildbot/bin/python'} 01:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:15 INFO - Downloading/unpacking flake8 01:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:55:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:55:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:55:18 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:55:18 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:55:18 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:55:18 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:55:18 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:55:18 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:55:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:55:18 INFO - no previously-included directories found matching 'docs/_build' 01:55:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:55:18 INFO - Running setup.py install for pep8 01:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:55:18 INFO - no previously-included directories found matching 'docs/_build' 01:55:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:55:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:55:18 INFO - Cleaning up... 01:55:18 INFO - Return code: 0 01:55:18 INFO - Running post-action listener: _resource_record_post_action 01:55:18 INFO - Running post-action listener: _start_resource_monitoring 01:55:18 INFO - Starting resource monitoring. 01:55:18 INFO - ##### 01:55:18 INFO - ##### Running install step. 01:55:18 INFO - ##### 01:55:18 INFO - Running pre-action listener: _resource_record_pre_action 01:55:18 INFO - Running main action method: install 01:55:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:55:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:55:18 INFO - Reading from file tmpfile_stdout 01:55:18 INFO - Detecting whether we're running mozinstall >=1.0... 01:55:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:55:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:55:18 INFO - Reading from file tmpfile_stdout 01:55:18 INFO - Output received: 01:55:18 INFO - Usage: mozinstall [options] installer 01:55:18 INFO - Options: 01:55:18 INFO - -h, --help show this help message and exit 01:55:18 INFO - -d DEST, --destination=DEST 01:55:18 INFO - Directory to install application into. [default: 01:55:18 INFO - "/builds/slave/test-pgo"] 01:55:18 INFO - --app=APP Application being installed. [default: firefox] 01:55:18 INFO - mkdir: /builds/slave/test-pgo/build/application 01:55:18 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:55:18 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:55:33 INFO - Reading from file tmpfile_stdout 01:55:33 INFO - Output received: 01:55:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:55:34 INFO - Running post-action listener: _resource_record_post_action 01:55:34 INFO - ##### 01:55:34 INFO - ##### Running run-tests step. 01:55:34 INFO - ##### 01:55:34 INFO - Running pre-action listener: _resource_record_pre_action 01:55:34 INFO - Running main action method: run_tests 01:55:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:55:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:55:34 INFO - Python 2.7.3 01:55:34 INFO - Return code: 0 01:55:34 INFO - grabbing minidump binary from tooltool 01:55: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:55:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e36c0>, '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 0x26e45c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e4a70>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:55:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 01:55:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:55:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:55:34 INFO - Return code: 0 01:55:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:55:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:55:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:55:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:55:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:55:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:55:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:55:35 INFO - Return code: 0 01:55:35 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-047', '--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:55:35 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-047 --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:55:35 INFO - Using env: {'DISPLAY': ':0', 01:55:35 INFO - 'HOME': '/home/cltbld', 01:55:35 INFO - 'LANG': 'en_US.UTF-8', 01:55:35 INFO - 'LANGUAGE': 'en_US:en', 01:55:35 INFO - 'LOGNAME': 'cltbld', 01:55:35 INFO - 'MAIL': '/var/mail/cltbld', 01:55:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:55:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:35 INFO - 'MOZ_NO_REMOTE': '1', 01:55:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:35 INFO - 'NO_EM_RESTART': '1', 01:55:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:55:35 INFO - 'PWD': '/builds/slave/test-pgo', 01:55:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:55:35 INFO - 'SHELL': '/bin/bash', 01:55:35 INFO - 'SHLVL': '1', 01:55:35 INFO - 'TERM': 'linux', 01:55:35 INFO - 'TMOUT': '86400', 01:55:35 INFO - 'USER': 'cltbld', 01:55:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603', 01:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:35 INFO - '_': '/tools/buildbot/bin/python'} 01:55:35 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-047', '--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:55:35 INFO - mozversion application_buildid: 20160305004010 01:55:35 INFO - mozversion application_changeset: 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 01:55:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:55:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:55:35 INFO - mozversion application_name: Firefox 01:55:35 INFO - mozversion application_remotingname: firefox-dev 01:55:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:55:35 INFO - mozversion application_vendor: Mozilla 01:55:35 INFO - mozversion application_version: 46.0a2 01:55:35 INFO - mozversion platform_buildid: 20160305004010 01:55:35 INFO - mozversion platform_changeset: 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 01:55:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:55:35 INFO - mozversion platform_version: 46.0a2 01:55:35 INFO - using testdate: 1457258135 01:55:35 INFO - actual date: 1457258135 01:55:35 INFO - starting webserver on 'localhost:51024' 01:55:35 INFO - SUITE-START | Running 3 tests 01:55:35 INFO - TEST-START | dromaeo_css 01:55:35 INFO - operating with platform_type : linux_ 01:55:35 INFO - Initialising browser for dromaeo_css test... 01:55:35 INFO - TEST-INFO | started process 19203 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp2Q6NV/profile http://localhost:51024/getInfo.html) 01:55:38 INFO - PROCESS | 19203 | 01:55:38 INFO - PROCESS | 19203 | (process:19283): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:55:39 INFO - PROCESS | 19203 | __metrics Screen width/height:1600/1200 01:55:39 INFO - PROCESS | 19203 | colorDepth:24 01:55:39 INFO - PROCESS | 19203 | Browser inner width/height: 1024/697 01:55:39 INFO - PROCESS | 19203 | __metrics 01:55:40 INFO - TEST-INFO | 19203: exit 0 01:55:40 INFO - Browser initialized. 01:55:40 INFO - Running cycle 1/1 for dromaeo_css test... 01:55:40 INFO - TEST-INFO | started process 19332 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp2Q6NV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:55:41 INFO - PROCESS | 19332 | 01:55:41 INFO - PROCESS | 19332 | (process:19396): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:55:52 INFO - PROCESS | 19332 | RSS: Main: 142417920 01:55:52 INFO - PROCESS | 19332 | 01:56:42 INFO - PROCESS | 19332 | 1457258202001 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:58:49 INFO - PROCESS | 19332 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51024/tests/dromaeo/cssquery-ext.html) 01:58:50 INFO - PROCESS | 19332 | RSS: Main: 146128896 01:58:50 INFO - PROCESS | 19332 | 02:01:52 INFO - PROCESS | 19332 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-ext.html (next: http://localhost:51024/tests/dromaeo/cssquery-jquery.html) 02:01:53 INFO - PROCESS | 19332 | RSS: Main: 145330176 02:01:53 INFO - PROCESS | 19332 | 02:04:55 INFO - PROCESS | 19332 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51024/tests/dromaeo/cssquery-mootools.html) 02:04:55 INFO - PROCESS | 19332 | RSS: Main: 144244736 02:04:55 INFO - PROCESS | 19332 | 02:07:57 INFO - PROCESS | 19332 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51024/tests/dromaeo/cssquery-prototype.html) 02:07:57 INFO - PROCESS | 19332 | RSS: Main: 143343616 02:07:57 INFO - PROCESS | 19332 | 02:11:00 INFO - PROCESS | 19332 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51024/tests/dromaeo/cssquery-yui.html) 02:11:00 INFO - PROCESS | 19332 | RSS: Main: 145887232 02:11:00 INFO - PROCESS | 19332 | 02:14:03 INFO - PROCESS | 19332 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-yui.html (next: http://localhost:51024/tests/dromaeo/cssquery-dojo.html) 02:14:03 INFO - PROCESS | 19332 | RSS: Main: 147697664 02:14:03 INFO - PROCESS | 19332 | 02:14:03 INFO - PROCESS | 19332 | __start_tp_report 02:14:03 INFO - PROCESS | 19332 | _x_x_mozilla_page_load 02:14:03 INFO - PROCESS | 19332 | _x_x_mozilla_page_load_details 02:14:03 INFO - PROCESS | 19332 | |i|pagename|runs| 02:14:03 INFO - PROCESS | 19332 | |0;dojo.html;3337.115664348948;3365.4110530657144;3378.577677790276;3383.6278009418966;3406.523086767853;5429.267048948391;5464.590155738316;5467.589930755189;5473.534749546288;5485.451454854518;5420.566354691625;5466.289382380295;5480.287562616854;5494.615376923617;5519.475649813271;4940.481249468817;5011.198208286675;5078.111330517163;5095.949040509585;5139.922901156486;4929.162042452774;5064.822731204408;5105.489451054883;5106.719130447824;5145.74271286436;5046.697198168122;5073.518015788494;5073.670211436245;5081.644284900059;5082.161443361841;5070.797168113271;5115.84893398986;5117.437081920985;5126.23106534021;5133.974330128344;4911.042346742387;4963.677360971526;4985.401751789772;5014.874628134289;5029.170186919154;5397.730113494349;5409.810656627039;5410.5401040911565;5461.290032295816;5461.42655021221;6001.66990815505;6025.9096113558335;6031.4270144336215;6044.939550604482;6049.546284028672;5869.50109240715;5876.706164691791;5975.43233392827;6036.607620504653;6054.96972515139;5650.208970744099;5655;5667.8583035424035;5693.089105743061;5715.085586306171;5977.432143946318;6134.447899689049;6177.073438984098;6182.258129024456;6201.255849298113;5795.246617939725;5858.179854820243;5911.231539899785;5915.940840591625;5936.050231962865;5983.640981541122;5990.341062483123;5997.7001149942325;6000;6003.699815009232;5897.941020589825;5954.07711804671;5956.940430595639;5980.43185897339;6008.4592386684535;5729.656220626693;5947.910781338283;5961.2846458425265;6041.275046994301;6062.302835173923;4520.118576877478;4541.159885421142;4553.908921821611;4556.24821904382;4577.130345234395;4009.3184158693093;4049.2913740095364;4109.178164367138;4119.546849846574;4128.339465685476;5587.916181257285;5641.097424412074;5644.096944488862;5656.434356564393;5719.8570035749435;5951.9107213391835;6002.609830361012;6008.279006519246;6008.939910600838;6013.5189184865985;5499.202615620713;5605.327360716658;5618.719064046782;5650.519705824969;5661.688607126647;5041.143005689041;5159;5210.53105220532;5253.44838791929;5275.287836142072;5982.820515384546;6052.818415447544;6135.570510064253;6139.631622102688;6156.846078848064;5897.3807750185615;5992.67040312787;6008.819735407945;6022.849428764316;6023.488003519662;6102.633841969496;6107.144999700135;6169.84575385619;6178.258608966953;6182.505399568114;5961.493273071837;5961.552883533665;5966.433188847052;5977;5989.64062156272;5957.553183511167;6010.819675409744;6053.97082495968;6059;6088.391160883876;5673.659580425187;5715.342735585461;5811.215485909517;5874.089516125007;5906.379830117948;5843.970780146242;5850.414958504116;5851.356350801323;5862.824115276549;5883.94116058834;5537.031019571478;5749.683767392667;5753.1370294456165;5761.078227483583;5771.8557036074435;5808.709564521672;5832.679202643895;5874.353821079592;5879.794207202727;5880.735366908585;5723.170140329712;5724.627899186539;5737.454941780524;5784.132380143013;5799.130130480293 02:14:03 INFO - PROCESS | 19332 | |1;ext.html;566.2497191221631;567.4609121334734;577.8642019125506;584.8567101060241;596.6539407143857;37191.442128368064;37665.81167094168;37960.62039379609;37995;38138.809305953466;38100.42849357262;38426.61573384266;38589.22821543567;38591;38857.222855542874;8589.355798315135;8774.166454186841;8812.074732153127;8827.955860220722;8851.690190843321;8564.143585641448;8841.95579022104;8854.114588541159;8859.114088591154;8903.24322432594;8841.248493878029;8875.068117847597;8888.866667;8909.886264216973;8922.776930576723;8708.21626053655;8790.120987901191;8848.557572121368;8848.867266991001;8911.287097032222;8418;8441.366897482714;8482;8495.575221238912;8514.233718965323;37533.81233093845;38405.80797095997;38430.615693842985;38440.231195375934;38568;3599.248714907083;3787.621237876218;3820.9808950955344;4293;4356.215881141393;31286.68713312883;31464.685353146404;31772.20569485758;31827.522587161213;31905.883294084826;4133.937990930139;4138.317177665682;4210.873673789792;4210.873673789792;4222.577742225783;278319.6084019587;279078;279847;280442;280669;45486.772566136955;45657.7717111419;45764;45840.77079614647;46068;43484;43648.56351436445;43745;43823.56176438258;44233.778831105636;16609.750853737205;16726.6654666906;16766.83233167677;16796.16019199035;16855.747163792552;13267.336633168303;13279.535216267384;13309.40107695156;13439;13779.173249605055;15320.540383788504;15377.692446151013;15419.922900385427;15475.767863482057;15493.147876866655;6149.292831324455;6174.66039367839;6280.309165991737;6301.8109456716375;6307.400796924285;1039.9792004159874;1065.4885654885697;1192.7614477104614;1215.3254943506263;1216.6593353860933;30651.693483064882;31021.844890775403;31160.376792464023;32997;33059.173520662174;1150.7065698246893;1151.405890496928;1155.7399585093287;1177.9587714429954;1233.521469456125;15559.144247066293;15857.595474398588;16056.36884398116;16228.539431451227;16278.674426511403;515103;518848;519073;519393;743239;58322;59551.702241488514;59906.40093599008;59978.700106499185;60133.699331503936;1491.2171110167033;1517.924103794806;1525.5575882993808;1527.0837497501411;1541.1754711229662;31335.373292534478;31338.686613133577;31580.210494737814;31776.523352149274;31993.6800632;48932.266016009075;49180.75409622929;49194.508054918995;49521;49524.75237623789;322277;324028;324157;324399;326276;34590.308193836485;35045.299094017464;35111;35534.64465355417;35581.288374232885;44853;45282.094358111994;45643.315350269106;46258.30612540882;46435;39062.414063789634;39218.607813921495;39742.006449838984;39833;40110.79944600258;39034.80482597569;39734.40398393969;39757.40363894486;39956.60043399645;40257.1948561033;39869.202615948096;39907.80046099867;40441.59558404378;40490.79754601208;40539;33730.15674608154;34564.30871382508;34628.44172012215;35347.46978795371;35428.64571354254;27240.182794516197;27375;27477.862610687618;27570.86214568914;27752.889884404398 02:14:03 INFO - PROCESS | 19332 | |2;jquery.html;373.6189087131125;375.7294747781598;375.95112635357407;376.42970899087885;385.0931057359919;15880.444184453547;16062.19689015549;17431.21559529821;19487.31794387195;19621.607567848634;11874.45632067832;11910.940445297783;12255.632331030061;12544.623661290154;12614.81077783834;5157.845264642057;5252.159654455288;5281;5291.947080529203;5331.973340133294;5504.2018907258425;5508.9724551377385;5525.336959564858;5561.249231353756;5569.582281328896;5362.731863406833;5499.037668408033;5533.280673512438;5535.308086489189;5536.640118392292;5544.750486228129;5549.750261238254;5756.769729210827;5799.3620701722775;5801.796937107223;5450.29146210994;5625.943740562583;5627.774889004435;5630.5495560355075;5737.7131143443075;14173.503927362493;14359.641008974755;14417.207053612046;20042.498937526532;21592;2398.2445529658276;2421.418859473731;2450.6936632920883;2462.938426539333;2497.2383423055962;10341.069303762697;10619.30974486656;10758.462076896201;11418.885811141865;14223.359948802225;1987.5130593004662;2018.3743039657606;2024.7266619006393;2107.357256036908;2127.5319429725437;57867;58104.128438073465;59911.40088599102;60103.58040953207;60852;10888.074513666268;10956.616518421817;11188.552457901593;11243.931826476472;11353.318800871974;14717.705645887023;14749.705005900036;14761.261936903113;14960.476383326532;14963.551093467213;7954.125046244909;8100.635471403801;8472.788180295542;8505.23452889243;8542.231199192103;8131.552764598004;8149.674013039412;8181.75454736347;8235.846981422606;8239.546824924566;4540.069285796404;4654.371659825948;4702.6473014524045;4910.8281210157475;4915.26271059344;1962.7928823773277;2018.8283995860222;2027.4120505053663;2032.2886989553538;2050.7026481160146;455.3102050393656;458.3811853997077;972.6790159247431;1027.3921313144904;1060.8196606576746;11558.306501609763;12093.87906120945;12182.573609923611;12189.817152742717;12213.572524961584;486.6544753225179;495.94296655885034;499.1041081259149;499.36331177747934;510.9846704598868;6510.934890651128;6641.468682505388;6735.6295403753265;6736.730530778812;6769.22153952292;521666;530016;534555;547782;596551;76521;77392.61303693446;77425;78643.21356786358;81041;536.286738637611;539.7652021370716;540.348879600081;541.9620626556182;542.4683809866353;10900.890991089987;10940.945295273472;10942.288751231463;10974.506147223234;10982.835257471304;32249;32668.67331326656;32969.17577060593;33663.83168084144;33748.66251337554;45407;45638.77180614076;46164.53835461602;47018;47029.529704702516;7605.087389513294;7920.920790792018;8025.518468891885;8040.798980025546;8118.472299300526;9279.86080208811;11667.708307292385;11714.88285117172;12032.217905836093;12449.377531123226;3132.4518209313733;4827.468978412302;6614.603123812587;10662.360258384522;10663.306885052447;10683.465826708789;10690.41202733857;10732.624358147428;11054.778904421706;11136.220464567403;10656.413897235727;10846.620368287073;11003.724906877393;11103.167262455187;11128.38793866345;8370.539620320696;8404.747857564284;8411.915880841114;8414.915850841413;8424.28393586552;10040.69877903664;10239.129673977497;10409.9479502602;10460.529276182438;10748.946255268673 02:14:03 INFO - PROCESS | 19332 | |3;mootools.html;1539.3996341426846;1547.1722628393811;1773.893566386017;1861.1810803246563;1886.2926402599016;8397.958010209955;8398.1601839816;8516.10580889007;8571.828563428728;8601.182887625673;8663.176998185163;8699.826003479926;8706.912930870689;8717.564121793917;8766.430182038162;2499.8250122491386;2539.9111031113916;2556.910508132216;2561.974380256192;2562.487502499498;2475.418276704973;2568.434944312258;2569.0366112707734;2570.5116027954627;2576.8196226264167;2450.0812195426715;2521.231024537515;2523.3817714659936;2539.4540173862615;2543.8473691578474;2455.067074511683;2455.1529722245796;2475.962860557102;2479.789217916479;2490;2457.63135529672;2470.28361775085;2470.9752902470923;2475.5667758142254;2478.677771889643;8275.337972962148;8286;8294.792630184294;8340.29107525861;8355.1227121152;5152.124138896396;5261.736913154327;5269.86825329366;5281.287026251483;5307.363116426015;3227.3383956288903;3268.0686004488607;3317.3531161423534;3328.251143492719;3361.3613413451367;996.7856910764148;1028.136365453023;1051.8422236664562;1062.6758838554238;1085.3433672628105;11755.471003804849;11852.34812085335;11865.88134118665;11886.58396956111;11926.701832454259;4647.233206520954;4736.502667219961;4776.9761151194025;4778.761061946889;4812.374391329105;9611.759706007266;9650.806983860284;9659.082387173208;9711.951440242894;9719.028097190225;5368.731563421813;5409.756560954766;5417.756200970965;5431.646942948696;5436.91844622331;4873.147199240118;4901.803927842918;4937.703737775745;4941.530554597308;5001.89996200074;3808.3906574947873;3841.7118716096406;3861.4787003754695;3880.9223815523533;3899.064224586079;1212.0848759186758;1223.1437993404652;1223.8714934931882;1226.5093962415106;1232.168286406672;1091.5306418240075;1117.1732917640886;1241.5468354050888;1443.350492278479;1490.381491680962;7830.060392752792;7962;7962.800929976797;7965.4822436541435;8085.838283234302;1110.2949626986922;1163.26714170074;1200.0879331707965;1220.3471142938663;1223.3821919930556;6215.564910456224;6229.878621848111;6236.968815155986;6253.749850005949;6284;9981.251406144569;10126.54430550627;10186.898131018743;10191.439470829175;10266.281360304707;9761.414315141114;9949.651762188289;10003.149732272694;10081.899181008095;10110.443925584164;7864.41016923733;7970;7979.321757650665;7986.880196797053;8040.638171282307;7778.416618753503;7932.6033698316005;8064.15326390744;8087.069986951341;8143.144969778088;8683.392162548562;8749.47503149813;9114.40756350835;9220.585073671835;9278.814423711623;8715.38992270535;8917.197452229331;8927.151920567536;8951.28389728807;9139.954300228455;7550.66022029021;7611.695532178651;7655.425843061904;7655.961720191363;7693.615319234128;7725.266099720518;7888.408369372435;7911.960440197762;7917.406194535318;7931.36549076061;7526.119976022604;7672.693092276247;7696.923030769621;7766.068071831416;7837.921620783719;7553.169151393233;7600.125985511516;7646;7705.845883082419;7760.573168475788;7450.441216908645;7505.962470187614;7516.5114267572435;7524.2851929066655;7546.698132074655;7111.751088711871;7132.643367831484;7201.099862517185;7211.206767255493;7225.494215404871;6944.375006249462;6977.7208911642965;6989.650517474004;7008.579485230903;7051.717931282691 02:14:03 INFO - PROCESS | 19332 | |4;prototype.html;354.3285474026721;359.19898626063883;362.39299173883745;363.7962740865116;365.2567026101883;6279.968600156993;6429.260635026973;6506.73973041079;6515.08788769572;6556.67216639168;6248.187735594378;6397.648129352884;6410.391012853783;6416.903746443807;6437.420632143107;4845.345878306436;4865.829695960642;4892.070506603743;4909.5581397674205;4915.5330243626795;4915.041566894457;4918.065567542156;4921.557059864612;4927.211646136619;4938.901221975559;4621.468531118914;4749.453812811519;4751.453582837983;4776.379070720802;4800;4789.760511974388;4791.161546729309;4795.400574928134;4799.976000119995;4803.543663351976;4163.854265100737;4176.0395109124765;4176.498820141572;4181.1010632714115;4186.811593478301;6028.306744724325;6103.176071230371;6108.664023478706;6117.938820611781;6158.8152355428965;5638.4361563843695;5642.210090587321;5643.520300774439;5665.688387138705;5667.1782591524;6805.931940680629;6811.795646130575;6815.556988795713;6818.556793808387;6844.93155068448;4628.514006029386;4656.115338085787;4669.392978912753;4680.297955306697;4688.203005489075;6991.89512157318;7080.822979425504;7145.142582890035;7160.069191005188;7179.820504487429;4785.784639691153;4786.0667169901535;4791.257355109963;4793.23308270675;4797.64017698674;4847.733374664427;4852.441969173519;4866;4875.683080599821;4881.414230292387;5549.694766787785;5677.971610141923;5683.744231509592;5684.6020778545935;5687;6809.38715515606;6822.351876571718;6828.897566536506;6840.897386539206;6845.657717114124;1691.129068529708;1744.284843214276;1746.7816522934634;1750.88619239749;1751.0806826415978;1146;1156.849609550753;1165.5279611757253;1179.2924245452832;1182.8403165572538;6446.033095035688;6450.5484616077365;6466.838329041811;6552.639604821685;6561.376669216417;6969.512134150561;6978.337057979484;6984.860302793915;7002;7038.577685338793;6397.232332120176;6522.249941256721;6538.640374779433;6546.116274302908;6550.017497375432;3770.8868733938025;3806.9428958565645;3807.695384369244;3810.5046343975105;3812.675922546559;7225.385842203366;7289.671964761493;7302.415806735448;7303.6348182590655;7308.1230252369;7046.907729301966;7205.387542058879;7208.639568021578;7210.639468026578;7220.241874603091;7197.244289349647;7257.092863392076;7271.927280727231;7272.127344718562;7285.963570182115;6942.993265976304;7002.439804815501;7004.754833580801;7005.684744186626;7014.403775679124;6770.390664840188;6839.1451068616425;6899.275576064641;6922.480813938874;6961;7310.342069213796;7336.816579585553;7351.66917488725;7401.111866576045;7437.330640242404;4907.533784290486;4911.656184067081;4931.235658472942;4950.480199578992;4956.727379994135;6762.898556521558;6909;6992.195897471653;7064.2935706431;7132.215456299699;6741.59550426976;6918.896216556655;6928.203256625553;6942.652867356713;6952.061471701458;6808.761693340709;6828.556143850634;6849.760258390932;6867.553609015398;6969.7212111517;6652.168478940132;6802.217744959195;6804.659767011729;6810.965945170243;6820.931790682228;6972.825679357854;6981.581105133709;6984.231734509099;6984.441244700311;6987.231404545598;6737.528373013842;6782.084418603426;6784.2876497967;6800.625965571743;6814.182298124257 02:14:03 INFO - PROCESS | 19332 | |5;yui.html;851.9957400212998;912.5209265135807;920.2178148573709;934.2292608597904;954.2604481526815;12379.504819807209;12480.375981200927;12514.683608843652;12716.745665086693;12968.481260749559;14167.645808854784;14225;14234.501792437266;14264.358103885324;14285.714285714279;852.8379607874515;856.9014563325235;862.279996203168;882.8278485695292;884.2969838978028;878.9516576588285;889.6797153024905;889.915458031486;892.5314210039717;894.9373543851933;914.9496777677225;917.3349321741717;918.3525614441836;919.7608621758358;921.4149015375218;898.7348732123974;909.5088652127843;910.4901255297021;912.8402529557301;913.1872633356318;673.666535065141;677.1603212017112;677.701811203074;678.5691086160324;678.8133263352568;14187.43250269988;14264.857351426457;14309.141451512942;14309.642258943506;14363.138211707332;14509.782353264603;14515.274236288144;14552.49066282675;14646.194459304734;14657;11303;11376.374299413612;11429.828552571718;11457.427128643618;11860.347680877549;3984;4022.034711669208;4048.3117869962175;4057.736247143926;4060.553339132693;48280.27579586309;48589.514104858856;48964.26553601699;49105.50894491045;49128.99999999964;11581.710457238469;11665.475053622607;11823.290602563873;11921.940390297994;11974.461149248305;19644.607107857762;19703.50741231452;19751.802481975283;19824.207031718568;19830.107645156004;8419.368547358972;8593.527355995355;8595;8679.47923124602;8688.348373871984;4776.570108690165;4853;4884.852059765952;4902.92645610309;4959.032988567267;3308.8511017004294;3317.419451595961;3343.7993720376853;3349.648286929886;3349.732021438279;583.9970800145973;610.517691024086;613.3161524899793;619.1517620859362;626.0984182776787;668.8428219368444;680.3536640191837;760.8478304339154;782.2685788787502;787.1773996174012;9251.028641992494;9624.951875240578;10034.498275086216;10048.346857454242;10123;757.7537300377289;771.3713323641326;771.714465647714;779.4426984705849;779.773865578987;4350.73895566267;4354.608085272341;4437.955620443819;4482.9775851121185;4596.540345965377;59759.40240597625;60058.39941600528;60549.09176362358;65200;66167.33832661709;53437;53811.19283210755;53909.46090539123;54659;55209.171862422096;47341.28988065182;47654;47766.522334776906;49227.01545969061;49895.750521247886;9527.57125929321;9581.712548623553;9750.463724494937;9852.753681158028;10208.795824083625;36844.81577592095;37754.43368349422;38207;38444;39813;46345.76827115843;47400.7629961848;47892.5210747902;47987.520124798306;48220.5177948216;12148.939255303667;12317.260964341809;12370;12461.127721059802;12538.05964552644;14098.50655227062;14112.559265210675;14157.716845662822;14389;14520.419183232974;12873.742525149632;13197.472101116233;13350.399232034775;13382.397792099573;13428.597142085753;11996;12169.878301217228;12244.142909996215;12550.623481295575;12553.497860085494;12717.870329932342;13044;13616.251106188858;13637.11358761717;13801.654958626115;10488.790224195322;10516.421596812248;10824.458777061272;11116;11126.61056863006;10726.892731072589;10836.187285953427;10958.835617465904;11195.10439164881;11718.648440546796 02:14:03 INFO - PROCESS | 19332 | __end_tp_report 02:14:03 INFO - PROCESS | 19332 | __start_cc_report 02:14:03 INFO - PROCESS | 19332 | _x_x_mozilla_cycle_collect,307 02:14:03 INFO - PROCESS | 19332 | __end_cc_report 02:14:03 INFO - PROCESS | 19332 | __startTimestamp1457259243291__endTimestamp 02:14:03 INFO - PROCESS | 19332 | 02:14:03 INFO - PROCESS | 19332 | ------- Summary: start ------- 02:14:03 INFO - PROCESS | 19332 | Number of tests: 6 02:14:03 INFO - PROCESS | 19332 | 02:14:03 INFO - PROCESS | 19332 | [#0] dojo.html Cycles:165 Average:5542.75 Median:5749.68 stddev:618.25 (10.8%) stddev-sans-first:595.44 02:14:03 INFO - PROCESS | 19332 | Values: 3337.1 3365.4 3378.6 3383.6 3406.5 5429.3 5464.6 5467.6 5473.5 5485.5 5420.6 5466.3 5480.3 5494.6 5519.5 4940.5 5011.2 5078.1 5095.9 5139.9 4929.2 5064.8 5105.5 5106.7 5145.7 5046.7 5073.5 5073.7 5081.6 5082.2 5070.8 5115.8 5117.4 5126.2 5134.0 4911.0 4963.7 4985.4 5014.9 5029.2 5397.7 5409.8 5410.5 5461.3 5461.4 6001.7 6025.9 6031.4 6044.9 6049.5 5869.5 5876.7 5975.4 6036.6 6055.0 5650.2 5655.0 5667.9 5693.1 5715.1 5977.4 6134.4 6177.1 6182.3 6201.3 5795.2 5858.2 5911.2 5915.9 5936.1 5983.6 5990.3 5997.7 6000.0 6003.7 5897.9 5954.1 5956.9 5980.4 6008.5 5729.7 5947.9 5961.3 6041.3 6062.3 4520.1 4541.2 4553.9 4556.2 4577.1 4009.3 4049.3 4109.2 4119.5 4128.3 5587.9 5641.1 5644.1 5656.4 5719.9 5951.9 6002.6 6008.3 6008.9 6013.5 5499.2 5605.3 5618.7 5650.5 5661.7 5041.1 5159.0 5210.5 5253.4 5275.3 5982.8 6052.8 6135.6 6139.6 6156.8 5897.4 5992.7 6008.8 6022.8 6023.5 6102.6 6107.1 6169.8 6178.3 6182.5 5961.5 5961.6 5966.4 5977.0 5989.6 5957.6 6010.8 6054.0 6059.0 6088.4 5673.7 5715.3 5811.2 5874.1 5906.4 5844.0 5850.4 5851.4 5862.8 5883.9 5537.0 5749.7 5753.1 5761.1 5771.9 5808.7 5832.7 5874.4 5879.8 5880.7 5723.2 5724.6 5737.5 5784.1 5799.1 02:14:03 INFO - PROCESS | 19332 | 02:14:03 INFO - PROCESS | 19332 | [#1] ext.html Cycles:180 Average:54496.51 Median:38590.11 stddev:109659.73 (284.2%) stddev-sans-first:109892.60 02:14:03 INFO - PROCESS | 19332 | Values: 566.2 567.5 577.9 584.9 596.7 37191.4 37665.8 37960.6 37995.0 38138.8 38100.4 38426.6 38589.2 38591.0 38857.2 8589.4 8774.2 8812.1 8828.0 8851.7 8564.1 8842.0 8854.1 8859.1 8903.2 8841.2 8875.1 8888.9 8909.9 8922.8 8708.2 8790.1 8848.6 8848.9 8911.3 8418.0 8441.4 8482.0 8495.6 8514.2 37533.8 38405.8 38430.6 38440.2 38568.0 3599.2 3787.6 3821.0 4293.0 4356.2 31286.7 31464.7 31772.2 31827.5 31905.9 4133.9 4138.3 4210.9 4210.9 4222.6 278319.6 279078.0 279847.0 280442.0 280669.0 45486.8 45657.8 45764.0 45840.8 46068.0 43484.0 43648.6 43745.0 43823.6 44233.8 16609.8 16726.7 16766.8 16796.2 16855.7 13267.3 13279.5 13309.4 13439.0 13779.2 15320.5 15377.7 15419.9 15475.8 15493.1 6149.3 6174.7 6280.3 6301.8 6307.4 1040.0 1065.5 1192.8 1215.3 1216.7 30651.7 31021.8 31160.4 32997.0 33059.2 1150.7 1151.4 1155.7 1178.0 1233.5 15559.1 15857.6 16056.4 16228.5 16278.7 515103.0 518848.0 519073.0 519393.0 743239.0 58322.0 59551.7 59906.4 59978.7 60133.7 1491.2 1517.9 1525.6 1527.1 1541.2 31335.4 31338.7 31580.2 31776.5 31993.7 48932.3 49180.8 49194.5 49521.0 49524.8 322277.0 324028.0 324157.0 324399.0 326276.0 34590.3 35045.3 35111.0 35534.6 35581.3 44853.0 45282.1 45643.3 46258.3 46435.0 39062.4 39218.6 39742.0 39833.0 40110.8 39034.8 39734.4 39757.4 39956.6 40257.2 39869.2 39907.8 40441.6 40490.8 40539.0 33730.2 34564.3 34628.4 35347.5 35428.6 27240.2 27375.0 27477.9 27570.9 27752.9 02:14:03 INFO - PROCESS | 19332 | 02:14:03 INFO - PROCESS | 19332 | [#2] jquery.html Cycles:180 Average:27824.14 Median:22931.16 stddev:89458.79 (390.1%) stddev-sans-first:89686.00 02:14:03 INFO - PROCESS | 19332 | Values: 373.6 375.7 376.0 376.4 385.1 15880.4 16062.2 17431.2 19487.3 19621.6 11874.5 11910.9 12255.6 12544.6 12614.8 5157.8 5252.2 5281.0 5291.9 5332.0 5504.2 5509.0 5525.3 5561.2 5569.6 5362.7 5499.0 5533.3 5535.3 5536.6 5544.8 5549.8 5756.8 5799.4 5801.8 5450.3 5625.9 5627.8 5630.5 5737.7 14173.5 14359.6 14417.2 20042.5 21592.0 2398.2 2421.4 2450.7 2462.9 2497.2 10341.1 10619.3 10758.5 11418.9 14223.4 1987.5 2018.4 2024.7 2107.4 2127.5 57867.0 58104.1 59911.4 60103.6 60852.0 10888.1 10956.6 11188.6 11243.9 11353.3 14717.7 14749.7 14761.3 14960.5 14963.6 7954.1 8100.6 8472.8 8505.2 8542.2 8131.6 8149.7 8181.8 8235.8 8239.5 4540.1 4654.4 4702.6 4910.8 4915.3 1962.8 2018.8 2027.4 2032.3 2050.7 455.3 458.4 972.7 1027.4 1060.8 11558.3 12093.9 12182.6 12189.8 12213.6 486.7 495.9 499.1 499.4 511.0 6510.9 6641.5 6735.6 6736.7 6769.2 521666.0 530016.0 534555.0 547782.0 596551.0 76521.0 77392.6 77425.0 78643.2 81041.0 536.3 539.8 540.3 542.0 542.5 10900.9 10940.9 10942.3 10974.5 10982.8 32249.0 32668.7 32969.2 33663.8 33748.7 45407.0 45638.8 46164.5 47018.0 47029.5 7605.1 7920.9 8025.5 8040.8 8118.5 9279.9 11667.7 11714.9 12032.2 12449.4 3132.5 4827.5 6614.6 10662.4 10663.3 10683.5 10690.4 10732.6 11054.8 11136.2 10656.4 10846.6 11003.7 11103.2 11128.4 8370.5 8404.7 8411.9 8414.9 8424.3 10040.7 10239.1 10409.9 10460.5 10748.9 02:14:03 INFO - PROCESS | 19332 | 02:14:03 INFO - PROCESS | 19332 | [#3] mootools.html Cycles:180 Average:5954.03 Median:5826.24 stddev:3051.54 (52.4%) stddev-sans-first:3042.06 02:14:03 INFO - PROCESS | 19332 | Values: 1539.4 1547.2 1773.9 1861.2 1886.3 8398.0 8398.2 8516.1 8571.8 8601.2 8663.2 8699.8 8706.9 8717.6 8766.4 2499.8 2539.9 2556.9 2562.0 2562.5 2475.4 2568.4 2569.0 2570.5 2576.8 2450.1 2521.2 2523.4 2539.5 2543.8 2455.1 2455.2 2476.0 2479.8 2490.0 2457.6 2470.3 2471.0 2475.6 2478.7 8275.3 8286.0 8294.8 8340.3 8355.1 5152.1 5261.7 5269.9 5281.3 5307.4 3227.3 3268.1 3317.4 3328.3 3361.4 996.8 1028.1 1051.8 1062.7 1085.3 11755.5 11852.3 11865.9 11886.6 11926.7 4647.2 4736.5 4777.0 4778.8 4812.4 9611.8 9650.8 9659.1 9712.0 9719.0 5368.7 5409.8 5417.8 5431.6 5436.9 4873.1 4901.8 4937.7 4941.5 5001.9 3808.4 3841.7 3861.5 3880.9 3899.1 1212.1 1223.1 1223.9 1226.5 1232.2 1091.5 1117.2 1241.5 1443.4 1490.4 7830.1 7962.0 7962.8 7965.5 8085.8 1110.3 1163.3 1200.1 1220.3 1223.4 6215.6 6229.9 6237.0 6253.7 6284.0 9981.3 10126.5 10186.9 10191.4 10266.3 9761.4 9949.7 10003.1 10081.9 10110.4 7864.4 7970.0 7979.3 7986.9 8040.6 7778.4 7932.6 8064.2 8087.1 8143.1 8683.4 8749.5 9114.4 9220.6 9278.8 8715.4 8917.2 8927.2 8951.3 9140.0 7550.7 7611.7 7655.4 7656.0 7693.6 7725.3 7888.4 7912.0 7917.4 7931.4 7526.1 7672.7 7696.9 7766.1 7837.9 7553.2 7600.1 7646.0 7705.8 7760.6 7450.4 7506.0 7516.5 7524.3 7546.7 7111.8 7132.6 7201.1 7211.2 7225.5 6944.4 6977.7 6989.7 7008.6 7051.7 02:14:03 INFO - PROCESS | 19332 | 02:14:03 INFO - PROCESS | 19332 | [#4] prototype.html Cycles:180 Average:5696.96 Median:6486.79 stddev:1728.93 (26.7%) stddev-sans-first:1686.64 02:14:03 INFO - PROCESS | 19332 | Values: 354.3 359.2 362.4 363.8 365.3 6280.0 6429.3 6506.7 6515.1 6556.7 6248.2 6397.6 6410.4 6416.9 6437.4 4845.3 4865.8 4892.1 4909.6 4915.5 4915.0 4918.1 4921.6 4927.2 4938.9 4621.5 4749.5 4751.5 4776.4 4800.0 4789.8 4791.2 4795.4 4800.0 4803.5 4163.9 4176.0 4176.5 4181.1 4186.8 6028.3 6103.2 6108.7 6117.9 6158.8 5638.4 5642.2 5643.5 5665.7 5667.2 6805.9 6811.8 6815.6 6818.6 6844.9 4628.5 4656.1 4669.4 4680.3 4688.2 6991.9 7080.8 7145.1 7160.1 7179.8 4785.8 4786.1 4791.3 4793.2 4797.6 4847.7 4852.4 4866.0 4875.7 4881.4 5549.7 5678.0 5683.7 5684.6 5687.0 6809.4 6822.4 6828.9 6840.9 6845.7 1691.1 1744.3 1746.8 1750.9 1751.1 1146.0 1156.8 1165.5 1179.3 1182.8 6446.0 6450.5 6466.8 6552.6 6561.4 6969.5 6978.3 6984.9 7002.0 7038.6 6397.2 6522.2 6538.6 6546.1 6550.0 3770.9 3806.9 3807.7 3810.5 3812.7 7225.4 7289.7 7302.4 7303.6 7308.1 7046.9 7205.4 7208.6 7210.6 7220.2 7197.2 7257.1 7271.9 7272.1 7286.0 6943.0 7002.4 7004.8 7005.7 7014.4 6770.4 6839.1 6899.3 6922.5 6961.0 7310.3 7336.8 7351.7 7401.1 7437.3 4907.5 4911.7 4931.2 4950.5 4956.7 6762.9 6909.0 6992.2 7064.3 7132.2 6741.6 6918.9 6928.2 6942.7 6952.1 6808.8 6828.6 6849.8 6867.6 6969.7 6652.2 6802.2 6804.7 6811.0 6820.9 6972.8 6981.6 6984.2 6984.4 6987.2 6737.5 6782.1 6784.3 6800.6 6814.2 02:14:03 INFO - PROCESS | 19332 | 02:14:03 INFO - PROCESS | 19332 | [#5] yui.html Cycles:180 Average:14941.12 Median:4396.28 stddev:16821.43 (382.6%) stddev-sans-first:16835.35 02:14:03 INFO - PROCESS | 19332 | Values: 852.0 912.5 920.2 934.2 954.3 12379.5 12480.4 12514.7 12716.7 12968.5 14167.6 14225.0 14234.5 14264.4 14285.7 852.8 856.9 862.3 882.8 884.3 879.0 889.7 889.9 892.5 894.9 914.9 917.3 918.4 919.8 921.4 898.7 909.5 910.5 912.8 913.2 673.7 677.2 677.7 678.6 678.8 14187.4 14264.9 14309.1 14309.6 14363.1 14509.8 14515.3 14552.5 14646.2 14657.0 11303.0 11376.4 11429.8 11457.4 11860.3 3984.0 4022.0 4048.3 4057.7 4060.6 48280.3 48589.5 48964.3 49105.5 49129.0 11581.7 11665.5 11823.3 11921.9 11974.5 19644.6 19703.5 19751.8 19824.2 19830.1 8419.4 8593.5 8595.0 8679.5 8688.3 4776.6 4853.0 4884.9 4902.9 4959.0 3308.9 3317.4 3343.8 3349.6 3349.7 584.0 610.5 613.3 619.2 626.1 668.8 680.4 760.8 782.3 787.2 9251.0 9625.0 10034.5 10048.3 10123.0 757.8 771.4 771.7 779.4 779.8 4350.7 4354.6 4438.0 4483.0 4596.5 59759.4 60058.4 60549.1 65200.0 66167.3 53437.0 53811.2 53909.5 54659.0 55209.2 47341.3 47654.0 47766.5 49227.0 49895.8 9527.6 9581.7 9750.5 9852.8 10208.8 36844.8 37754.4 38207.0 38444.0 39813.0 46345.8 47400.8 47892.5 47987.5 48220.5 12148.9 12317.3 12370.0 12461.1 12538.1 14098.5 14112.6 14157.7 14389.0 14520.4 12873.7 13197.5 13350.4 13382.4 13428.6 11996.0 12169.9 12244.1 12550.6 12553.5 12717.9 13044.0 13616.3 13637.1 13801.7 10488.8 10516.4 10824.5 11116.0 11126.6 10726.9 10836.2 10958.8 11195.1 11718.6 02:14:03 INFO - PROCESS | 19332 | -------- Summary: end -------- 02:14:03 INFO - PROCESS | 19332 | 02:14:03 INFO - TEST-INFO | 19332: exit 0 02:14:03 INFO - TEST-OK | dromaeo_css | took 1108582ms 02:14:03 INFO - TEST-START | kraken 02:14:03 INFO - operating with platform_type : linux_ 02:14:03 INFO - Initialising browser for kraken test... 02:14:03 INFO - TEST-INFO | started process 19576 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzLHnjd/profile http://localhost:51024/getInfo.html) 02:14:07 INFO - PROCESS | 19576 | 02:14:07 INFO - PROCESS | 19576 | (process:19656): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:14:08 INFO - PROCESS | 19576 | __metrics Screen width/height:1600/1200 02:14:08 INFO - PROCESS | 19576 | colorDepth:24 02:14:08 INFO - PROCESS | 19576 | Browser inner width/height: 1024/697 02:14:08 INFO - PROCESS | 19576 | __metrics 02:14:09 INFO - TEST-INFO | 19576: exit 0 02:14:09 INFO - Browser initialized. 02:14:09 INFO - Running cycle 1/1 for kraken test... 02:14:09 INFO - TEST-INFO | started process 19705 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzLHnjd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:14:10 INFO - PROCESS | 19705 | 02:14:10 INFO - PROCESS | 19705 | (process:19766): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:14:20 INFO - PROCESS | 19705 | RSS: Main: 141611008 02:14:20 INFO - PROCESS | 19705 | 02:14:23 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51024/tests/kraken/driver.html?testName=audio-beat-detection) 02:14:23 INFO - PROCESS | 19705 | RSS: Main: 146403328 02:14:23 INFO - PROCESS | 19705 | 02:14:26 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51024/tests/kraken/driver.html?testName=audio-dft) 02:14:27 INFO - PROCESS | 19705 | RSS: Main: 144846848 02:14:27 INFO - PROCESS | 19705 | 02:14:30 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51024/tests/kraken/driver.html?testName=audio-fft) 02:14:30 INFO - PROCESS | 19705 | RSS: Main: 145731584 02:14:30 INFO - PROCESS | 19705 | 02:14:32 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51024/tests/kraken/driver.html?testName=audio-oscillator) 02:14:33 INFO - PROCESS | 19705 | RSS: Main: 144785408 02:14:33 INFO - PROCESS | 19705 | 02:14:35 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51024/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:14:36 INFO - PROCESS | 19705 | RSS: Main: 144920576 02:14:36 INFO - PROCESS | 19705 | 02:14:39 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51024/tests/kraken/driver.html?testName=imaging-darkroom) 02:14:39 INFO - PROCESS | 19705 | RSS: Main: 145580032 02:14:39 INFO - PROCESS | 19705 | 02:14:42 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51024/tests/kraken/driver.html?testName=imaging-desaturate) 02:14:43 INFO - PROCESS | 19705 | RSS: Main: 145793024 02:14:43 INFO - PROCESS | 19705 | 02:14:46 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51024/tests/kraken/driver.html?testName=json-parse-financial) 02:14:46 INFO - PROCESS | 19705 | RSS: Main: 145518592 02:14:46 INFO - PROCESS | 19705 | 02:14:48 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51024/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:14:49 INFO - PROCESS | 19705 | RSS: Main: 146878464 02:14:49 INFO - PROCESS | 19705 | 02:14:50 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:14:51 INFO - PROCESS | 19705 | RSS: Main: 147156992 02:14:51 INFO - PROCESS | 19705 | 02:14:53 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:14:54 INFO - PROCESS | 19705 | RSS: Main: 146292736 02:14:54 INFO - PROCESS | 19705 | 02:14:56 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:14:57 INFO - PROCESS | 19705 | RSS: Main: 147251200 02:14:57 INFO - PROCESS | 19705 | 02:14:59 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:15:00 INFO - PROCESS | 19705 | RSS: Main: 145248256 02:15:00 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51024/tests/kraken/driver.html?testName=ai-astar) 02:15:01 INFO - PROCESS | 19705 | RSS: Main: 147480576 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | __start_tp_report 02:15:01 INFO - PROCESS | 19705 | _x_x_mozilla_page_load 02:15:01 INFO - PROCESS | 19705 | _x_x_mozilla_page_load_details 02:15:01 INFO - PROCESS | 19705 | |i|pagename|runs| 02:15:01 INFO - PROCESS | 19705 | |0;ai-astar;111;106;112;111;115;122;111;112;114;111 02:15:01 INFO - PROCESS | 19705 | |1;audio-beat-detection;153;144;153;166;125;144;164;127;159;127 02:15:01 INFO - PROCESS | 19705 | |2;audio-dft;162;162;162;162;164;163;163;162;165;164 02:15:01 INFO - PROCESS | 19705 | |3;audio-fft;74;76;75;153;75;73;75;74;156;76 02:15:01 INFO - PROCESS | 19705 | |4;audio-oscillator;95;96;150;96;96;95;136;102;96;142 02:15:01 INFO - PROCESS | 19705 | |5;imaging-gaussian-blur;109;110;110;110;109;109;110;110;110;109 02:15:01 INFO - PROCESS | 19705 | |6;imaging-darkroom;147;146;146;147;147;147;147;146;147;147 02:15:01 INFO - PROCESS | 19705 | |7;imaging-desaturate;96;96;97;97;96;96;96;96;97;96 02:15:01 INFO - PROCESS | 19705 | |8;json-parse-financial;53;55;56;55;55;57;55;64;53;54 02:15:01 INFO - PROCESS | 19705 | |9;json-stringify-tinderbox;63;63;63;65;64;65;65;64;65;65 02:15:01 INFO - PROCESS | 19705 | |10;stanford-crypto-aes;78;77;79;79;87;78;87;79;79;79 02:15:01 INFO - PROCESS | 19705 | |11;stanford-crypto-ccm;111;110;111;117;115;113;121;114;108;119 02:15:01 INFO - PROCESS | 19705 | |12;stanford-crypto-pbkdf2;128;141;136;137;135;135;138;135;135;125 02:15:01 INFO - PROCESS | 19705 | |13;stanford-crypto-sha256-iterative;64;66;67;69;66;64;66;63;65;65 02:15:01 INFO - PROCESS | 19705 | __end_tp_report 02:15:01 INFO - PROCESS | 19705 | __start_cc_report 02:15:01 INFO - PROCESS | 19705 | _x_x_mozilla_cycle_collect,734 02:15:01 INFO - PROCESS | 19705 | __end_cc_report 02:15:01 INFO - PROCESS | 19705 | __startTimestamp1457259301962__endTimestamp 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | ------- Summary: start ------- 02:15:01 INFO - PROCESS | 19705 | Number of tests: 14 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:4.09 (3.7%) stddev-sans-first:4.30 02:15:01 INFO - PROCESS | 19705 | Values: 111.0 106.0 112.0 111.0 115.0 122.0 111.0 112.0 114.0 111.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:153.00 stddev:15.50 (10.1%) stddev-sans-first:16.24 02:15:01 INFO - PROCESS | 19705 | Values: 153.0 144.0 153.0 166.0 125.0 144.0 164.0 127.0 159.0 127.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 02:15:01 INFO - PROCESS | 19705 | Values: 162.0 162.0 162.0 162.0 164.0 163.0 163.0 162.0 165.0 164.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#3] audio-fft Cycles:10 Average:90.70 Median:75.00 stddev:33.65 (44.9%) stddev-sans-first:35.14 02:15:01 INFO - PROCESS | 19705 | Values: 74.0 76.0 75.0 153.0 75.0 73.0 75.0 74.0 156.0 76.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:95.50 stddev:22.60 (23.7%) stddev-sans-first:23.27 02:15:01 INFO - PROCESS | 19705 | Values: 95.0 96.0 150.0 96.0 96.0 95.0 136.0 102.0 96.0 142.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:15:01 INFO - PROCESS | 19705 | Values: 109.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 109.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 02:15:01 INFO - PROCESS | 19705 | Values: 147.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:15:01 INFO - PROCESS | 19705 | Values: 96.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 97.0 96.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:3.16 (5.8%) stddev-sans-first:3.20 02:15:01 INFO - PROCESS | 19705 | Values: 53.0 55.0 56.0 55.0 55.0 57.0 55.0 64.0 53.0 54.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 02:15:01 INFO - PROCESS | 19705 | Values: 63.0 63.0 63.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.00 stddev:3.65 (4.6%) stddev-sans-first:3.78 02:15:01 INFO - PROCESS | 19705 | Values: 78.0 77.0 79.0 79.0 87.0 78.0 87.0 79.0 79.0 79.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#11] stanford-crypto-ccm Cycles:10 Average:113.90 Median:114.50 stddev:4.15 (3.6%) stddev-sans-first:4.27 02:15:01 INFO - PROCESS | 19705 | Values: 111.0 110.0 111.0 117.0 115.0 113.0 121.0 114.0 108.0 119.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.50 Median:135.50 stddev:4.67 (3.4%) stddev-sans-first:4.32 02:15:01 INFO - PROCESS | 19705 | Values: 128.0 141.0 136.0 137.0 135.0 135.0 138.0 135.0 135.0 125.0 02:15:01 INFO - PROCESS | 19705 | 02:15:01 INFO - PROCESS | 19705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.72 (2.6%) stddev-sans-first:1.73 02:15:01 INFO - PROCESS | 19705 | Values: 64.0 66.0 67.0 69.0 66.0 64.0 66.0 63.0 65.0 65.0 02:15:01 INFO - PROCESS | 19705 | -------- Summary: end -------- 02:15:01 INFO - PROCESS | 19705 | 02:15:02 INFO - TEST-INFO | 19705: exit 0 02:15:02 INFO - TEST-OK | kraken | took 58904ms 02:15:02 INFO - TEST-START | v8_7 02:15:02 INFO - operating with platform_type : linux_ 02:15:02 INFO - Initialising browser for v8_7 test... 02:15:02 INFO - TEST-INFO | started process 19994 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8948L9/profile http://localhost:51024/getInfo.html) 02:15:06 INFO - PROCESS | 19994 | 02:15:06 INFO - PROCESS | 19994 | (process:20073): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:15:07 INFO - PROCESS | 19994 | __metrics Screen width/height:1600/1200 02:15:07 INFO - PROCESS | 19994 | colorDepth:24 02:15:07 INFO - PROCESS | 19994 | Browser inner width/height: 1024/697 02:15:07 INFO - PROCESS | 19994 | __metrics 02:15:08 INFO - TEST-INFO | 19994: exit 0 02:15:08 INFO - Browser initialized. 02:15:08 INFO - Running cycle 1/1 for v8_7 test... 02:15:08 INFO - TEST-INFO | started process 20122 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8948L9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:09 INFO - PROCESS | 20122 | 02:15:09 INFO - PROCESS | 20122 | (process:20186): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:15:19 INFO - PROCESS | 20122 | RSS: Main: 140791808 02:15:19 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | Cycle 1(1): loaded http://localhost:51024/tests/v8_7/run.html (next: http://localhost:51024/tests/v8_7/run.html) 02:15:42 INFO - PROCESS | 20122 | RSS: Main: 144723968 02:15:42 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | __start_tp_report 02:15:42 INFO - PROCESS | 20122 | _x_x_mozilla_page_load 02:15:42 INFO - PROCESS | 20122 | _x_x_mozilla_page_load_details 02:15:42 INFO - PROCESS | 20122 | |i|pagename|runs| 02:15:42 INFO - PROCESS | 20122 | |0;Richards;167.33601070950468 02:15:42 INFO - PROCESS | 20122 | |1;DeltaBlue;169.20473773265653 02:15:42 INFO - PROCESS | 20122 | |2;Encrypt;278.00945232137894 02:15:42 INFO - PROCESS | 20122 | |3;Decrypt;5196.891191709845 02:15:42 INFO - PROCESS | 20122 | |4;RayTrace;912.4087591240876 02:15:42 INFO - PROCESS | 20122 | |5;Earley;547.945205479452 02:15:42 INFO - PROCESS | 20122 | |6;Boyer;11144.444444444445 02:15:42 INFO - PROCESS | 20122 | |7;RegExp;38830.188679245286 02:15:42 INFO - PROCESS | 20122 | |8;Splay;522.1932114882507 02:15:42 INFO - PROCESS | 20122 | |9;NavierStokes;4835.748792270531 02:15:42 INFO - PROCESS | 20122 | __end_tp_report 02:15:42 INFO - PROCESS | 20122 | __startTimestamp1457259342510__endTimestamp 02:15:42 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | ------- Summary: start ------- 02:15:42 INFO - PROCESS | 20122 | Number of tests: 10 02:15:42 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 02:15:42 INFO - PROCESS | 20122 | Values: 167.3 02:15:42 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | [#1] DeltaBlue Cycles:1 Average:169.20 Median:169.20 stddev:0.00 (0.0%) 02:15:42 INFO - PROCESS | 20122 | Values: 169.2 02:15:42 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 02:15:42 INFO - PROCESS | 20122 | Values: 278.0 02:15:42 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 02:15:42 INFO - PROCESS | 20122 | Values: 5196.9 02:15:42 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | [#4] RayTrace Cycles:1 Average:912.41 Median:912.41 stddev:0.00 (0.0%) 02:15:42 INFO - PROCESS | 20122 | Values: 912.4 02:15:42 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | [#5] Earley Cycles:1 Average:547.95 Median:547.95 stddev:0.00 (0.0%) 02:15:42 INFO - PROCESS | 20122 | Values: 547.9 02:15:42 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | [#6] Boyer Cycles:1 Average:11144.44 Median:11144.44 stddev:0.00 (0.0%) 02:15:42 INFO - PROCESS | 20122 | Values: 11144.4 02:15:42 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | [#7] RegExp Cycles:1 Average:38830.19 Median:38830.19 stddev:0.00 (0.0%) 02:15:42 INFO - PROCESS | 20122 | Values: 38830.2 02:15:42 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | [#8] Splay Cycles:1 Average:522.19 Median:522.19 stddev:0.00 (0.0%) 02:15:42 INFO - PROCESS | 20122 | Values: 522.2 02:15:42 INFO - PROCESS | 20122 | 02:15:42 INFO - PROCESS | 20122 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 02:15:42 INFO - PROCESS | 20122 | Values: 4835.7 02:15:42 INFO - PROCESS | 20122 | -------- Summary: end -------- 02:15:42 INFO - PROCESS | 20122 | 02:15:43 INFO - TEST-INFO | 20122: exit 0 02:15:43 INFO - TEST-OK | v8_7 | took 40491ms 02:15:43 INFO - SUITE-END | took 1207s 02:15:43 INFO - Completed test suite (00:20:08) 02:15:43 INFO - Working with test: dromaeo_css 02:15:43 INFO - Generating results file: dromaeo_css 02:15:43 INFO - Working with test: kraken 02:15:43 INFO - Generating results file: kraken 02:15:43 INFO - javascript benchmark 02:15:43 INFO - Working with test: v8_7 02:15:43 INFO - Generating results file: v8_7 02:15:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:15:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 02:15:43 INFO - process_Request line: dromaeo_css 7265.21 graph.html#tests=[[72,52,43]] 02:15:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:15:43 INFO - process_Request line: kraken 1489.30 graph.html#tests=[[232,52,43]] 02:15:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:15:43 INFO - process_Request line: v8_7 22135.53 graph.html#tests=[[230,52,43]] 02:15:43 INFO - RETURN: dromaeo_css: 7265.21 02:15:43 INFO - RETURN: kraken: 1489.30 02:15:43 INFO - RETURN: v8_7: 22135.53 02:15:43 INFO - javascript benchmark 02:15:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3337.115664348948, 3365.4110530657144, 3378.577677790276, 3383.6278009418966, 3406.523086767853, 5429.267048948391, 5464.590155738316, 5467.589930755189, 5473.534749546288, 5485.451454854518, 5420.566354691625, 5466.289382380295, 5480.287562616854, 5494.615376923617, 5519.475649813271, 4940.481249468817, 5011.198208286675, 5078.111330517163, 5095.949040509585, 5139.922901156486, 4929.162042452774, 5064.822731204408, 5105.489451054883, 5106.719130447824, 5145.74271286436, 5046.697198168122, 5073.518015788494, 5073.670211436245, 5081.644284900059, 5082.161443361841, 5070.797168113271, 5115.84893398986, 5117.437081920985, 5126.23106534021, 5133.974330128344, 4911.042346742387, 4963.677360971526, 4985.401751789772, 5014.874628134289, 5029.170186919154, 5397.730113494349, 5409.810656627039, 5410.5401040911565, 5461.290032295816, 5461.42655021221, 6001.66990815505, 6025.9096113558335, 6031.4270144336215, 6044.939550604482, 6049.546284028672, 5869.50109240715, 5876.706164691791, 5975.43233392827, 6036.607620504653, 6054.96972515139, 5650.208970744099, 5655.0, 5667.8583035424035, 5693.089105743061, 5715.085586306171, 5977.432143946318, 6134.447899689049, 6177.073438984098, 6182.258129024456, 6201.255849298113, 5795.246617939725, 5858.179854820243, 5911.231539899785, 5915.940840591625, 5936.050231962865, 5983.640981541122, 5990.341062483123, 5997.7001149942325, 6000.0, 6003.699815009232, 5897.941020589825, 5954.07711804671, 5956.940430595639, 5980.43185897339, 6008.4592386684535, 5729.656220626693, 5947.910781338283, 5961.2846458425265, 6041.275046994301, 6062.302835173923, 4520.118576877478, 4541.159885421142, 4553.908921821611, 4556.24821904382, 4577.130345234395, 4009.3184158693093, 4049.2913740095364, 4109.178164367138, 4119.546849846574, 4128.339465685476, 5587.916181257285, 5641.097424412074, 5644.096944488862, 5656.434356564393, 5719.8570035749435, 5951.9107213391835, 6002.609830361012, 6008.279006519246, 6008.939910600838, 6013.5189184865985, 5499.202615620713, 5605.327360716658, 5618.719064046782, 5650.519705824969, 5661.688607126647, 5041.143005689041, 5159.0, 5210.53105220532, 5253.44838791929, 5275.287836142072, 5982.820515384546, 6052.818415447544, 6135.570510064253, 6139.631622102688, 6156.846078848064, 5897.3807750185615, 5992.67040312787, 6008.819735407945, 6022.849428764316, 6023.488003519662, 6102.633841969496, 6107.144999700135, 6169.84575385619, 6178.258608966953, 6182.505399568114, 5961.493273071837, 5961.552883533665, 5966.433188847052, 5977.0, 5989.64062156272, 5957.553183511167, 6010.819675409744, 6053.97082495968, 6059.0, 6088.391160883876, 5673.659580425187, 5715.342735585461, 5811.215485909517, 5874.089516125007, 5906.379830117948, 5843.970780146242, 5850.414958504116, 5851.356350801323, 5862.824115276549, 5883.94116058834, 5537.031019571478, 5749.683767392667, 5753.1370294456165, 5761.078227483583, 5771.8557036074435, 5808.709564521672, 5832.679202643895, 5874.353821079592, 5879.794207202727, 5880.735366908585, 5723.170140329712, 5724.627899186539, 5737.454941780524, 5784.132380143013, 5799.130130480293], "unit": "score", "name": "dojo.html", "value": 5502.684021704651}, {"lowerIsBetter": false, "replicates": [566.2497191221631, 567.4609121334734, 577.8642019125506, 584.8567101060241, 596.6539407143857, 37191.442128368064, 37665.81167094168, 37960.62039379609, 37995.0, 38138.809305953466, 38100.42849357262, 38426.61573384266, 38589.22821543567, 38591.0, 38857.222855542874, 8589.355798315135, 8774.166454186841, 8812.074732153127, 8827.955860220722, 8851.690190843321, 8564.143585641448, 8841.95579022104, 8854.114588541159, 8859.114088591154, 8903.24322432594, 8841.248493878029, 8875.068117847597, 8888.866667, 8909.886264216973, 8922.776930576723, 8708.21626053655, 8790.120987901191, 8848.557572121368, 8848.867266991001, 8911.287097032222, 8418.0, 8441.366897482714, 8482.0, 8495.575221238912, 8514.233718965323, 37533.81233093845, 38405.80797095997, 38430.615693842985, 38440.231195375934, 38568.0, 3599.248714907083, 3787.621237876218, 3820.9808950955344, 4293.0, 4356.215881141393, 31286.68713312883, 31464.685353146404, 31772.20569485758, 31827.522587161213, 31905.883294084826, 4133.937990930139, 4138.317177665682, 4210.873673789792, 4210.873673789792, 4222.577742225783, 278319.6084019587, 279078.0, 279847.0, 280442.0, 280669.0, 45486.772566136955, 45657.7717111419, 45764.0, 45840.77079614647, 46068.0, 43484.0, 43648.56351436445, 43745.0, 43823.56176438258, 44233.778831105636, 16609.750853737205, 16726.6654666906, 16766.83233167677, 16796.16019199035, 16855.747163792552, 13267.336633168303, 13279.535216267384, 13309.40107695156, 13439.0, 13779.173249605055, 15320.540383788504, 15377.692446151013, 15419.922900385427, 15475.767863482057, 15493.147876866655, 6149.292831324455, 6174.66039367839, 6280.309165991737, 6301.8109456716375, 6307.400796924285, 1039.9792004159874, 1065.4885654885697, 1192.7614477104614, 1215.3254943506263, 1216.6593353860933, 30651.693483064882, 31021.844890775403, 31160.376792464023, 32997.0, 33059.173520662174, 1150.7065698246893, 1151.405890496928, 1155.7399585093287, 1177.9587714429954, 1233.521469456125, 15559.144247066293, 15857.595474398588, 16056.36884398116, 16228.539431451227, 16278.674426511403, 515103.0, 518848.0, 519073.0, 519393.0, 743239.0, 58322.0, 59551.702241488514, 59906.40093599008, 59978.700106499185, 60133.699331503936, 1491.2171110167033, 1517.924103794806, 1525.5575882993808, 1527.0837497501411, 1541.1754711229662, 31335.373292534478, 31338.686613133577, 31580.210494737814, 31776.523352149274, 31993.6800632, 48932.266016009075, 49180.75409622929, 49194.508054918995, 49521.0, 49524.75237623789, 322277.0, 324028.0, 324157.0, 324399.0, 326276.0, 34590.308193836485, 35045.299094017464, 35111.0, 35534.64465355417, 35581.288374232885, 44853.0, 45282.094358111994, 45643.315350269106, 46258.30612540882, 46435.0, 39062.414063789634, 39218.607813921495, 39742.006449838984, 39833.0, 40110.79944600258, 39034.80482597569, 39734.40398393969, 39757.40363894486, 39956.60043399645, 40257.1948561033, 39869.202615948096, 39907.80046099867, 40441.59558404378, 40490.79754601208, 40539.0, 33730.15674608154, 34564.30871382508, 34628.44172012215, 35347.46978795371, 35428.64571354254, 27240.182794516197, 27375.0, 27477.862610687618, 27570.86214568914, 27752.889884404398], "unit": "score", "name": "ext.html", "value": 19272.782817508436}, {"lowerIsBetter": false, "replicates": [373.6189087131125, 375.7294747781598, 375.95112635357407, 376.42970899087885, 385.0931057359919, 15880.444184453547, 16062.19689015549, 17431.21559529821, 19487.31794387195, 19621.607567848634, 11874.45632067832, 11910.940445297783, 12255.632331030061, 12544.623661290154, 12614.81077783834, 5157.845264642057, 5252.159654455288, 5281.0, 5291.947080529203, 5331.973340133294, 5504.2018907258425, 5508.9724551377385, 5525.336959564858, 5561.249231353756, 5569.582281328896, 5362.731863406833, 5499.037668408033, 5533.280673512438, 5535.308086489189, 5536.640118392292, 5544.750486228129, 5549.750261238254, 5756.769729210827, 5799.3620701722775, 5801.796937107223, 5450.29146210994, 5625.943740562583, 5627.774889004435, 5630.5495560355075, 5737.7131143443075, 14173.503927362493, 14359.641008974755, 14417.207053612046, 20042.498937526532, 21592.0, 2398.2445529658276, 2421.418859473731, 2450.6936632920883, 2462.938426539333, 2497.2383423055962, 10341.069303762697, 10619.30974486656, 10758.462076896201, 11418.885811141865, 14223.359948802225, 1987.5130593004662, 2018.3743039657606, 2024.7266619006393, 2107.357256036908, 2127.5319429725437, 57867.0, 58104.128438073465, 59911.40088599102, 60103.58040953207, 60852.0, 10888.074513666268, 10956.616518421817, 11188.552457901593, 11243.931826476472, 11353.318800871974, 14717.705645887023, 14749.705005900036, 14761.261936903113, 14960.476383326532, 14963.551093467213, 7954.125046244909, 8100.635471403801, 8472.788180295542, 8505.23452889243, 8542.231199192103, 8131.552764598004, 8149.674013039412, 8181.75454736347, 8235.846981422606, 8239.546824924566, 4540.069285796404, 4654.371659825948, 4702.6473014524045, 4910.8281210157475, 4915.26271059344, 1962.7928823773277, 2018.8283995860222, 2027.4120505053663, 2032.2886989553538, 2050.7026481160146, 455.3102050393656, 458.3811853997077, 972.6790159247431, 1027.3921313144904, 1060.8196606576746, 11558.306501609763, 12093.87906120945, 12182.573609923611, 12189.817152742717, 12213.572524961584, 486.6544753225179, 495.94296655885034, 499.1041081259149, 499.36331177747934, 510.9846704598868, 6510.934890651128, 6641.468682505388, 6735.6295403753265, 6736.730530778812, 6769.22153952292, 521666.0, 530016.0, 534555.0, 547782.0, 596551.0, 76521.0, 77392.61303693446, 77425.0, 78643.21356786358, 81041.0, 536.286738637611, 539.7652021370716, 540.348879600081, 541.9620626556182, 542.4683809866353, 10900.890991089987, 10940.945295273472, 10942.288751231463, 10974.506147223234, 10982.835257471304, 32249.0, 32668.67331326656, 32969.17577060593, 33663.83168084144, 33748.66251337554, 45407.0, 45638.77180614076, 46164.53835461602, 47018.0, 47029.529704702516, 7605.087389513294, 7920.920790792018, 8025.518468891885, 8040.798980025546, 8118.472299300526, 9279.86080208811, 11667.708307292385, 11714.88285117172, 12032.217905836093, 12449.377531123226, 3132.4518209313733, 4827.468978412302, 6614.603123812587, 10662.360258384522, 10663.306885052447, 10683.465826708789, 10690.41202733857, 10732.624358147428, 11054.778904421706, 11136.220464567403, 10656.413897235727, 10846.620368287073, 11003.724906877393, 11103.167262455187, 11128.38793866345, 8370.539620320696, 8404.747857564284, 8411.915880841114, 8414.915850841413, 8424.28393586552, 10040.69877903664, 10239.129673977497, 10409.9479502602, 10460.529276182438, 10748.946255268673], "unit": "score", "name": "jquery.html", "value": 7912.190048763163}, {"lowerIsBetter": false, "replicates": [1539.3996341426846, 1547.1722628393811, 1773.893566386017, 1861.1810803246563, 1886.2926402599016, 8397.958010209955, 8398.1601839816, 8516.10580889007, 8571.828563428728, 8601.182887625673, 8663.176998185163, 8699.826003479926, 8706.912930870689, 8717.564121793917, 8766.430182038162, 2499.8250122491386, 2539.9111031113916, 2556.910508132216, 2561.974380256192, 2562.487502499498, 2475.418276704973, 2568.434944312258, 2569.0366112707734, 2570.5116027954627, 2576.8196226264167, 2450.0812195426715, 2521.231024537515, 2523.3817714659936, 2539.4540173862615, 2543.8473691578474, 2455.067074511683, 2455.1529722245796, 2475.962860557102, 2479.789217916479, 2490.0, 2457.63135529672, 2470.28361775085, 2470.9752902470923, 2475.5667758142254, 2478.677771889643, 8275.337972962148, 8286.0, 8294.792630184294, 8340.29107525861, 8355.1227121152, 5152.124138896396, 5261.736913154327, 5269.86825329366, 5281.287026251483, 5307.363116426015, 3227.3383956288903, 3268.0686004488607, 3317.3531161423534, 3328.251143492719, 3361.3613413451367, 996.7856910764148, 1028.136365453023, 1051.8422236664562, 1062.6758838554238, 1085.3433672628105, 11755.471003804849, 11852.34812085335, 11865.88134118665, 11886.58396956111, 11926.701832454259, 4647.233206520954, 4736.502667219961, 4776.9761151194025, 4778.761061946889, 4812.374391329105, 9611.759706007266, 9650.806983860284, 9659.082387173208, 9711.951440242894, 9719.028097190225, 5368.731563421813, 5409.756560954766, 5417.756200970965, 5431.646942948696, 5436.91844622331, 4873.147199240118, 4901.803927842918, 4937.703737775745, 4941.530554597308, 5001.89996200074, 3808.3906574947873, 3841.7118716096406, 3861.4787003754695, 3880.9223815523533, 3899.064224586079, 1212.0848759186758, 1223.1437993404652, 1223.8714934931882, 1226.5093962415106, 1232.168286406672, 1091.5306418240075, 1117.1732917640886, 1241.5468354050888, 1443.350492278479, 1490.381491680962, 7830.060392752792, 7962.0, 7962.800929976797, 7965.4822436541435, 8085.838283234302, 1110.2949626986922, 1163.26714170074, 1200.0879331707965, 1220.3471142938663, 1223.3821919930556, 6215.564910456224, 6229.878621848111, 6236.968815155986, 6253.749850005949, 6284.0, 9981.251406144569, 10126.54430550627, 10186.898131018743, 10191.439470829175, 10266.281360304707, 9761.414315141114, 9949.651762188289, 10003.149732272694, 10081.899181008095, 10110.443925584164, 7864.41016923733, 7970.0, 7979.321757650665, 7986.880196797053, 8040.638171282307, 7778.416618753503, 7932.6033698316005, 8064.15326390744, 8087.069986951341, 8143.144969778088, 8683.392162548562, 8749.47503149813, 9114.40756350835, 9220.585073671835, 9278.814423711623, 8715.38992270535, 8917.197452229331, 8927.151920567536, 8951.28389728807, 9139.954300228455, 7550.66022029021, 7611.695532178651, 7655.425843061904, 7655.961720191363, 7693.615319234128, 7725.266099720518, 7888.408369372435, 7911.960440197762, 7917.406194535318, 7931.36549076061, 7526.119976022604, 7672.693092276247, 7696.923030769621, 7766.068071831416, 7837.921620783719, 7553.169151393233, 7600.125985511516, 7646.0, 7705.845883082419, 7760.573168475788, 7450.441216908645, 7505.962470187614, 7516.5114267572435, 7524.2851929066655, 7546.698132074655, 7111.751088711871, 7132.643367831484, 7201.099862517185, 7211.206767255493, 7225.494215404871, 6944.375006249462, 6977.7208911642965, 6989.650517474004, 7008.579485230903, 7051.717931282691], "unit": "score", "name": "mootools.html", "value": 4896.687172566595}, {"lowerIsBetter": false, "replicates": [354.3285474026721, 359.19898626063883, 362.39299173883745, 363.7962740865116, 365.2567026101883, 6279.968600156993, 6429.260635026973, 6506.73973041079, 6515.08788769572, 6556.67216639168, 6248.187735594378, 6397.648129352884, 6410.391012853783, 6416.903746443807, 6437.420632143107, 4845.345878306436, 4865.829695960642, 4892.070506603743, 4909.5581397674205, 4915.5330243626795, 4915.041566894457, 4918.065567542156, 4921.557059864612, 4927.211646136619, 4938.901221975559, 4621.468531118914, 4749.453812811519, 4751.453582837983, 4776.379070720802, 4800.0, 4789.760511974388, 4791.161546729309, 4795.400574928134, 4799.976000119995, 4803.543663351976, 4163.854265100737, 4176.0395109124765, 4176.498820141572, 4181.1010632714115, 4186.811593478301, 6028.306744724325, 6103.176071230371, 6108.664023478706, 6117.938820611781, 6158.8152355428965, 5638.4361563843695, 5642.210090587321, 5643.520300774439, 5665.688387138705, 5667.1782591524, 6805.931940680629, 6811.795646130575, 6815.556988795713, 6818.556793808387, 6844.93155068448, 4628.514006029386, 4656.115338085787, 4669.392978912753, 4680.297955306697, 4688.203005489075, 6991.89512157318, 7080.822979425504, 7145.142582890035, 7160.069191005188, 7179.820504487429, 4785.784639691153, 4786.0667169901535, 4791.257355109963, 4793.23308270675, 4797.64017698674, 4847.733374664427, 4852.441969173519, 4866.0, 4875.683080599821, 4881.414230292387, 5549.694766787785, 5677.971610141923, 5683.744231509592, 5684.6020778545935, 5687.0, 6809.38715515606, 6822.351876571718, 6828.897566536506, 6840.897386539206, 6845.657717114124, 1691.129068529708, 1744.284843214276, 1746.7816522934634, 1750.88619239749, 1751.0806826415978, 1146.0, 1156.849609550753, 1165.5279611757253, 1179.2924245452832, 1182.8403165572538, 6446.033095035688, 6450.5484616077365, 6466.838329041811, 6552.639604821685, 6561.376669216417, 6969.512134150561, 6978.337057979484, 6984.860302793915, 7002.0, 7038.577685338793, 6397.232332120176, 6522.249941256721, 6538.640374779433, 6546.116274302908, 6550.017497375432, 3770.8868733938025, 3806.9428958565645, 3807.695384369244, 3810.5046343975105, 3812.675922546559, 7225.385842203366, 7289.671964761493, 7302.415806735448, 7303.6348182590655, 7308.1230252369, 7046.907729301966, 7205.387542058879, 7208.639568021578, 7210.639468026578, 7220.241874603091, 7197.244289349647, 7257.092863392076, 7271.927280727231, 7272.127344718562, 7285.963570182115, 6942.993265976304, 7002.439804815501, 7004.754833580801, 7005.684744186626, 7014.403775679124, 6770.390664840188, 6839.1451068616425, 6899.275576064641, 6922.480813938874, 6961.0, 7310.342069213796, 7336.816579585553, 7351.66917488725, 7401.111866576045, 7437.330640242404, 4907.533784290486, 4911.656184067081, 4931.235658472942, 4950.480199578992, 4956.727379994135, 6762.898556521558, 6909.0, 6992.195897471653, 7064.2935706431, 7132.215456299699, 6741.59550426976, 6918.896216556655, 6928.203256625553, 6942.652867356713, 6952.061471701458, 6808.761693340709, 6828.556143850634, 6849.760258390932, 6867.553609015398, 6969.7212111517, 6652.168478940132, 6802.217744959195, 6804.659767011729, 6810.965945170243, 6820.931790682228, 6972.825679357854, 6981.581105133709, 6984.231734509099, 6984.441244700311, 6987.231404545598, 6737.528373013842, 6782.084418603426, 6784.2876497967, 6800.625965571743, 6814.182298124257], "unit": "score", "name": "prototype.html", "value": 5136.356906193398}, {"lowerIsBetter": false, "replicates": [851.9957400212998, 912.5209265135807, 920.2178148573709, 934.2292608597904, 954.2604481526815, 12379.504819807209, 12480.375981200927, 12514.683608843652, 12716.745665086693, 12968.481260749559, 14167.645808854784, 14225.0, 14234.501792437266, 14264.358103885324, 14285.714285714279, 852.8379607874515, 856.9014563325235, 862.279996203168, 882.8278485695292, 884.2969838978028, 878.9516576588285, 889.6797153024905, 889.915458031486, 892.5314210039717, 894.9373543851933, 914.9496777677225, 917.3349321741717, 918.3525614441836, 919.7608621758358, 921.4149015375218, 898.7348732123974, 909.5088652127843, 910.4901255297021, 912.8402529557301, 913.1872633356318, 673.666535065141, 677.1603212017112, 677.701811203074, 678.5691086160324, 678.8133263352568, 14187.43250269988, 14264.857351426457, 14309.141451512942, 14309.642258943506, 14363.138211707332, 14509.782353264603, 14515.274236288144, 14552.49066282675, 14646.194459304734, 14657.0, 11303.0, 11376.374299413612, 11429.828552571718, 11457.427128643618, 11860.347680877549, 3984.0, 4022.034711669208, 4048.3117869962175, 4057.736247143926, 4060.553339132693, 48280.27579586309, 48589.514104858856, 48964.26553601699, 49105.50894491045, 49128.99999999964, 11581.710457238469, 11665.475053622607, 11823.290602563873, 11921.940390297994, 11974.461149248305, 19644.607107857762, 19703.50741231452, 19751.802481975283, 19824.207031718568, 19830.107645156004, 8419.368547358972, 8593.527355995355, 8595.0, 8679.47923124602, 8688.348373871984, 4776.570108690165, 4853.0, 4884.852059765952, 4902.92645610309, 4959.032988567267, 3308.8511017004294, 3317.419451595961, 3343.7993720376853, 3349.648286929886, 3349.732021438279, 583.9970800145973, 610.517691024086, 613.3161524899793, 619.1517620859362, 626.0984182776787, 668.8428219368444, 680.3536640191837, 760.8478304339154, 782.2685788787502, 787.1773996174012, 9251.028641992494, 9624.951875240578, 10034.498275086216, 10048.346857454242, 10123.0, 757.7537300377289, 771.3713323641326, 771.714465647714, 779.4426984705849, 779.773865578987, 4350.73895566267, 4354.608085272341, 4437.955620443819, 4482.9775851121185, 4596.540345965377, 59759.40240597625, 60058.39941600528, 60549.09176362358, 65200.0, 66167.33832661709, 53437.0, 53811.19283210755, 53909.46090539123, 54659.0, 55209.171862422096, 47341.28988065182, 47654.0, 47766.522334776906, 49227.01545969061, 49895.750521247886, 9527.57125929321, 9581.712548623553, 9750.463724494937, 9852.753681158028, 10208.795824083625, 36844.81577592095, 37754.43368349422, 38207.0, 38444.0, 39813.0, 46345.76827115843, 47400.7629961848, 47892.5210747902, 47987.520124798306, 48220.5177948216, 12148.939255303667, 12317.260964341809, 12370.0, 12461.127721059802, 12538.05964552644, 14098.50655227062, 14112.559265210675, 14157.716845662822, 14389.0, 14520.419183232974, 12873.742525149632, 13197.472101116233, 13350.399232034775, 13382.397792099573, 13428.597142085753, 11996.0, 12169.878301217228, 12244.142909996215, 12550.623481295575, 12553.497860085494, 12717.870329932342, 13044.0, 13616.251106188858, 13637.11358761717, 13801.654958626115, 10488.790224195322, 10516.421596812248, 10824.458777061272, 11116.0, 11126.61056863006, 10726.892731072589, 10836.187285953427, 10958.835617465904, 11195.10439164881, 11718.648440546796], "unit": "score", "name": "yui.html", "value": 6967.598713308356}], "name": "dromaeo_css", "value": 7265.211714957989}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 112.0, 111.0, 115.0, 122.0, 111.0, 112.0, 114.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [153.0, 144.0, 153.0, 166.0, 125.0, 144.0, 164.0, 127.0, 159.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 162.0, 164.0, 163.0, 163.0, 162.0, 165.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 75.0, 153.0, 75.0, 73.0, 75.0, 74.0, 156.0, 76.0], "unit": "score", "name": "audio-fft", "value": 90.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 150.0, 96.0, 96.0, 95.0, 136.0, 102.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 56.0, 55.0, 55.0, 57.0, 55.0, 64.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 79.0, 79.0, 87.0, 78.0, 87.0, 79.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.2}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 111.0, 117.0, 115.0, 113.0, 121.0, 114.0, 108.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.9}, {"lowerIsBetter": true, "replicates": [128.0, 141.0, 136.0, 137.0, 135.0, 135.0, 138.0, 135.0, 135.0, 125.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.5}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 67.0, 69.0, 66.0, 64.0, 66.0, 63.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1489.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [169.20473773265653], "unit": "score", "name": "DeltaBlue", "value": 390.75737999999984}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [912.4087591240876], "unit": "score", "name": "RayTrace", "value": 811.0279440000002}, {"lowerIsBetter": false, "replicates": [547.945205479452], "unit": "score", "name": "Earley", "value": 1216.2949749999998}, {"lowerIsBetter": false, "replicates": [11144.444444444445], "unit": "score", "name": "Boyer", "value": 59.80226321036885}, {"lowerIsBetter": false, "replicates": [38830.188679245286], "unit": "score", "name": "RegExp", "value": 23.460741010689976}, {"lowerIsBetter": false, "replicates": [522.1932114882507], "unit": "score", "name": "Splay", "value": 156.055265}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 22135.526816937785}]} 02:15:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22135.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1489.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7265.21"}}} 02:15:43 INFO - Return code: 0 02:15:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:15:43 INFO - # TBPL SUCCESS # 02:15:43 INFO - Running post-action listener: _resource_record_post_action 02:15:43 INFO - Running post-run listener: _resource_record_post_run 02:15:44 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 262144; Write bytes: 374910976; Read time: 16; Write time: 269100 02:15:44 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 121712640; Read time: 0; Write time: 102096 02:15:44 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 262144; Write bytes: 253198336; Read time: 16; Write time: 167004 02:15:44 INFO - Running post-run listener: _upload_blobber_files 02:15:44 INFO - Blob upload gear active. 02:15:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:15:44 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:15:44 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:15:44 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:15:45 INFO - (blobuploader) - INFO - Open directory for files ... 02:15:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:15:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:15:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:46 INFO - (blobuploader) - INFO - Done attempting. 02:15:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:15:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:15:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:47 INFO - (blobuploader) - INFO - Done attempting. 02:15:47 INFO - (blobuploader) - INFO - Iteration through files over. 02:15:47 INFO - Return code: 0 02:15:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:15:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:15:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f903845d002f054a0a8169447e4b11d0f335077621a121db82d26ca36bb43a40763342642962fb43353796000fc96db5206d65ceb3e8764fa4f9895d928d10b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c24944b57416dc9c378950d91f481502f67c4982fbfa51744358ddd3d64d538b93ca7c5a65f5b7a903a820a1d7947a64b31e5bac68130b425d4897d1cd64ac3"} 02:15:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:15:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:15:47 INFO - Contents: 02:15:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f903845d002f054a0a8169447e4b11d0f335077621a121db82d26ca36bb43a40763342642962fb43353796000fc96db5206d65ceb3e8764fa4f9895d928d10b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c24944b57416dc9c378950d91f481502f67c4982fbfa51744358ddd3d64d538b93ca7c5a65f5b7a903a820a1d7947a64b31e5bac68130b425d4897d1cd64ac3"} 02:15:47 INFO - Running post-run listener: copy_logs_to_upload_dir 02:15:47 INFO - Copying logs to upload dir... 02:15:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:15:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1334.860952 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2016-03-06 02:15:46.726353) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 02:15:46.730081) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603 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/f903845d002f054a0a8169447e4b11d0f335077621a121db82d26ca36bb43a40763342642962fb43353796000fc96db5206d65ceb3e8764fa4f9895d928d10b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c24944b57416dc9c378950d91f481502f67c4982fbfa51744358ddd3d64d538b93ca7c5a65f5b7a903a820a1d7947a64b31e5bac68130b425d4897d1cd64ac3"} 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.011201 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/f903845d002f054a0a8169447e4b11d0f335077621a121db82d26ca36bb43a40763342642962fb43353796000fc96db5206d65ceb3e8764fa4f9895d928d10b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c24944b57416dc9c378950d91f481502f67c4982fbfa51744358ddd3d64d538b93ca7c5a65f5b7a903a820a1d7947a64b31e5bac68130b425d4897d1cd64ac3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 02:15:46.754239) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 02:15:46.754577) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457249722.982889-229563603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 02:15:46.838396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 02:15:46.838722) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 02:15:46.839006) ========= ========= Total master_lag: 0.36 =========