builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1456774619.67 results: success (0) buildid: 20160229083150 builduid: 7c88152fade649b0b7a942440a089843 revision: 6af962bff65de440a88387256ce311c5e5e2e440 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 11:36:59.670527) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 11:36:59.670887) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 11:36:59.671178) ========= 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=3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006385 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.85 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:00.526140) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:00.526474) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:00.566851) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:00.567131) ========= 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=3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:00.626878) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:00.627172) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:00.627538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:00.627833) ========= 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=3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 11:37:00-- 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% 222M=0s 2016-02-29 11:37:01 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.404135 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:01.059635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:01.059949) ========= 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=3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018294 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:01.116704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:01.117187) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6af962bff65de440a88387256ce311c5e5e2e440 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6af962bff65de440a88387256ce311c5e5e2e440 --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=3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 11:37:01,402 truncating revision to first 12 chars 2016-02-29 11:37:01,402 Setting DEBUG logging. 2016-02-29 11:37:01,402 attempt 1/10 2016-02-29 11:37:01,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6af962bff65d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 11:37:01,826 unpacking tar archive at: fx-team-6af962bff65d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.736215 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:01.865917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:01.866286) ========= echo 6af962bff65de440a88387256ce311c5e5e2e440 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6af962bff65de440a88387256ce311c5e5e2e440'] 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=3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6af962bff65de440a88387256ce311c5e5e2e440 program finished with exit code 0 elapsedTime=0.003830 script_repo_revision: '6af962bff65de440a88387256ce311c5e5e2e440' ========= master_lag: 0.14 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:02.013847) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:02.014218) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 11:37:02.024430) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-29 11:37:02.024739) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:37:02 INFO - MultiFileLogger online at 20160229 11:37:02 in /builds/slave/test-pgo 11:37:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:37:02 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:37:02 INFO - {'append_to_log': False, 11:37:02 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:37:02 INFO - 'blob_upload_branch': 'Fx-Team', 11:37:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:37:02 INFO - 'branch': 'Fx-Team', 11:37:02 INFO - 'buildbot_json_path': 'buildprops.json', 11:37:02 INFO - 'config_files': ('talos/linux_config.py',), 11:37:02 INFO - 'default_actions': ('clobber', 11:37:02 INFO - 'read-buildbot-config', 11:37:02 INFO - 'download-and-extract', 11:37:02 INFO - 'populate-webroot', 11:37:02 INFO - 'create-virtualenv', 11:37:02 INFO - 'install', 11:37:02 INFO - 'run-tests'), 11:37:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:37:02 INFO - 'download_minidump_stackwalk': True, 11:37:02 INFO - 'download_symbols': 'ondemand', 11:37:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:37:02 INFO - 'tooltool.py': '/tools/tooltool.py', 11:37:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:37:02 INFO - '/tools/misc-python/virtualenv.py')}, 11:37:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:37:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:37:02 INFO - 'installer_path': 'installer.exe', 11:37:02 INFO - 'log_level': 'info', 11:37:02 INFO - 'log_name': 'talos', 11:37:02 INFO - 'log_to_console': True, 11:37:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:37:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:37:02 INFO - 'opt_config_files': (), 11:37:02 INFO - 'pip_index': False, 11:37:02 INFO - 'sps_profile': False, 11:37:02 INFO - 'sps_profile_interval': 0, 11:37:02 INFO - 'suite': 'dromaeojs-e10s', 11:37:02 INFO - 'system_bits': '32', 11:37:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:37:02 INFO - 'title': 'talos-linux64-ix-059', 11:37:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:37:02 INFO - 'use_talos_json': True, 11:37:02 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:37:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:37:02 INFO - 'work_dir': 'build'} 11:37:02 INFO - ##### 11:37:02 INFO - ##### Running clobber step. 11:37:02 INFO - ##### 11:37:02 INFO - Running pre-action listener: _resource_record_pre_action 11:37:02 INFO - Running main action method: clobber 11:37:02 INFO - rmtree: /builds/slave/test-pgo/build 11:37:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:37:02 INFO - Running post-action listener: _resource_record_post_action 11:37:02 INFO - ##### 11:37:02 INFO - ##### Running read-buildbot-config step. 11:37:02 INFO - ##### 11:37:02 INFO - Running pre-action listener: _resource_record_pre_action 11:37:02 INFO - Running main action method: read_buildbot_config 11:37:02 INFO - Using buildbot properties: 11:37:02 INFO - { 11:37:02 INFO - "project": "", 11:37:02 INFO - "product": "firefox", 11:37:02 INFO - "script_repo_revision": "production", 11:37:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:37:02 INFO - "repository": "", 11:37:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:37:02 INFO - "buildid": "20160229083150", 11:37:02 INFO - "pgo_build": "True", 11:37:02 INFO - "basedir": "/builds/slave/test-pgo", 11:37:02 INFO - "buildnumber": 304, 11:37:02 INFO - "slavename": "talos-linux64-ix-059", 11:37:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:37:02 INFO - "platform": "ubuntu64_hw", 11:37:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:37:02 INFO - "branch": "fx-team", 11:37:02 INFO - "repo_path": "integration/fx-team", 11:37:02 INFO - "revision": "6af962bff65de440a88387256ce311c5e5e2e440", 11:37:02 INFO - "stage_platform": "linux64-pgo", 11:37:02 INFO - "builduid": "7c88152fade649b0b7a942440a089843", 11:37:02 INFO - "slavebuilddir": "test" 11:37:02 INFO - } 11:37:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 11:37:02 INFO - Running post-action listener: _resource_record_post_action 11:37:02 INFO - ##### 11:37:02 INFO - ##### Running download-and-extract step. 11:37:02 INFO - ##### 11:37:02 INFO - Running pre-action listener: _resource_record_pre_action 11:37:02 INFO - Running main action method: download_and_extract 11:37:02 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:37: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')]} 11:37:02 INFO - https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:37:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/test_packages.json 11:37:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/test_packages.json 11:37:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:37:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:37:03 INFO - Downloaded 1448 bytes. 11:37:03 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:37:03 INFO - Using the following test package requirements: 11:37:03 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:37:03 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:37:03 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:37:03 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:03 INFO - u'jsshell-linux-x86_64.zip'], 11:37:03 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:37:03 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:37:03 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:37:03 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:37:03 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:37:03 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:37:03 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:37:03 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:03 INFO - https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:37:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:37:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:37:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:37:04 INFO - Downloaded 23372555 bytes. 11:37:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:37:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:37:06 INFO - Return code: 0 11:37:06 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:37:06 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')]} 11:37:06 INFO - https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:37:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:37:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:37:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:37:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:37:07 INFO - Downloaded 23372555 bytes. 11:37:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:37:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:37:08 INFO - Return code: 0 11:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:08 INFO - https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:37:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:37:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:37:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:37:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:37:10 INFO - Downloaded 10713410 bytes. 11:37:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:37:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 11:37:10 INFO - Return code: 0 11:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:10 INFO - https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:37:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:37:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:37:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:37:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:37:11 INFO - Downloaded 56588995 bytes. 11:37:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:37:11 INFO - mkdir: /builds/slave/test-pgo/properties 11:37:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:37:11 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:37:11 INFO - Contents: 11:37:11 INFO - build_url:https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:37:12 INFO - Running post-action listener: _resource_record_post_action 11:37:12 INFO - Running post-action listener: set_extra_try_arguments 11:37:12 INFO - ##### 11:37:12 INFO - ##### Running populate-webroot step. 11:37:12 INFO - ##### 11:37:12 INFO - Running pre-action listener: _resource_record_pre_action 11:37:12 INFO - Running main action method: populate_webroot 11:37:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:37:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:37:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:37:12 INFO - '--tppagecycles', 11:37:12 INFO - '7'], 11:37:12 INFO - 'tests': ['tsvgm']}}, 11:37:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:37:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:37:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:37:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:37:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:37:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:37:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'talos_options': ['--e10s'], 11:37:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'tests': ['damp', 'tps']}, 11:37:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'talos_options': ['--e10s'], 11:37:12 INFO - 'tests': ['damp', 'tps']}, 11:37:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:37:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:37:12 INFO - 'other': {'tests': ['a11yr', 11:37:12 INFO - 'ts_paint', 11:37:12 INFO - 'tpaint', 11:37:12 INFO - 'sessionrestore', 11:37:12 INFO - 'sessionrestore_no_auto_restore']}, 11:37:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:37:12 INFO - 'tests': ['a11yr', 11:37:12 INFO - 'ts_paint', 11:37:12 INFO - 'tpaint', 11:37:12 INFO - 'sessionrestore', 11:37:12 INFO - 'sessionrestore_no_auto_restore']}, 11:37:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:37:12 INFO - 'tests': ['a11yr', 11:37:12 INFO - 'ts_paint', 11:37:12 INFO - 'tpaint', 11:37:12 INFO - 'sessionrestore', 11:37:12 INFO - 'sessionrestore_no_auto_restore']}, 11:37:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:37:12 INFO - 'tests': ['a11yr', 11:37:12 INFO - 'ts_paint', 11:37:12 INFO - 'tpaint', 11:37:12 INFO - 'sessionrestore', 11:37:12 INFO - 'sessionrestore_no_auto_restore']}, 11:37:12 INFO - 'other_l64': {'tests': ['a11yr', 11:37:12 INFO - 'ts_paint', 11:37:12 INFO - 'tpaint', 11:37:12 INFO - 'sessionrestore', 11:37:12 INFO - 'sessionrestore_no_auto_restore']}, 11:37:12 INFO - 'other_nol64': {'tests': ['a11yr', 11:37:12 INFO - 'ts_paint', 11:37:12 INFO - 'tpaint', 11:37:12 INFO - 'sessionrestore', 11:37:12 INFO - 'sessionrestore_no_auto_restore']}, 11:37:12 INFO - 'svgr': {'tests': ['tsvgx', 11:37:12 INFO - 'tsvgr_opacity', 11:37:12 INFO - 'tart', 11:37:12 INFO - 'tscrollx', 11:37:12 INFO - 'cart']}, 11:37:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:37:12 INFO - 'tests': ['tsvgx', 11:37:12 INFO - 'tsvgr_opacity', 11:37:12 INFO - 'tart', 11:37:12 INFO - 'tscrollx', 11:37:12 INFO - 'cart']}, 11:37:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'tests': ['tp5o']}, 11:37:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'talos_options': ['--e10s'], 11:37:12 INFO - 'tests': ['tp5o']}, 11:37:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'talos_options': ['--xperf_path', 11:37:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:12 INFO - 'tests': ['tp5n']}, 11:37:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'talos_options': ['--e10s', 11:37:12 INFO - '--xperf_path', 11:37:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:12 INFO - 'tests': ['tp5n']}}, 11:37:12 INFO - 'talos.zip': {'path': '', 11:37:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:37:12 INFO - Running post-action listener: _resource_record_post_action 11:37:12 INFO - ##### 11:37:12 INFO - ##### Running create-virtualenv step. 11:37:12 INFO - ##### 11:37:12 INFO - Running pre-action listener: _resource_record_pre_action 11:37:12 INFO - Running main action method: create_virtualenv 11:37:12 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:37:12 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 11:37:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:37:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:37:12 INFO - Using real prefix '/usr' 11:37:12 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:37:13 INFO - Installing distribute.............................................................................................................................................................................................done. 11:37:15 INFO - Installing pip.................done. 11:37:15 INFO - Return code: 0 11:37:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:37: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')]} 11:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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')]} 11:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3700046f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558c0>, '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 0x23567c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2356c50>, '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': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', '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 11:37: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:37: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 pip>=1.5 11:37:15 INFO - Using env: {'DISPLAY': ':0', 11:37:15 INFO - 'HOME': '/home/cltbld', 11:37:15 INFO - 'LANG': 'en_US.UTF-8', 11:37:15 INFO - 'LANGUAGE': 'en_US:en', 11:37:15 INFO - 'LOGNAME': 'cltbld', 11:37:15 INFO - 'MAIL': '/var/mail/cltbld', 11:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:15 INFO - 'MOZ_NO_REMOTE': '1', 11:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:15 INFO - 'NO_EM_RESTART': '1', 11:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:37:15 INFO - 'PWD': '/builds/slave/test-pgo', 11:37:15 INFO - 'SHELL': '/bin/bash', 11:37:15 INFO - 'SHLVL': '1', 11:37:15 INFO - 'TERM': 'linux', 11:37:15 INFO - 'TMOUT': '86400', 11:37:15 INFO - 'USER': 'cltbld', 11:37:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', 11:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:15 INFO - '_': '/tools/buildbot/bin/python'} 11:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:15 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 11:37:15 INFO - Cleaning up... 11:37:15 INFO - Return code: 0 11:37:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:37: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')]} 11:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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')]} 11:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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', '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 0x7f3700046f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558c0>, '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 0x23567c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2356c50>, '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': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', '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 11:37: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:37: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 psutil>=0.7.1 11:37:15 INFO - Using env: {'DISPLAY': ':0', 11:37:15 INFO - 'HOME': '/home/cltbld', 11:37:15 INFO - 'LANG': 'en_US.UTF-8', 11:37:15 INFO - 'LANGUAGE': 'en_US:en', 11:37:15 INFO - 'LOGNAME': 'cltbld', 11:37:15 INFO - 'MAIL': '/var/mail/cltbld', 11:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:15 INFO - 'MOZ_NO_REMOTE': '1', 11:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:15 INFO - 'NO_EM_RESTART': '1', 11:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:37:15 INFO - 'PWD': '/builds/slave/test-pgo', 11:37:15 INFO - 'SHELL': '/bin/bash', 11:37:15 INFO - 'SHLVL': '1', 11:37:15 INFO - 'TERM': 'linux', 11:37:15 INFO - 'TMOUT': '86400', 11:37:15 INFO - 'USER': 'cltbld', 11:37:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', 11:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:15 INFO - '_': '/tools/buildbot/bin/python'} 11:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:15 INFO - Downloading/unpacking psutil>=0.7.1 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:37:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:17 INFO - Installing collected packages: psutil 11:37:17 INFO - Running setup.py install for psutil 11:37:17 INFO - building 'psutil._psutil_linux' extension 11:37:17 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 11:37:17 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 11:37:17 INFO - building 'psutil._psutil_posix' extension 11:37:17 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 11:37:17 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 11:37:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:18 INFO - Successfully installed psutil 11:37:18 INFO - Cleaning up... 11:37:18 INFO - Return code: 0 11:37:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:18 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 0x7f3700046f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558c0>, '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 0x23567c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2356c50>, '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': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', '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 11:37:18 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 11:37:18 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 11:37:18 INFO - Using env: {'DISPLAY': ':0', 11:37:18 INFO - 'HOME': '/home/cltbld', 11:37:18 INFO - 'LANG': 'en_US.UTF-8', 11:37:18 INFO - 'LANGUAGE': 'en_US:en', 11:37:18 INFO - 'LOGNAME': 'cltbld', 11:37:18 INFO - 'MAIL': '/var/mail/cltbld', 11:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:18 INFO - 'MOZ_NO_REMOTE': '1', 11:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:18 INFO - 'NO_EM_RESTART': '1', 11:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:37:18 INFO - 'PWD': '/builds/slave/test-pgo', 11:37:18 INFO - 'SHELL': '/bin/bash', 11:37:18 INFO - 'SHLVL': '1', 11:37:18 INFO - 'TERM': 'linux', 11:37:18 INFO - 'TMOUT': '86400', 11:37:18 INFO - 'USER': 'cltbld', 11:37:18 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', 11:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:18 INFO - '_': '/tools/buildbot/bin/python'} 11:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:37:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:37:20 INFO - Installing collected packages: mozsystemmonitor 11:37:20 INFO - Running setup.py install for mozsystemmonitor 11:37:20 INFO - Successfully installed mozsystemmonitor 11:37:20 INFO - Cleaning up... 11:37:20 INFO - Return code: 0 11:37:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:37:20 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')]} 11:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:20 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')]} 11:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:20 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 0x7f3700046f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558c0>, '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 0x23567c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2356c50>, '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': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', '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 11:37:20 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 11:37:20 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 11:37:20 INFO - Using env: {'DISPLAY': ':0', 11:37:20 INFO - 'HOME': '/home/cltbld', 11:37:20 INFO - 'LANG': 'en_US.UTF-8', 11:37:20 INFO - 'LANGUAGE': 'en_US:en', 11:37:20 INFO - 'LOGNAME': 'cltbld', 11:37:20 INFO - 'MAIL': '/var/mail/cltbld', 11:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:20 INFO - 'MOZ_NO_REMOTE': '1', 11:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:20 INFO - 'NO_EM_RESTART': '1', 11:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:37:20 INFO - 'PWD': '/builds/slave/test-pgo', 11:37:20 INFO - 'SHELL': '/bin/bash', 11:37:20 INFO - 'SHLVL': '1', 11:37:20 INFO - 'TERM': 'linux', 11:37:20 INFO - 'TMOUT': '86400', 11:37:20 INFO - 'USER': 'cltbld', 11:37:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', 11:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:20 INFO - '_': '/tools/buildbot/bin/python'} 11:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:20 INFO - Downloading/unpacking blobuploader==1.2.4 11:37:20 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 11:37:20 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 11:37:20 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 11:37:20 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 11:37:20 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 11:37:20 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 11:37:22 INFO - Downloading blobuploader-1.2.4.tar.gz 11:37:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:37:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:37:22 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 11:37:22 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 11:37:22 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 11:37:22 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 11:37:22 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 11:37:22 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 11:37:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:37:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:37:22 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 11:37:22 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 11:37:22 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 11:37:22 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 11:37:22 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 11:37:22 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 11:37:23 INFO - Downloading docopt-0.6.1.tar.gz 11:37:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:37:23 INFO - Installing collected packages: blobuploader, requests, docopt 11:37:23 INFO - Running setup.py install for blobuploader 11:37:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:37:23 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:37:23 INFO - Running setup.py install for requests 11:37:23 INFO - Running setup.py install for docopt 11:37:23 INFO - Successfully installed blobuploader requests docopt 11:37:23 INFO - Cleaning up... 11:37:23 INFO - Return code: 0 11:37:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:37:23 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')]} 11:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:23 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')]} 11:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:23 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 0x7f3700046f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558c0>, '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 0x23567c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2356c50>, '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': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', '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 11:37:23 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 11:37:23 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 11:37:23 INFO - Using env: {'DISPLAY': ':0', 11:37:23 INFO - 'HOME': '/home/cltbld', 11:37:23 INFO - 'LANG': 'en_US.UTF-8', 11:37:23 INFO - 'LANGUAGE': 'en_US:en', 11:37:23 INFO - 'LOGNAME': 'cltbld', 11:37:23 INFO - 'MAIL': '/var/mail/cltbld', 11:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:23 INFO - 'MOZ_NO_REMOTE': '1', 11:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:23 INFO - 'NO_EM_RESTART': '1', 11:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:37:23 INFO - 'PWD': '/builds/slave/test-pgo', 11:37:23 INFO - 'SHELL': '/bin/bash', 11:37:23 INFO - 'SHLVL': '1', 11:37:23 INFO - 'TERM': 'linux', 11:37:23 INFO - 'TMOUT': '86400', 11:37:23 INFO - 'USER': 'cltbld', 11:37:23 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', 11:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:23 INFO - '_': '/tools/buildbot/bin/python'} 11:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:37:23 INFO - Running setup.py (path:/tmp/pip-48UyMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:37:24 INFO - Running setup.py (path:/tmp/pip-md5tNC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:37:24 INFO - Running setup.py (path:/tmp/pip-iEIfLk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:37:24 INFO - Running setup.py (path:/tmp/pip-bAzX8K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:37:24 INFO - Running setup.py (path:/tmp/pip-GtytGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:37:24 INFO - Running setup.py (path:/tmp/pip-6h3QcH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:37:24 INFO - Running setup.py (path:/tmp/pip-8RJA0n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:37:24 INFO - Running setup.py (path:/tmp/pip-dFkd_g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:37:24 INFO - Running setup.py (path:/tmp/pip-rmgGgz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:37:24 INFO - Running setup.py (path:/tmp/pip-5nVjf3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:37:24 INFO - Running setup.py (path:/tmp/pip-EnaWCS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:37:24 INFO - Running setup.py (path:/tmp/pip-Xj3M57-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:37:24 INFO - Running setup.py (path:/tmp/pip-iQJJVc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:37:24 INFO - Running setup.py (path:/tmp/pip-fIE5ke-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:37:24 INFO - Running setup.py (path:/tmp/pip-o_APSI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:37:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:37:25 INFO - Running setup.py (path:/tmp/pip-XoGh9h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:37:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:37:25 INFO - Running setup.py (path:/tmp/pip-C09qI_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:37:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:37:25 INFO - Running setup.py install for manifestparser 11:37:25 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:37:25 INFO - Running setup.py install for mozcrash 11:37:25 INFO - Running setup.py install for mozdebug 11:37:25 INFO - Running setup.py install for mozdevice 11:37:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:37:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:37:25 INFO - Running setup.py install for mozfile 11:37:25 INFO - Running setup.py install for mozhttpd 11:37:25 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:37:25 INFO - Running setup.py install for mozinfo 11:37:25 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:37:25 INFO - Running setup.py install for mozInstall 11:37:25 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:37:25 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:37:25 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:37:25 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:37:25 INFO - Running setup.py install for mozleak 11:37:26 INFO - Running setup.py install for mozlog 11:37:26 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:37:26 INFO - Running setup.py install for moznetwork 11:37:26 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:37:26 INFO - Running setup.py install for mozprocess 11:37:26 INFO - Running setup.py install for mozprofile 11:37:26 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:37:26 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:37:26 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:37:26 INFO - Running setup.py install for mozrunner 11:37:26 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:37:26 INFO - Running setup.py install for mozscreenshot 11:37:26 INFO - Running setup.py install for moztest 11:37:26 INFO - Running setup.py install for mozversion 11:37:26 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:37:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:37:26 INFO - Cleaning up... 11:37:26 INFO - Return code: 0 11:37:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:37:26 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')]} 11:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:26 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')]} 11:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:26 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 0x7f3700046f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558c0>, '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 0x23567c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2356c50>, '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': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', '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 11:37:26 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 11:37:26 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 11:37:26 INFO - Using env: {'DISPLAY': ':0', 11:37:26 INFO - 'HOME': '/home/cltbld', 11:37:26 INFO - 'LANG': 'en_US.UTF-8', 11:37:26 INFO - 'LANGUAGE': 'en_US:en', 11:37:26 INFO - 'LOGNAME': 'cltbld', 11:37:26 INFO - 'MAIL': '/var/mail/cltbld', 11:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:26 INFO - 'MOZ_NO_REMOTE': '1', 11:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:26 INFO - 'NO_EM_RESTART': '1', 11:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:37:26 INFO - 'PWD': '/builds/slave/test-pgo', 11:37:26 INFO - 'SHELL': '/bin/bash', 11:37:26 INFO - 'SHLVL': '1', 11:37:26 INFO - 'TERM': 'linux', 11:37:26 INFO - 'TMOUT': '86400', 11:37:26 INFO - 'USER': 'cltbld', 11:37:26 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', 11:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:26 INFO - '_': '/tools/buildbot/bin/python'} 11:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:37:27 INFO - Running setup.py (path:/tmp/pip-xPFQy8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:37:27 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)) 11:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:37:27 INFO - Running setup.py (path:/tmp/pip-tEhXM8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:37:27 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)) 11:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:37:27 INFO - Running setup.py (path:/tmp/pip-YpHgW1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:37:27 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)) 11:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:37:27 INFO - Running setup.py (path:/tmp/pip-hch5MU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:37:27 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)) 11:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:37:27 INFO - Running setup.py (path:/tmp/pip-Y0HgjW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:37:27 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)) 11:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:37:27 INFO - Running setup.py (path:/tmp/pip-J1gp9c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:37:27 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)) 11:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:37:27 INFO - Running setup.py (path:/tmp/pip-YNI00E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:37:27 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)) 11:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:37:27 INFO - Running setup.py (path:/tmp/pip-FWO0Zr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:37:27 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)) 11:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:37:27 INFO - Running setup.py (path:/tmp/pip-n8MExZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:37:27 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)) 11:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:37:27 INFO - Running setup.py (path:/tmp/pip-eTIrJU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:37:27 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)) 11:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:37:27 INFO - Running setup.py (path:/tmp/pip-uQ4_D0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:37:27 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)) 11:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:37:27 INFO - Running setup.py (path:/tmp/pip-nHD53r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:37:28 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)) 11:37:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:37:28 INFO - Running setup.py (path:/tmp/pip-AgaX3P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:37:28 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)) 11:37:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:37:28 INFO - Running setup.py (path:/tmp/pip-2bZZSS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:37:28 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)) 11:37:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:37:28 INFO - Running setup.py (path:/tmp/pip-3cYzUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:37:28 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)) 11:37:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:37:28 INFO - Running setup.py (path:/tmp/pip-CNhcBM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:37:28 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)) 11:37:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:37:28 INFO - Running setup.py (path:/tmp/pip-ValZAB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:37:28 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)) 11:37:28 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)) 11:37:28 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)) 11:37:28 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)) 11:37:28 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)) 11:37:28 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)) 11:37:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:37:28 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 11:37:28 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 11:37:28 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 11:37:28 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 11:37:28 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 11:37:28 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 11:37:30 INFO - Downloading blessings-1.6.tar.gz 11:37:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:37:30 INFO - Installing collected packages: blessings 11:37:30 INFO - Running setup.py install for blessings 11:37:30 INFO - Successfully installed blessings 11:37:30 INFO - Cleaning up... 11:37:30 INFO - Return code: 0 11:37:30 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:37:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:37:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:37:30 INFO - Reading from file tmpfile_stdout 11:37:30 INFO - Current package versions: 11:37:30 INFO - argparse == 1.2.1 11:37:30 INFO - blessings == 1.6 11:37:30 INFO - blobuploader == 1.2.4 11:37:30 INFO - docopt == 0.6.1 11:37:30 INFO - manifestparser == 1.1 11:37:30 INFO - mozInstall == 1.12 11:37:30 INFO - mozcrash == 0.16 11:37:30 INFO - mozdebug == 0.1 11:37:30 INFO - mozdevice == 0.48 11:37:30 INFO - mozfile == 1.2 11:37:30 INFO - mozhttpd == 0.7 11:37:30 INFO - mozinfo == 0.9 11:37:30 INFO - mozleak == 0.1 11:37:30 INFO - mozlog == 3.1 11:37:30 INFO - moznetwork == 0.27 11:37:30 INFO - mozprocess == 0.22 11:37:30 INFO - mozprofile == 0.28 11:37:30 INFO - mozrunner == 6.11 11:37:30 INFO - mozscreenshot == 0.1 11:37:30 INFO - mozsystemmonitor == 0.0 11:37:30 INFO - moztest == 0.7 11:37:30 INFO - mozversion == 1.4 11:37:30 INFO - psutil == 3.1.1 11:37:30 INFO - requests == 1.2.3 11:37:30 INFO - wsgiref == 0.1.2 11:37:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:37:30 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')]} 11:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:30 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')]} 11:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:30 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 0x7f3700046f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558c0>, '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 0x23567c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2356c50>, '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': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', '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 11:37:30 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 11:37:30 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 11:37:30 INFO - Using env: {'DISPLAY': ':0', 11:37:30 INFO - 'HOME': '/home/cltbld', 11:37:30 INFO - 'LANG': 'en_US.UTF-8', 11:37:30 INFO - 'LANGUAGE': 'en_US:en', 11:37:30 INFO - 'LOGNAME': 'cltbld', 11:37:30 INFO - 'MAIL': '/var/mail/cltbld', 11:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:30 INFO - 'MOZ_NO_REMOTE': '1', 11:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:30 INFO - 'NO_EM_RESTART': '1', 11:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:37:30 INFO - 'PWD': '/builds/slave/test-pgo', 11:37:30 INFO - 'SHELL': '/bin/bash', 11:37:30 INFO - 'SHLVL': '1', 11:37:30 INFO - 'TERM': 'linux', 11:37:30 INFO - 'TMOUT': '86400', 11:37:30 INFO - 'USER': 'cltbld', 11:37:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', 11:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:30 INFO - '_': '/tools/buildbot/bin/python'} 11:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:30 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)) 11:37:30 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)) 11:37:30 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)) 11:37:30 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)) 11:37:30 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)) 11:37:30 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)) 11:37:30 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)) 11:37:30 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)) 11:37:30 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)) 11:37:30 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)) 11:37:30 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)) 11:37:30 INFO - Cleaning up... 11:37:30 INFO - Return code: 0 11:37:30 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:37:30 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')]} 11:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:30 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')]} 11:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:30 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 0x7f3700046f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558c0>, '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 0x23567c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2356c50>, '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': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', '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 11:37:30 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 11:37:30 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 11:37:30 INFO - Using env: {'DISPLAY': ':0', 11:37:30 INFO - 'HOME': '/home/cltbld', 11:37:30 INFO - 'LANG': 'en_US.UTF-8', 11:37:30 INFO - 'LANGUAGE': 'en_US:en', 11:37:30 INFO - 'LOGNAME': 'cltbld', 11:37:30 INFO - 'MAIL': '/var/mail/cltbld', 11:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:30 INFO - 'MOZ_NO_REMOTE': '1', 11:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:30 INFO - 'NO_EM_RESTART': '1', 11:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:37:30 INFO - 'PWD': '/builds/slave/test-pgo', 11:37:30 INFO - 'SHELL': '/bin/bash', 11:37:30 INFO - 'SHLVL': '1', 11:37:30 INFO - 'TERM': 'linux', 11:37:30 INFO - 'TMOUT': '86400', 11:37:30 INFO - 'USER': 'cltbld', 11:37:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', 11:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:30 INFO - '_': '/tools/buildbot/bin/python'} 11:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:31 INFO - Downloading/unpacking jsonschema 11:37:31 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 11:37:31 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 11:37:31 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 11:37:31 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 11:37:31 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 11:37:31 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 11:37:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:37:32 INFO - Downloading/unpacking functools32 (from jsonschema) 11:37:32 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 11:37:32 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 11:37:32 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 11:37:32 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 11:37:32 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 11:37:32 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 11:37:33 INFO - Downloading functools32-3.2.3-2.tar.gz 11:37:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:37:33 INFO - warning: no files found matching '*.txt' 11:37:33 INFO - no previously-included directories found matching 'build' 11:37:33 INFO - no previously-included directories found matching 'dist' 11:37:33 INFO - no previously-included directories found matching '.git*' 11:37:33 INFO - Installing collected packages: jsonschema, functools32 11:37:33 INFO - Running setup.py install for functools32 11:37:33 INFO - warning: no files found matching '*.txt' 11:37:33 INFO - no previously-included directories found matching 'build' 11:37:33 INFO - no previously-included directories found matching 'dist' 11:37:33 INFO - no previously-included directories found matching '.git*' 11:37:33 INFO - Successfully installed jsonschema functools32 11:37:33 INFO - Cleaning up... 11:37:33 INFO - Return code: 0 11:37:33 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:37: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')]} 11:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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')]} 11:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:33 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 0x7f3700046f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23558c0>, '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 0x23567c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2356c50>, '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': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', '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 11:37:33 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 11:37:33 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 11:37:33 INFO - Using env: {'DISPLAY': ':0', 11:37:33 INFO - 'HOME': '/home/cltbld', 11:37:33 INFO - 'LANG': 'en_US.UTF-8', 11:37:33 INFO - 'LANGUAGE': 'en_US:en', 11:37:33 INFO - 'LOGNAME': 'cltbld', 11:37:33 INFO - 'MAIL': '/var/mail/cltbld', 11:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:33 INFO - 'MOZ_NO_REMOTE': '1', 11:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:33 INFO - 'NO_EM_RESTART': '1', 11:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:37:33 INFO - 'PWD': '/builds/slave/test-pgo', 11:37:33 INFO - 'SHELL': '/bin/bash', 11:37:33 INFO - 'SHLVL': '1', 11:37:33 INFO - 'TERM': 'linux', 11:37:33 INFO - 'TMOUT': '86400', 11:37:33 INFO - 'USER': 'cltbld', 11:37:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', 11:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:33 INFO - '_': '/tools/buildbot/bin/python'} 11:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:33 INFO - Downloading/unpacking flake8 11:37:33 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 11:37:33 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 11:37:33 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 11:37:33 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 11:37:33 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 11:37:33 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 11:37:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:37:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:37:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 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 11:37:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:37:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:37:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:37:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:37:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:37:36 INFO - no previously-included directories found matching 'docs/_build' 11:37:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:37:36 INFO - Running setup.py install for pep8 11:37:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:37:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:37:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:37:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:37:36 INFO - no previously-included directories found matching 'docs/_build' 11:37:36 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:37:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:37:36 INFO - Cleaning up... 11:37:36 INFO - Return code: 0 11:37:36 INFO - Running post-action listener: _resource_record_post_action 11:37:36 INFO - Running post-action listener: _start_resource_monitoring 11:37:36 INFO - Starting resource monitoring. 11:37:36 INFO - ##### 11:37:36 INFO - ##### Running install step. 11:37:36 INFO - ##### 11:37:36 INFO - Running pre-action listener: _resource_record_pre_action 11:37:36 INFO - Running main action method: install 11:37:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:37:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:37:36 INFO - Reading from file tmpfile_stdout 11:37:36 INFO - Detecting whether we're running mozinstall >=1.0... 11:37:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:37:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:37:36 INFO - Reading from file tmpfile_stdout 11:37:36 INFO - Output received: 11:37:36 INFO - Usage: mozinstall [options] installer 11:37:36 INFO - Options: 11:37:36 INFO - -h, --help show this help message and exit 11:37:36 INFO - -d DEST, --destination=DEST 11:37:36 INFO - Directory to install application into. [default: 11:37:36 INFO - "/builds/slave/test-pgo"] 11:37:36 INFO - --app=APP Application being installed. [default: firefox] 11:37:36 INFO - mkdir: /builds/slave/test-pgo/build/application 11:37:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:37:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:37:52 INFO - Reading from file tmpfile_stdout 11:37:52 INFO - Output received: 11:37:52 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:37:52 INFO - Running post-action listener: _resource_record_post_action 11:37:52 INFO - ##### 11:37:52 INFO - ##### Running run-tests step. 11:37:52 INFO - ##### 11:37:52 INFO - Running pre-action listener: _resource_record_pre_action 11:37:52 INFO - Running main action method: run_tests 11:37:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:37:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:37:52 INFO - Python 2.7.3 11:37:52 INFO - Return code: 0 11:37:52 INFO - grabbing minidump binary from tooltool 11:37: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')]} 11:37:52 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 0x23558c0>, '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 0x23567c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2356c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:37:52 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 11:37:52 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 11:37:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:37:53 INFO - Return code: 0 11:37:53 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:37:53 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:37:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:37:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:37:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:37:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:37:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:37:54 INFO - Return code: 0 11:37:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 11:37:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 11:37:54 INFO - Using env: {'DISPLAY': ':0', 11:37:54 INFO - 'HOME': '/home/cltbld', 11:37:54 INFO - 'LANG': 'en_US.UTF-8', 11:37:54 INFO - 'LANGUAGE': 'en_US:en', 11:37:54 INFO - 'LOGNAME': 'cltbld', 11:37:54 INFO - 'MAIL': '/var/mail/cltbld', 11:37:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:37:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:54 INFO - 'MOZ_NO_REMOTE': '1', 11:37:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:54 INFO - 'NO_EM_RESTART': '1', 11:37:54 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:37:54 INFO - 'PWD': '/builds/slave/test-pgo', 11:37:54 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:37:54 INFO - 'SHELL': '/bin/bash', 11:37:54 INFO - 'SHLVL': '1', 11:37:54 INFO - 'TERM': 'linux', 11:37:54 INFO - 'TMOUT': '86400', 11:37:54 INFO - 'USER': 'cltbld', 11:37:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066', 11:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:54 INFO - '_': '/tools/buildbot/bin/python'} 11:37:54 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 11:37:54 INFO - mozversion application_buildid: 20160229083150 11:37:54 INFO - mozversion application_changeset: 6af962bff65de440a88387256ce311c5e5e2e440 11:37:54 INFO - mozversion application_display_name: Nightly 11:37:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:37:54 INFO - mozversion application_name: Firefox 11:37:54 INFO - mozversion application_remotingname: firefox 11:37:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:37:54 INFO - mozversion application_vendor: Mozilla 11:37:54 INFO - mozversion application_version: 47.0a1 11:37:54 INFO - mozversion platform_buildid: 20160229083150 11:37:54 INFO - mozversion platform_changeset: 6af962bff65de440a88387256ce311c5e5e2e440 11:37:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:37:54 INFO - mozversion platform_version: 47.0a1 11:37:54 INFO - using testdate: 1456774674 11:37:54 INFO - actual date: 1456774674 11:37:54 INFO - starting webserver on 'localhost:41709' 11:37:54 INFO - SUITE-START | Running 2 tests 11:37:54 INFO - TEST-START | dromaeo_css 11:37:54 INFO - operating with platform_type : linux_ 11:37:54 INFO - Initialising browser for dromaeo_css test... 11:37:54 INFO - TEST-INFO | started process 2808 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp13h5ai/profile http://localhost:41709/getInfo.html) 11:37:57 INFO - PROCESS | 2808 | 11:37:57 INFO - PROCESS | 2808 | (process:2926): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:37:58 INFO - PROCESS | 2808 | __metrics Screen width/height:1600/1200 11:37:58 INFO - PROCESS | 2808 | colorDepth:24 11:37:58 INFO - PROCESS | 2808 | Browser inner width/height: 1024/697 11:37:58 INFO - PROCESS | 2808 | __metrics 11:37:59 ERROR - PROCESS | 2808 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 11:37:59 INFO - PROCESS | 2808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:37:59 INFO - PROCESS | 2808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:37:59 INFO - PROCESS | 2808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:37:59 INFO - PROCESS | 2808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:37:59 INFO - PROCESS | 2808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:37:59 INFO - PROCESS | 2808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:37:59 INFO - PROCESS | 2808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:37:59 INFO - PROCESS | 2808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:37:59 INFO - PROCESS | 2808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:37:59 INFO - TEST-INFO | 2808: exit 0 11:37:59 INFO - Browser initialized. 11:37:59 INFO - Running cycle 1/1 for dromaeo_css test... 11:37:59 INFO - TEST-INFO | started process 2978 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp13h5ai/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:01 INFO - PROCESS | 2978 | 11:38:01 INFO - PROCESS | 2978 | (process:3038): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:38:11 INFO - PROCESS | 2978 | RSS: Main: 160772096 11:38:11 INFO - PROCESS | 2978 | 11:39:01 INFO - PROCESS | 2978 | 1456774741432 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] 11:41:10 INFO - PROCESS | 2978 | Cycle 1(1): loaded http://localhost:41709/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41709/tests/dromaeo/cssquery-ext.html) 11:41:11 INFO - PROCESS | 2978 | RSS: Main: 169050112 11:41:11 INFO - PROCESS | 2978 | 11:44:13 INFO - PROCESS | 2978 | Cycle 1(1): loaded http://localhost:41709/tests/dromaeo/cssquery-ext.html (next: http://localhost:41709/tests/dromaeo/cssquery-jquery.html) 11:44:13 INFO - PROCESS | 2978 | RSS: Main: 164937728 11:44:13 INFO - PROCESS | 2978 | 11:47:15 INFO - PROCESS | 2978 | Cycle 1(1): loaded http://localhost:41709/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41709/tests/dromaeo/cssquery-mootools.html) 11:47:16 INFO - PROCESS | 2978 | RSS: Main: 166305792 11:47:16 INFO - PROCESS | 2978 | 11:50:17 INFO - PROCESS | 2978 | Cycle 1(1): loaded http://localhost:41709/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41709/tests/dromaeo/cssquery-prototype.html) 11:50:18 INFO - PROCESS | 2978 | RSS: Main: 163708928 11:50:18 INFO - PROCESS | 2978 | 11:53:20 INFO - PROCESS | 2978 | Cycle 1(1): loaded http://localhost:41709/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41709/tests/dromaeo/cssquery-yui.html) 11:53:21 INFO - PROCESS | 2978 | RSS: Main: 164683776 11:53:21 INFO - PROCESS | 2978 | 11:56:24 INFO - PROCESS | 2978 | Cycle 1(1): loaded http://localhost:41709/tests/dromaeo/cssquery-yui.html (next: http://localhost:41709/tests/dromaeo/cssquery-dojo.html) 11:56:24 INFO - PROCESS | 2978 | RSS: Main: 168558592 11:56:24 INFO - PROCESS | 2978 | 11:56:24 INFO - PROCESS | 2978 | __start_tp_report 11:56:24 INFO - PROCESS | 2978 | _x_x_mozilla_page_load 11:56:24 INFO - PROCESS | 2978 | _x_x_mozilla_page_load_details 11:56:24 INFO - PROCESS | 2978 | |i|pagename|runs| 11:56:24 INFO - PROCESS | 2978 | |0;dojo.html;3154.1168472827603;3192.872285108596;3202.6797320267992;3228.5480032795404;3242.108420184449;5213.713245771481;5237.607179461541;5249.842504724859;5256.842294731159;5273.129933560967;5150.484951504847;5273.235380869781;5306.044911915854;5330.626856120063;5337.813176538822;4811.615070794328;4839.709617422957;4864.318995340655;4958.404991401037;4973.378327709036;4823.252395878644;4893.804247830082;4895.192293271606;4898.314236006961;4943;4818.614510839142;4833.32333473314;4835.661503694742;4866.197077482211;4907.558319751204;4837.0567739290855;4866.7079975201605;4866.878328041792;4890.779914903838;4922.950770492285;4765.880852978703;4841.491643377465;4847.854564363075;4884.5603895649565;4884.975575122137;5028;5067.239914012891;5118.6416950813455;5144.202648589475;5146.3824341078935;5616.663000219959;5622.550195984311;5639.097744360924;5675.51758100562;5688.089905615123;5624.550035997151;5695.515881150107;5699.857503562444;5751.281089863767;5762.164486149527;5301.257823904656;5328.573714102862;5334.786608535654;5339.866503337409;5344.759485823147;5718.085106382959;5767.336756272998;5767.509761670221;5780.104083867007;5831.591788574844;5530.5022547970075;5622.156676498476;5634.7182640867795;5641.210230567724;5684.431556844283;5617.438256174431;5718.1708652246025;5730.828075157752;5756.913646295226;5761.9135712964335;5576.191452239484;5701.771929122789;5706;5708.286464191976;5740.368559458456;5659.151127330851;5663.830085097454;5711.086226203787;5716.5998380113;5768.221290125864;4235.597618226264;4244.915101697949;4255.0426154115075;4258.956555643887;4287.63555097814;3834.8082595870096;3853.6339047790416;3869.2841824262036;3874.3994680824517;3906;5360.249565060894;5361.812336568201;5378.811741589026;5382.30030096085;5420.13277875538;5666.394275805676;5670.858228544319;5673.319201695823;5678.574106941914;5683.886322273532;5216.087184742655;5390.51485366319;5400.567954563626;5433.945660543423;5438.945610543923;4766.118268120409;4778;4784.665197777775;4787.712737235777;4824;5838.065909454467;5868.530517558585;5868.706564671749;5901.262342207224;5907;5532.5297349724115;5580.888382232414;5641.097424412074;5669.064604340238;5726.656400615976;5886.705664716833;5935.465808077293;5970.880582388241;5971.790987315423;5986.311574169026;5532.97639936613;5602.299712535933;5603.131514615241;5615.494605485526;5643.209950606836;5577.163425486209;5736.110902810071;5752.597318187854;5760.567957403127;5812.447817457335;5537.584681149011;5539;5547.362053363753;5587.888242235052;5611.438856114356;5459.945400545944;5463.945360546344;5488.341399032141;5525.198846167203;5532.723363831712;5417.5665946723375;5439.292891924025;5448.509634132947;5454.372747134131;5477.561795056466;5456.890862182655;5521.4478552144465;5529.253550770594;5536;5539.556835453073;5419.403865574863;5454.072807622634;5503.449655034625;5545.306836645419;5549.056660367828 11:56:24 INFO - PROCESS | 2978 | |1;ext.html;478.90900728861493;515.8239214590734;525.5480286953219;534.1240365800088;551.5284431810802;35635.287294254165;35655.99999999997;36004.459933101025;36048.2790344193;36201.45697814532;39387;39565.63692086169;39770.60229397705;40024;40036.79981600095;8477.872831907527;8653.95673021634;8685.826283474327;8706.259967902735;8745.038045814956;8432.325413966868;8594.226519613234;8613.397062205648;8629;8653.69712060078;8829.514376709278;8836.248918841875;8876.911230887705;8878.60046297915;8916.73249802507;8756.255718263923;8767.693130740425;8790.824183516326;8809.691660791905;8811.471311721318;8681.392302538825;8778.956105219497;8782.297416206751;8789;8844;40098.39852402217;40403.59596404057;40677.98305042368;40707.18585628271;40718.38922416166;2815.5469745262462;3220.7454781652705;3306.6197387300526;3309.652486488908;3400.4049291373913;26476.8676156618;26745.331366715793;26804.59793103105;27580.310492237655;27913;3714.814259287025;3752.2307926875196;3797.487339209199;3845.5404489454245;3880.3597406427907;219265.84404935755;220233;220653.9999999984;221000;221047;41738.79130604328;56498;62888.37111628916;62942.68528657327;63080;40477.39283910744;40729;40969.38545921814;41023.7948810254;41288.793556032026;12869.4208760606;12869.485220591072;13000.67498312531;13024.54414095502;13050.216986980811;11009.779804404026;11053.17101217412;11086.778264434666;11103.222774405715;11117.166212534092;14113.153210807179;14138.57584272453;14354.210518421587;14423.92788036053;14546;5783.826485205451;5897.64614123154;5905.911411328833;5913.408659134052;5914.526837852962;918.7519369770125;958.5734348214977;969.3021024862088;1057.5769692123213;1088.9945550272198;27443.725562744516;27680;27686.537761397292;27898.860505697343;28100.578491322645;1099.9890001099886;1105.1766434006556;1108.955641774336;1120.6581992492206;1135.3244819332483;14914;14921.40314387434;14970.27696800245;14971.475998340224;15070.321835517429;291880;293808;294537;296695;298128;54024.45975540273;54702.45297547053;54709;54768;55069.44930550723;1264.9177803442747;1272.1603741530546;1280.884720375152;1282.2691066092239;1291.7739395605731;27727;28819.56770648484;28819.711802882543;28859.42281154323;28877.71122288834;48323.516764831904;48617;48726.64006959161;48904.26643600278;48953.5104648949;274989;277848;278686;279567;280991;32352.35295294128;44333.556664432945;44801.10397791961;45135.32297015482;45224.32163517616;40306.193876121724;41196.588034119275;41220.79389603033;41292.38061429141;41624.79187604043;34084.488732669524;34253.31493370169;34262.82868585641;35813.46279805753;37485.4377184337;36576;36907.44638830366;37086.44370334393;37101.6289837109;37564.62435375611;33904.3219135611;36222.637773622984;37307.81346093252;39367.40948885826;40224.798876005436;30462;31339.903103392186;31923.521147182346;31929.6807031936;31972.20069498281;23634.17280395178;24169.879150604134;24987.625185622594;25011.749882500942;25179.866905989642 11:56:24 INFO - PROCESS | 2978 | |2;jquery.html;348.64786565568767;349.9047979823153;353.86022521104167;356.1914454188991;358.53211558915604;16464.259108340124;16777.66444671106;17074.402395916146;17397.652046959054;17475.825241747578;16139.83860161401;16171.35314587418;16258.593535161626;16350.182490875439;16393;5150.871228219287;5202.4537423570355;5347.572194224472;5359.276497672823;5362.624616276862;5365.382980957201;5408.972955135238;5416.1063424534905;5435.266239057716;5437.13005919053;5160.509751573594;5384.461553844623;5386.272853164832;5389.51494365507;5401.4328495508;5363.544098751572;5365.222042803791;5392.460753924615;5401.594880383967;5409.702466364349;4603.8158473661015;4693.929591056137;4751.501092385319;4776.689515181502;4780.952190478086;20455.386338409724;20580.86805225712;20587.176512939466;20760.792392076037;20761.896190519103;2190.9890450547646;2247.0562363807076;2293.7018187635667;2822.181567345488;2925.917410558086;12462.252264864046;12934.44391179292;12952.676183095498;13043.282619455926;13068.215907045513;1818.5453636590853;1825.3884948542254;1884.4703103745587;1894.8294653481114;1932.7390802241798;53691.731541342044;57437;60870;61857.38142618561;62150;9460.739824668153;9652.9034709652;9677.612895484242;9800.11798938099;9943.204543636492;12703.809442858364;12835.743285134431;12838.422270997828;12875.871241287654;12904.80642790359;7423.1092268927;7476.738314158978;7520.360769334558;7605.467617266849;7617.047869016373;7397.149327827261;7398.371138453184;7410.814729631802;7490.550566966;7543.585102819397;5831.125331200354;5912.320083190402;5931.7627294907725;5951.9702401488585;5966.3294277602345;1753;1759.2786957347425;1794.6590147871862;1804.6029873427824;1814.5191524246086;864.762190397633;941.3739862991171;943.8489841625444;1015.7592053177952;1033.395463653756;16206.837931620768;16428.75356869648;16589.66820663604;16761.07814070238;16762.83237167637;928.3362395886974;940.9012053734259;953.4184147669915;955.044955044955;963.8457846744487;9590.280728945358;9822.557984890696;9823.459709716035;9959.502024898726;9999.50002499872;414610;416282;417442;418560;429937;50952;63324.366756331845;63434;64020;64811.351886481476;1031.2214278219897;1042.1870940666292;1042.7966546523355;1055.7067592199649;1056.0917610854658;14589.854101459274;15042.473513427416;15090.849091508944;15139.243037848284;15261.542153735405;31097.8445107773;31432.84283578659;33402.49896251607;33453.49819752657;34896.65103348934;39304.41043384409;41682.79158604187;42068.579314206465;42467;42516.51192208258;7846.293833555007;7868.527888326718;7873.724419645514;8090.52784667655;8141.9185808141165;9234.584443699916;11356.432178391213;11795.469203885674;11862;12044.21712588679;9891.35706179096;10056.798864022825;10485.475726213812;10659.09397701204;10810.08114310261;10273.84589231177;10377.273590848568;10461.372317660966;10665.680029599125;10841.945790270998;10590.205734570092;10703.839442408214;10776.191785615953;10989.560417583207;11146.665600032013;7584.886226706493;7722.227777222233;7817.296443320129;7907.723229686933;7984.321332686786;10614.946925265323;10806.945965270123;10907.509162087883;10960.56157753681;10994.890051099706 11:56:24 INFO - PROCESS | 2978 | |3;mootools.html;1501.8197816262048;1508.8943773935825;1702.7786387769588;1810.7012342963412;1841.2911029253733;6836.7607133750325;6929.307069293068;7587.35507481864;7815.257550532698;7849.686012559498;6857.657117144147;7366.300201480851;7406.59263740494;7525.247475252486;7553.735619253313;2243.3157886844506;2263.0608297556496;2265.8753768542806;2278.4759505313705;2281.783230593091;2212.1483228956886;2236.1614394602025;2266.8186545076437;2268.5576312619046;2277.772222777717;2100.789921007902;2257.2325409360815;2267.4784799496124;2273.874936878471;2288.965665515019;2255.8082562982167;2260.4009937366695;2270.262164796448;2280.726312842453;2280.771922807706;2260.1411463643876;2270.819174029512;2271.704678391815;2272;2274.65880117982;7628.427867909929;7654.69870122075;7681.308682218627;7712.730054448068;7740.071191457061;4715.575598196145;4821.566059054667;4829.251466022772;4842.467328593887;4860.149473842063;2972.9405411891858;3065.9080227592985;3167.7149056584785;3185.3310804730804;3190.0748782852943;961.4135377419768;961.4615815143472;985.5811280205955;989.1443901025561;992.0327680511443;10930.125589952784;10932.781344373068;10941;10950.06924411418;10953.288036277616;4296.634786043159;4310.28880234764;4327.956720432755;4350.934735978963;4400.867973960786;9215.90784092164;9241.399309044891;9298.37278476264;9299.302552308603;9328.533573321307;4716.646251531149;4736.834210802605;4780.211265141213;4782.378290822171;4787.329773831666;4154;4263.936040959388;4278.55075217104;4288.506821715543;4343.370211319341;3429.331280400298;3489.180042689966;3493.2140268439907;3533.2933413316923;3581.4806853006166;1037.6264544763878;1042.8748550174028;1049.0034467256137;1049.4123290956936;1057.7778666479971;1293.6442478318538;1295.8250636164187;1320.2804471563022;1322.0150987514364;1326.0584984660807;7195.820104497325;7206.639668016578;7337.33963943237;7403.296686814744;7418.888716669254;488.2773495227013;496.53077841439494;515.5952577226859;521.9947800522023;526.9920951185735;5811.215485909348;5823.213866128019;5834.154047663065;5870.7945221917025;5873.794417195378;9146.496942668084;9661.372010819274;9684.75788105303;9692.079252471003;9796.461194634363;9521.428714277166;9539.47532885684;9553.426794392359;9570.425774453555;9666.806663866684;7264.564126152448;7502.774916752506;7522;7594.392448604099;7609.847803043908;7190.388816950409;7271.200167981412;7334.96332518334;7348;7359.153697324876;8366.414350995372;8500.70247541333;8553.272971797467;8686.218240358397;8714.215720584923;8575.056743758307;8605.870911936201;8638.481691098554;8788.516631585324;8850.911490885266;6618.569792963442;6720.596764194164;6912.896306555305;7043.788686339213;7068.257832927674;7586.696532138652;7655.846883062419;7680.846383072419;7714.652840622298;7727.806804829925;6796.2524122347495;6808.046873437624;6954.061201737701;6986.825329366603;7161.2122666507685;6878.209005964378;6964.26875178099;6991.161060672752;7024.578525288499;7083.5041547091205;6889.724411023503;6998.650067496503;7034.753783617549;7175.641217939186;7205.963970180115;6423.229212494531;6436.356364363526;6447.968325067966;6481.157449531531;6492.31830657793;6301.495880329654;6335.208098987627;6353.841153971188;6376.968115159394;6415.839604009937 11:56:24 INFO - PROCESS | 2978 | |4;prototype.html;327.8819624935024;329.9589794199302;339.4924587741326;339.65864306372094;340.85343302379965;6168.29064657564;6259.4679452246555;6298.464630506401;6314.336994615568;6318.368163183679;6157.81526554203;6180.660063696495;6186.350433204516;6193.969030154843;6197.907031394533;4506.346579745935;4623.86128416148;4726.692764970283;4746.620270378361;4788.856334309976;4735.786889589959;4747.691400058985;4748.90502189956;4756.215224487955;4787.593054590364;4704.200285951397;4707.340972263886;4707.90584188316;4708.882277943045;4715.41057367829;4728.2198437257985;4728.952710472903;4736.431628204603;4741.454732705749;4751.382320298374;4168.291390463629;4169.207850508424;4169.791510424467;4174.352975288835;4176.310908700061;5744.540436765091;5809.651420914759;5916.0238560637445;5931.73307201177;5945.435183657545;5488.890222195534;5503.972480137613;5514.476124768141;5515.448455154493;5517;6542.084108224853;6554.410103090697;6555.6394398308075;6555.967220163916;6561.671916404161;4557.612602928755;4600.953990460086;4601.861944141681;4607.654425918036;4611.262198048296;6873.450123990069;6883.242843287185;6887.276835932255;6888.104546408985;6890.7941110306;4361.193179261783;4493.752843593634;4721.291806229093;4725.834595789131;4730.881727956828;4522.253828118323;4554.476235232924;4555.134524440346;4566.634669226454;4567.040921406476;5325.733713314319;5333.359996800409;5344.038073146871;5350.5184533392185;5378.19327100938;6575.50683698715;6583.242927063353;6590.143281373391;6595.406413422815;6608.603483790988;1602.3110062673163;1604.2219523531078;1607.9919600402156;1618.6519898221939;1625.7154997875325;993.6323560282742;1012.2256473797551;1027.7225149209671;1037.1339931157418;1056.8837427882927;6333.240011198685;6342.619442833445;6359.268684101387;6362.1093046973465;6373.6175829450385;6754.696038678271;6812.795616131425;6815.318468153145;6827.52207345481;6841.486888483384;6237.906431403532;6415;6441.452476539546;6450.935490645127;6461.224653041665;3692.9261414771554;3698.7780733156096;3713.9814300928324;3721.981390093032;3725.3294407006997;7301.780946571611;7302.087239095114;7311.305425984523;7316.853662926712;7321.341079302888;7018.719251229996;7050.541714788523;7053.964730176419;7064.611446370499;7081.752138675121;7102.964485177645;7303.30618591233;7412.666430010662;7418.666160022812;7424.443166762514;6842.281560436082;6848.9657551711925;6871.828204294932;6875.209350924708;6893.482988775761;6757.00668302842;6790.8641827164165;6795.218549866829;6805.795826125224;6810.455163586802;7272.636368181464;7323.926760732537;7325.340719335072;7325.377342925698;7327.8534429312185;4417.469903611587;4562.041971185955;4576.565226303496;4580.541945805393;4586.541345865387;6864.519483636297;6882.070920425878;6886.276940921131;6895.931040689529;6896.965515172392;6633.9336606633315;6654.700538475877;6664.500162487736;6670.099536562502;6677.966610166918;6629.337066293332;6669.433098186709;6688.398044176048;6688.699008544724;6695.06269122333;6368.936310636835;6527.608343499405;6587.242467116343;6597.208334999831;6601.471882249504;6696.1629796275465;6704.195496540447;6721.193456785217;6737.66311684404;6748.561343512656;6562.081308616702;6577.309382514958;6579.111819904251;6580.341965803573;6591.571547849375 11:56:24 INFO - PROCESS | 2978 | |5;yui.html;682.7337338438007;689.5483458334793;736.4108713029576;832.1595188859254;844.7676888855564;15297.388104475822;15689.607759806011;15711.607209819746;15787.447439339625;15826.28781704823;14820.555383338517;14865.628359291024;14955.252237388142;14981.625459363522;14986.475473358434;838.9622466988985;841.1672444280149;859.0850743957665;859.1751918158575;860.9354298427612;856.4989481153501;860.7331727164568;864.9005364383082;865.398548009134;867.9479231246114;885.4156256870467;888.6667499687617;891.3359547137392;896.6771962093674;899.1278459893892;889.9644014239423;890.875277461156;891.2468963725642;891.4027601507006;891.6433426629368;664.1565212180503;664.9035889796;665.1386454541332;665.3180489997791;665.5574043261225;14157.150570965672;14201.289935503184;14287.928560357235;14311;14346.784798228035;12695.365231738377;12793.232406055666;12830.486780528767;12922.095453318272;13073.346332683328;10288.588456461732;10552.736181595445;10568.735781605521;10769.192310576738;10843.51204195813;4276.5295817460055;4308.569143085698;4370.431843860278;4497.280435130396;4501.617362524189;49909;50010.9997800042;50200.24299149512;50341.496585034416;50596.241056384184;9670.806583868283;10128.162865733742;10589.57641694339;10599.62901298451;10609.098226650667;18196.09019549017;18311.450656480327;18444.07779611014;18450.815491845176;18489;7836.960815196002;7895.644695988694;7938;8176.7955801105445;8248.381371397169;4311.568843115726;4382.364557139197;4442.755648439303;4464.374987501752;4618.792154353062;3112.0041586692496;3137.51368537877;3162.130414136085;3169.6196456425378;3180.9522857157162;556.774506324939;560.7869009776259;562.1202817590458;565.2058857305492;584.8800995795851;686.6395142550201;689.7206631314326;704.8968364509526;710.7313494974277;713.6717110129399;7745.225477452323;7781.338586220121;7834;8008.27925486709;8037.638306276114;652.1391762873056;668.9197296324375;671.9685283090432;674.8852695041854;677.4072686399401;3717.4795528626014;3775.2072064866684;3809.238152369537;3824.0631045394057;3970.980145099256;53458.73270633622;53807.46192538103;54116.188257176174;54355.72822135864;54608.453915461134;46422.07155856864;46860;46994;47214;47273;42545.36181957273;43284.350734739004;43429;43603.781981089895;43748.15636983586;7231.2768723129375;7274.709011639475;7325.670344834602;7348.595827229554;7426.331630153312;32967.83516082404;33003.66996330102;33230.66769332276;33353.332933341684;33969.32061358709;39058.414123787596;40269;41098.794506027276;41711.58288417077;42128.3680744783;9600.375975561567;9837.508124593598;9848.655297064568;9873.308868379145;10105.848412273675;10910.072643825364;11123.110151187724;11144.777104457704;11179.72050698739;11887.940560297144;9806.411615303105;9839.901600983898;9980.451075190935;10063.446510441996;10193.43936083493;10615.150787936793;10621.468926553796;10933.507992140532;11005.559777608805;11009.504572294427;9828.803423931338;10014.799704006025;10082.546285417027;10119.7470063249;10473.790524189626;8892.86660700103;9217.76955576116;9234.676786312446;9361.531923403938;9395.859062113937;8542.914570854213;8763.167499087576;8854.822903542023;9003.189712925869;9162.129597688208 11:56:24 INFO - PROCESS | 2978 | __end_tp_report 11:56:24 INFO - PROCESS | 2978 | __start_cc_report 11:56:24 INFO - PROCESS | 2978 | _x_x_mozilla_cycle_collect,331 11:56:24 INFO - PROCESS | 2978 | __end_cc_report 11:56:24 INFO - PROCESS | 2978 | __startTimestamp1456775784264__endTimestamp 11:56:24 INFO - PROCESS | 2978 | 11:56:24 INFO - PROCESS | 2978 | ------- Summary: start ------- 11:56:24 INFO - PROCESS | 2978 | Number of tests: 6 11:56:24 INFO - PROCESS | 2978 | 11:56:24 INFO - PROCESS | 2978 | [#0] dojo.html Cycles:165 Average:5273.26 Median:5459.95 stddev:589.64 (10.8%) stddev-sans-first:567.53 11:56:24 INFO - PROCESS | 2978 | Values: 3154.1 3192.9 3202.7 3228.5 3242.1 5213.7 5237.6 5249.8 5256.8 5273.1 5150.5 5273.2 5306.0 5330.6 5337.8 4811.6 4839.7 4864.3 4958.4 4973.4 4823.3 4893.8 4895.2 4898.3 4943.0 4818.6 4833.3 4835.7 4866.2 4907.6 4837.1 4866.7 4866.9 4890.8 4923.0 4765.9 4841.5 4847.9 4884.6 4885.0 5028.0 5067.2 5118.6 5144.2 5146.4 5616.7 5622.6 5639.1 5675.5 5688.1 5624.6 5695.5 5699.9 5751.3 5762.2 5301.3 5328.6 5334.8 5339.9 5344.8 5718.1 5767.3 5767.5 5780.1 5831.6 5530.5 5622.2 5634.7 5641.2 5684.4 5617.4 5718.2 5730.8 5756.9 5761.9 5576.2 5701.8 5706.0 5708.3 5740.4 5659.2 5663.8 5711.1 5716.6 5768.2 4235.6 4244.9 4255.0 4259.0 4287.6 3834.8 3853.6 3869.3 3874.4 3906.0 5360.2 5361.8 5378.8 5382.3 5420.1 5666.4 5670.9 5673.3 5678.6 5683.9 5216.1 5390.5 5400.6 5433.9 5438.9 4766.1 4778.0 4784.7 4787.7 4824.0 5838.1 5868.5 5868.7 5901.3 5907.0 5532.5 5580.9 5641.1 5669.1 5726.7 5886.7 5935.5 5970.9 5971.8 5986.3 5533.0 5602.3 5603.1 5615.5 5643.2 5577.2 5736.1 5752.6 5760.6 5812.4 5537.6 5539.0 5547.4 5587.9 5611.4 5459.9 5463.9 5488.3 5525.2 5532.7 5417.6 5439.3 5448.5 5454.4 5477.6 5456.9 5521.4 5529.3 5536.0 5539.6 5419.4 5454.1 5503.4 5545.3 5549.1 11:56:24 INFO - PROCESS | 2978 | 11:56:24 INFO - PROCESS | 2978 | [#1] ext.html Cycles:180 Average:43285.34 Median:36996.95 stddev:69561.05 (188.0%) stddev-sans-first:69681.93 11:56:24 INFO - PROCESS | 2978 | Values: 478.9 515.8 525.5 534.1 551.5 35635.3 35656.0 36004.5 36048.3 36201.5 39387.0 39565.6 39770.6 40024.0 40036.8 8477.9 8654.0 8685.8 8706.3 8745.0 8432.3 8594.2 8613.4 8629.0 8653.7 8829.5 8836.2 8876.9 8878.6 8916.7 8756.3 8767.7 8790.8 8809.7 8811.5 8681.4 8779.0 8782.3 8789.0 8844.0 40098.4 40403.6 40678.0 40707.2 40718.4 2815.5 3220.7 3306.6 3309.7 3400.4 26476.9 26745.3 26804.6 27580.3 27913.0 3714.8 3752.2 3797.5 3845.5 3880.4 219265.8 220233.0 220654.0 221000.0 221047.0 41738.8 56498.0 62888.4 62942.7 63080.0 40477.4 40729.0 40969.4 41023.8 41288.8 12869.4 12869.5 13000.7 13024.5 13050.2 11009.8 11053.2 11086.8 11103.2 11117.2 14113.2 14138.6 14354.2 14423.9 14546.0 5783.8 5897.6 5905.9 5913.4 5914.5 918.8 958.6 969.3 1057.6 1089.0 27443.7 27680.0 27686.5 27898.9 28100.6 1100.0 1105.2 1109.0 1120.7 1135.3 14914.0 14921.4 14970.3 14971.5 15070.3 291880.0 293808.0 294537.0 296695.0 298128.0 54024.5 54702.5 54709.0 54768.0 55069.4 1264.9 1272.2 1280.9 1282.3 1291.8 27727.0 28819.6 28819.7 28859.4 28877.7 48323.5 48617.0 48726.6 48904.3 48953.5 274989.0 277848.0 278686.0 279567.0 280991.0 32352.4 44333.6 44801.1 45135.3 45224.3 40306.2 41196.6 41220.8 41292.4 41624.8 34084.5 34253.3 34262.8 35813.5 37485.4 36576.0 36907.4 37086.4 37101.6 37564.6 33904.3 36222.6 37307.8 39367.4 40224.8 30462.0 31339.9 31923.5 31929.7 31972.2 23634.2 24169.9 24987.6 25011.7 25179.9 11:56:24 INFO - PROCESS | 2978 | 11:56:24 INFO - PROCESS | 2978 | [#2] jquery.html Cycles:180 Average:24201.33 Median:226957.21 stddev:68490.59 (30.2%) stddev-sans-first:68659.31 11:56:24 INFO - PROCESS | 2978 | Values: 348.6 349.9 353.9 356.2 358.5 16464.3 16777.7 17074.4 17397.7 17475.8 16139.8 16171.4 16258.6 16350.2 16393.0 5150.9 5202.5 5347.6 5359.3 5362.6 5365.4 5409.0 5416.1 5435.3 5437.1 5160.5 5384.5 5386.3 5389.5 5401.4 5363.5 5365.2 5392.5 5401.6 5409.7 4603.8 4693.9 4751.5 4776.7 4781.0 20455.4 20580.9 20587.2 20760.8 20761.9 2191.0 2247.1 2293.7 2822.2 2925.9 12462.3 12934.4 12952.7 13043.3 13068.2 1818.5 1825.4 1884.5 1894.8 1932.7 53691.7 57437.0 60870.0 61857.4 62150.0 9460.7 9652.9 9677.6 9800.1 9943.2 12703.8 12835.7 12838.4 12875.9 12904.8 7423.1 7476.7 7520.4 7605.5 7617.0 7397.1 7398.4 7410.8 7490.6 7543.6 5831.1 5912.3 5931.8 5952.0 5966.3 1753.0 1759.3 1794.7 1804.6 1814.5 864.8 941.4 943.8 1015.8 1033.4 16206.8 16428.8 16589.7 16761.1 16762.8 928.3 940.9 953.4 955.0 963.8 9590.3 9822.6 9823.5 9959.5 9999.5 414610.0 416282.0 417442.0 418560.0 429937.0 50952.0 63324.4 63434.0 64020.0 64811.4 1031.2 1042.2 1042.8 1055.7 1056.1 14589.9 15042.5 15090.8 15139.2 15261.5 31097.8 31432.8 33402.5 33453.5 34896.7 39304.4 41682.8 42068.6 42467.0 42516.5 7846.3 7868.5 7873.7 8090.5 8141.9 9234.6 11356.4 11795.5 11862.0 12044.2 9891.4 10056.8 10485.5 10659.1 10810.1 10273.8 10377.3 10461.4 10665.7 10841.9 10590.2 10703.8 10776.2 10989.6 11146.7 7584.9 7722.2 7817.3 7907.7 7984.3 10614.9 10806.9 10907.5 10960.6 10994.9 11:56:24 INFO - PROCESS | 2978 | 11:56:24 INFO - PROCESS | 2978 | [#3] mootools.html Cycles:180 Average:5471.90 Median:6429.79 stddev:2885.60 (44.9%) stddev-sans-first:2878.27 11:56:24 INFO - PROCESS | 2978 | Values: 1501.8 1508.9 1702.8 1810.7 1841.3 6836.8 6929.3 7587.4 7815.3 7849.7 6857.7 7366.3 7406.6 7525.2 7553.7 2243.3 2263.1 2265.9 2278.5 2281.8 2212.1 2236.2 2266.8 2268.6 2277.8 2100.8 2257.2 2267.5 2273.9 2289.0 2255.8 2260.4 2270.3 2280.7 2280.8 2260.1 2270.8 2271.7 2272.0 2274.7 7628.4 7654.7 7681.3 7712.7 7740.1 4715.6 4821.6 4829.3 4842.5 4860.1 2972.9 3065.9 3167.7 3185.3 3190.1 961.4 961.5 985.6 989.1 992.0 10930.1 10932.8 10941.0 10950.1 10953.3 4296.6 4310.3 4328.0 4350.9 4400.9 9215.9 9241.4 9298.4 9299.3 9328.5 4716.6 4736.8 4780.2 4782.4 4787.3 4154.0 4263.9 4278.6 4288.5 4343.4 3429.3 3489.2 3493.2 3533.3 3581.5 1037.6 1042.9 1049.0 1049.4 1057.8 1293.6 1295.8 1320.3 1322.0 1326.1 7195.8 7206.6 7337.3 7403.3 7418.9 488.3 496.5 515.6 522.0 527.0 5811.2 5823.2 5834.2 5870.8 5873.8 9146.5 9661.4 9684.8 9692.1 9796.5 9521.4 9539.5 9553.4 9570.4 9666.8 7264.6 7502.8 7522.0 7594.4 7609.8 7190.4 7271.2 7335.0 7348.0 7359.2 8366.4 8500.7 8553.3 8686.2 8714.2 8575.1 8605.9 8638.5 8788.5 8850.9 6618.6 6720.6 6912.9 7043.8 7068.3 7586.7 7655.8 7680.8 7714.7 7727.8 6796.3 6808.0 6954.1 6986.8 7161.2 6878.2 6964.3 6991.2 7024.6 7083.5 6889.7 6998.7 7034.8 7175.6 7206.0 6423.2 6436.4 6448.0 6481.2 6492.3 6301.5 6335.2 6353.8 6377.0 6415.8 11:56:24 INFO - PROCESS | 2978 | 11:56:24 INFO - PROCESS | 2978 | [#4] prototype.html Cycles:180 Average:5542.63 Median:6337.93 stddev:1717.56 (27.1%) stddev-sans-first:1677.18 11:56:24 INFO - PROCESS | 2978 | Values: 327.9 330.0 339.5 339.7 340.9 6168.3 6259.5 6298.5 6314.3 6318.4 6157.8 6180.7 6186.4 6194.0 6197.9 4506.3 4623.9 4726.7 4746.6 4788.9 4735.8 4747.7 4748.9 4756.2 4787.6 4704.2 4707.3 4707.9 4708.9 4715.4 4728.2 4729.0 4736.4 4741.5 4751.4 4168.3 4169.2 4169.8 4174.4 4176.3 5744.5 5809.7 5916.0 5931.7 5945.4 5488.9 5504.0 5514.5 5515.4 5517.0 6542.1 6554.4 6555.6 6556.0 6561.7 4557.6 4601.0 4601.9 4607.7 4611.3 6873.5 6883.2 6887.3 6888.1 6890.8 4361.2 4493.8 4721.3 4725.8 4730.9 4522.3 4554.5 4555.1 4566.6 4567.0 5325.7 5333.4 5344.0 5350.5 5378.2 6575.5 6583.2 6590.1 6595.4 6608.6 1602.3 1604.2 1608.0 1618.7 1625.7 993.6 1012.2 1027.7 1037.1 1056.9 6333.2 6342.6 6359.3 6362.1 6373.6 6754.7 6812.8 6815.3 6827.5 6841.5 6237.9 6415.0 6441.5 6450.9 6461.2 3692.9 3698.8 3714.0 3722.0 3725.3 7301.8 7302.1 7311.3 7316.9 7321.3 7018.7 7050.5 7054.0 7064.6 7081.8 7103.0 7303.3 7412.7 7418.7 7424.4 6842.3 6849.0 6871.8 6875.2 6893.5 6757.0 6790.9 6795.2 6805.8 6810.5 7272.6 7323.9 7325.3 7325.4 7327.9 4417.5 4562.0 4576.6 4580.5 4586.5 6864.5 6882.1 6886.3 6895.9 6897.0 6633.9 6654.7 6664.5 6670.1 6678.0 6629.3 6669.4 6688.4 6688.7 6695.1 6368.9 6527.6 6587.2 6597.2 6601.5 6696.2 6704.2 6721.2 6737.7 6748.6 6562.1 6577.3 6579.1 6580.3 6591.6 11:56:24 INFO - PROCESS | 2978 | 11:56:24 INFO - PROCESS | 2978 | [#5] yui.html Cycles:180 Average:13380.97 Median:48591.00 stddev:15143.29 (31.2%) stddev-sans-first:15155.74 11:56:24 INFO - PROCESS | 2978 | Values: 682.7 689.5 736.4 832.2 844.8 15297.4 15689.6 15711.6 15787.4 15826.3 14820.6 14865.6 14955.3 14981.6 14986.5 839.0 841.2 859.1 859.2 860.9 856.5 860.7 864.9 865.4 867.9 885.4 888.7 891.3 896.7 899.1 890.0 890.9 891.2 891.4 891.6 664.2 664.9 665.1 665.3 665.6 14157.2 14201.3 14287.9 14311.0 14346.8 12695.4 12793.2 12830.5 12922.1 13073.3 10288.6 10552.7 10568.7 10769.2 10843.5 4276.5 4308.6 4370.4 4497.3 4501.6 49909.0 50011.0 50200.2 50341.5 50596.2 9670.8 10128.2 10589.6 10599.6 10609.1 18196.1 18311.5 18444.1 18450.8 18489.0 7837.0 7895.6 7938.0 8176.8 8248.4 4311.6 4382.4 4442.8 4464.4 4618.8 3112.0 3137.5 3162.1 3169.6 3181.0 556.8 560.8 562.1 565.2 584.9 686.6 689.7 704.9 710.7 713.7 7745.2 7781.3 7834.0 8008.3 8037.6 652.1 668.9 672.0 674.9 677.4 3717.5 3775.2 3809.2 3824.1 3971.0 53458.7 53807.5 54116.2 54355.7 54608.5 46422.1 46860.0 46994.0 47214.0 47273.0 42545.4 43284.4 43429.0 43603.8 43748.2 7231.3 7274.7 7325.7 7348.6 7426.3 32967.8 33003.7 33230.7 33353.3 33969.3 39058.4 40269.0 41098.8 41711.6 42128.4 9600.4 9837.5 9848.7 9873.3 10105.8 10910.1 11123.1 11144.8 11179.7 11887.9 9806.4 9839.9 9980.5 10063.4 10193.4 10615.2 10621.5 10933.5 11005.6 11009.5 9828.8 10014.8 10082.5 10119.7 10473.8 8892.9 9217.8 9234.7 9361.5 9395.9 8542.9 8763.2 8854.8 9003.2 9162.1 11:56:24 INFO - PROCESS | 2978 | -------- Summary: end -------- 11:56:24 INFO - PROCESS | 2978 | 11:56:24 INFO - PROCESS | 2978 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:24 INFO - PROCESS | 2978 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:24 INFO - PROCESS | 2978 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:24 INFO - PROCESS | 2978 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:24 INFO - PROCESS | 2978 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:24 INFO - PROCESS | 2978 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:24 INFO - PROCESS | 2978 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:24 INFO - PROCESS | 2978 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:24 INFO - PROCESS | 2978 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:24 INFO - TEST-INFO | 2978: exit 0 11:56:24 INFO - TEST-OK | dromaeo_css | took 1110633ms 11:56:24 INFO - TEST-START | kraken 11:56:24 INFO - operating with platform_type : linux_ 11:56:24 INFO - Initialising browser for kraken test... 11:56:24 INFO - TEST-INFO | started process 3221 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4ssT4k/profile http://localhost:41709/getInfo.html) 11:56:28 INFO - PROCESS | 3221 | 11:56:28 INFO - PROCESS | 3221 | (process:3292): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:56:29 INFO - PROCESS | 3221 | __metrics Screen width/height:1600/1200 11:56:29 INFO - PROCESS | 3221 | colorDepth:24 11:56:29 INFO - PROCESS | 3221 | Browser inner width/height: 1024/697 11:56:29 INFO - PROCESS | 3221 | __metrics 11:56:29 ERROR - PROCESS | 3221 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 11:56:29 INFO - PROCESS | 3221 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:29 INFO - PROCESS | 3221 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:29 INFO - PROCESS | 3221 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:29 INFO - PROCESS | 3221 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:29 INFO - PROCESS | 3221 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:29 INFO - PROCESS | 3221 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:29 INFO - PROCESS | 3221 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:29 INFO - PROCESS | 3221 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:29 INFO - PROCESS | 3221 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:56:30 INFO - TEST-INFO | 3221: exit 0 11:56:30 INFO - Browser initialized. 11:56:30 INFO - Running cycle 1/1 for kraken test... 11:56:30 INFO - TEST-INFO | started process 3343 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4ssT4k/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:31 INFO - PROCESS | 3343 | 11:56:31 INFO - PROCESS | 3343 | (process:3401): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:56:42 INFO - PROCESS | 3343 | RSS: Main: 160714752 11:56:42 INFO - PROCESS | 3343 | 11:56:44 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41709/tests/kraken/driver.html?testName=audio-beat-detection) 11:56:45 INFO - PROCESS | 3343 | RSS: Main: 168001536 11:56:45 INFO - PROCESS | 3343 | 11:56:48 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41709/tests/kraken/driver.html?testName=audio-dft) 11:56:48 INFO - PROCESS | 3343 | RSS: Main: 171659264 11:56:48 INFO - PROCESS | 3343 | 11:56:51 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41709/tests/kraken/driver.html?testName=audio-fft) 11:56:52 INFO - PROCESS | 3343 | RSS: Main: 165167104 11:56:52 INFO - PROCESS | 3343 | 11:56:54 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41709/tests/kraken/driver.html?testName=audio-oscillator) 11:56:54 INFO - PROCESS | 3343 | RSS: Main: 165453824 11:56:54 INFO - PROCESS | 3343 | 11:56:57 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41709/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:56:57 INFO - PROCESS | 3343 | RSS: Main: 165404672 11:56:57 INFO - PROCESS | 3343 | 11:57:00 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41709/tests/kraken/driver.html?testName=imaging-darkroom) 11:57:01 INFO - PROCESS | 3343 | RSS: Main: 165502976 11:57:01 INFO - PROCESS | 3343 | 11:57:04 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41709/tests/kraken/driver.html?testName=imaging-desaturate) 11:57:05 INFO - PROCESS | 3343 | RSS: Main: 166027264 11:57:05 INFO - PROCESS | 3343 | 11:57:08 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41709/tests/kraken/driver.html?testName=json-parse-financial) 11:57:08 INFO - PROCESS | 3343 | RSS: Main: 166494208 11:57:08 INFO - PROCESS | 3343 | 11:57:10 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41709/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:57:11 INFO - PROCESS | 3343 | RSS: Main: 166215680 11:57:11 INFO - PROCESS | 3343 | 11:57:12 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41709/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:57:13 INFO - PROCESS | 3343 | RSS: Main: 164765696 11:57:13 INFO - PROCESS | 3343 | 11:57:15 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41709/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:57:16 INFO - PROCESS | 3343 | RSS: Main: 167038976 11:57:16 INFO - PROCESS | 3343 | 11:57:18 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41709/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:57:19 INFO - PROCESS | 3343 | RSS: Main: 165044224 11:57:19 INFO - PROCESS | 3343 | 11:57:21 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41709/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:57:22 INFO - PROCESS | 3343 | RSS: Main: 166793216 11:57:22 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41709/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41709/tests/kraken/driver.html?testName=ai-astar) 11:57:24 INFO - PROCESS | 3343 | RSS: Main: 167096320 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | __start_tp_report 11:57:24 INFO - PROCESS | 3343 | _x_x_mozilla_page_load 11:57:24 INFO - PROCESS | 3343 | _x_x_mozilla_page_load_details 11:57:24 INFO - PROCESS | 3343 | |i|pagename|runs| 11:57:24 INFO - PROCESS | 3343 | |0;ai-astar;115;109;114;112;113;125;114;111;113;113 11:57:24 INFO - PROCESS | 3343 | |1;audio-beat-detection;156;128;156;167;128;155;152;133;173;130 11:57:24 INFO - PROCESS | 3343 | |2;audio-dft;162;163;163;163;162;162;167;172;166;163 11:57:24 INFO - PROCESS | 3343 | |3;audio-fft;77;75;72;75;75;154;74;73;73;74 11:57:24 INFO - PROCESS | 3343 | |4;audio-oscillator;96;96;149;95;96;97;142;96;96;144 11:57:24 INFO - PROCESS | 3343 | |5;imaging-gaussian-blur;120;117;115;117;118;115;115;115;115;115 11:57:24 INFO - PROCESS | 3343 | |6;imaging-darkroom;147;148;146;147;147;145;148;148;148;147 11:57:24 INFO - PROCESS | 3343 | |7;imaging-desaturate;97;96;96;99;96;97;96;96;98;96 11:57:24 INFO - PROCESS | 3343 | |8;json-parse-financial;60;58;58;60;64;56;58;68;56;55 11:57:24 INFO - PROCESS | 3343 | |9;json-stringify-tinderbox;67;68;68;68;70;69;68;67;69;69 11:57:24 INFO - PROCESS | 3343 | |10;stanford-crypto-aes;83;85;85;94;84;85;85;84;94;85 11:57:24 INFO - PROCESS | 3343 | |11;stanford-crypto-ccm;119;123;120;127;123;124;120;135;136;120 11:57:24 INFO - PROCESS | 3343 | |12;stanford-crypto-pbkdf2;143;159;158;159;158;143;159;147;158;145 11:57:24 INFO - PROCESS | 3343 | |13;stanford-crypto-sha256-iterative;73;75;73;73;72;72;71;70;71;69 11:57:24 INFO - PROCESS | 3343 | __end_tp_report 11:57:24 INFO - PROCESS | 3343 | __start_cc_report 11:57:24 INFO - PROCESS | 3343 | _x_x_mozilla_cycle_collect,797 11:57:24 INFO - PROCESS | 3343 | __end_cc_report 11:57:24 INFO - PROCESS | 3343 | __startTimestamp1456775844460__endTimestamp 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | ------- Summary: start ------- 11:57:24 INFO - PROCESS | 3343 | Number of tests: 14 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#0] ai-astar Cycles:10 Average:113.90 Median:113.50 stddev:4.25 (3.7%) stddev-sans-first:4.49 11:57:24 INFO - PROCESS | 3343 | Values: 115.0 109.0 114.0 112.0 113.0 125.0 114.0 111.0 113.0 113.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:155.50 stddev:16.76 (10.8%) stddev-sans-first:17.51 11:57:24 INFO - PROCESS | 3343 | Values: 156.0 128.0 156.0 167.0 128.0 155.0 152.0 133.0 173.0 130.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:3.20 (2.0%) stddev-sans-first:3.28 11:57:24 INFO - PROCESS | 3343 | Values: 162.0 163.0 163.0 163.0 162.0 162.0 167.0 172.0 166.0 163.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#3] audio-fft Cycles:10 Average:82.20 Median:74.50 stddev:25.27 (33.9%) stddev-sans-first:26.73 11:57:24 INFO - PROCESS | 3343 | Values: 77.0 75.0 72.0 75.0 75.0 154.0 74.0 73.0 73.0 74.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:96.00 stddev:23.73 (24.7%) stddev-sans-first:24.57 11:57:24 INFO - PROCESS | 3343 | Values: 96.0 96.0 149.0 95.0 96.0 97.0 142.0 96.0 96.0 144.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.00 stddev:1.75 (1.5%) stddev-sans-first:1.20 11:57:24 INFO - PROCESS | 3343 | Values: 120.0 117.0 115.0 117.0 118.0 115.0 115.0 115.0 115.0 115.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.99 (0.7%) stddev-sans-first:1.05 11:57:24 INFO - PROCESS | 3343 | Values: 147.0 148.0 146.0 147.0 147.0 145.0 148.0 148.0 148.0 147.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.50 stddev:1.06 (1.1%) stddev-sans-first:1.12 11:57:24 INFO - PROCESS | 3343 | Values: 97.0 96.0 96.0 99.0 96.0 97.0 96.0 96.0 98.0 96.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:59.00 stddev:4.00 (6.8%) stddev-sans-first:4.24 11:57:24 INFO - PROCESS | 3343 | Values: 60.0 58.0 58.0 60.0 64.0 56.0 58.0 68.0 56.0 55.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.95 (1.4%) stddev-sans-first:0.88 11:57:24 INFO - PROCESS | 3343 | Values: 67.0 68.0 68.0 68.0 70.0 69.0 68.0 67.0 69.0 69.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.00 stddev:4.06 (4.8%) stddev-sans-first:4.12 11:57:24 INFO - PROCESS | 3343 | Values: 83.0 85.0 85.0 94.0 84.0 85.0 85.0 84.0 94.0 85.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:123.50 stddev:6.18 (5.0%) stddev-sans-first:6.20 11:57:24 INFO - PROCESS | 3343 | Values: 119.0 123.0 120.0 127.0 123.0 124.0 120.0 135.0 136.0 120.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.90 Median:158.00 stddev:7.32 (4.6%) stddev-sans-first:6.84 11:57:24 INFO - PROCESS | 3343 | Values: 143.0 159.0 158.0 159.0 158.0 143.0 159.0 147.0 158.0 145.0 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.50 stddev:1.73 (2.4%) stddev-sans-first:1.79 11:57:24 INFO - PROCESS | 3343 | Values: 73.0 75.0 73.0 73.0 72.0 72.0 71.0 70.0 71.0 69.0 11:57:24 INFO - PROCESS | 3343 | -------- Summary: end -------- 11:57:24 INFO - PROCESS | 3343 | 11:57:24 INFO - PROCESS | 3343 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:57:24 INFO - PROCESS | 3343 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:57:24 INFO - PROCESS | 3343 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:57:24 INFO - PROCESS | 3343 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:57:24 INFO - PROCESS | 3343 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:57:24 INFO - PROCESS | 3343 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:57:24 INFO - PROCESS | 3343 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:57:24 INFO - PROCESS | 3343 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:57:25 INFO - TEST-INFO | 3343: exit 0 11:57:25 INFO - TEST-OK | kraken | took 60436ms 11:57:25 INFO - SUITE-END | took 1171s 11:57:25 INFO - Completed test suite (00:19:31) 11:57:25 INFO - Working with test: dromaeo_css 11:57:25 INFO - Generating results file: dromaeo_css 11:57:25 INFO - Working with test: kraken 11:57:25 INFO - Generating results file: kraken 11:57:25 INFO - javascript benchmark 11:57:25 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:57:25 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:57:25 INFO - process_Request line: dromaeo_css 6883.38 graph.html#tests=[[72,64,43]] 11:57:25 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:57:25 INFO - process_Request line: kraken 1542.40 graph.html#tests=[[232,64,43]] 11:57:25 INFO - RETURN: dromaeo_css: 6883.38 11:57:25 INFO - RETURN: kraken: 1542.40 11:57:25 INFO - javascript benchmark 11:57:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3154.1168472827603, 3192.872285108596, 3202.6797320267992, 3228.5480032795404, 3242.108420184449, 5213.713245771481, 5237.607179461541, 5249.842504724859, 5256.842294731159, 5273.129933560967, 5150.484951504847, 5273.235380869781, 5306.044911915854, 5330.626856120063, 5337.813176538822, 4811.615070794328, 4839.709617422957, 4864.318995340655, 4958.404991401037, 4973.378327709036, 4823.252395878644, 4893.804247830082, 4895.192293271606, 4898.314236006961, 4943.0, 4818.614510839142, 4833.32333473314, 4835.661503694742, 4866.197077482211, 4907.558319751204, 4837.0567739290855, 4866.7079975201605, 4866.878328041792, 4890.779914903838, 4922.950770492285, 4765.880852978703, 4841.491643377465, 4847.854564363075, 4884.5603895649565, 4884.975575122137, 5028.0, 5067.239914012891, 5118.6416950813455, 5144.202648589475, 5146.3824341078935, 5616.663000219959, 5622.550195984311, 5639.097744360924, 5675.51758100562, 5688.089905615123, 5624.550035997151, 5695.515881150107, 5699.857503562444, 5751.281089863767, 5762.164486149527, 5301.257823904656, 5328.573714102862, 5334.786608535654, 5339.866503337409, 5344.759485823147, 5718.085106382959, 5767.336756272998, 5767.509761670221, 5780.104083867007, 5831.591788574844, 5530.5022547970075, 5622.156676498476, 5634.7182640867795, 5641.210230567724, 5684.431556844283, 5617.438256174431, 5718.1708652246025, 5730.828075157752, 5756.913646295226, 5761.9135712964335, 5576.191452239484, 5701.771929122789, 5706.0, 5708.286464191976, 5740.368559458456, 5659.151127330851, 5663.830085097454, 5711.086226203787, 5716.5998380113, 5768.221290125864, 4235.597618226264, 4244.915101697949, 4255.0426154115075, 4258.956555643887, 4287.63555097814, 3834.8082595870096, 3853.6339047790416, 3869.2841824262036, 3874.3994680824517, 3906.0, 5360.249565060894, 5361.812336568201, 5378.811741589026, 5382.30030096085, 5420.13277875538, 5666.394275805676, 5670.858228544319, 5673.319201695823, 5678.574106941914, 5683.886322273532, 5216.087184742655, 5390.51485366319, 5400.567954563626, 5433.945660543423, 5438.945610543923, 4766.118268120409, 4778.0, 4784.665197777775, 4787.712737235777, 4824.0, 5838.065909454467, 5868.530517558585, 5868.706564671749, 5901.262342207224, 5907.0, 5532.5297349724115, 5580.888382232414, 5641.097424412074, 5669.064604340238, 5726.656400615976, 5886.705664716833, 5935.465808077293, 5970.880582388241, 5971.790987315423, 5986.311574169026, 5532.97639936613, 5602.299712535933, 5603.131514615241, 5615.494605485526, 5643.209950606836, 5577.163425486209, 5736.110902810071, 5752.597318187854, 5760.567957403127, 5812.447817457335, 5537.584681149011, 5539.0, 5547.362053363753, 5587.888242235052, 5611.438856114356, 5459.945400545944, 5463.945360546344, 5488.341399032141, 5525.198846167203, 5532.723363831712, 5417.5665946723375, 5439.292891924025, 5448.509634132947, 5454.372747134131, 5477.561795056466, 5456.890862182655, 5521.4478552144465, 5529.253550770594, 5536.0, 5539.556835453073, 5419.403865574863, 5454.072807622634, 5503.449655034625, 5545.306836645419, 5549.056660367828], "unit": "score", "name": "dojo.html", "value": 5234.788872065265}, {"lowerIsBetter": false, "replicates": [478.90900728861493, 515.8239214590734, 525.5480286953219, 534.1240365800088, 551.5284431810802, 35635.287294254165, 35655.99999999997, 36004.459933101025, 36048.2790344193, 36201.45697814532, 39387.0, 39565.63692086169, 39770.60229397705, 40024.0, 40036.79981600095, 8477.872831907527, 8653.95673021634, 8685.826283474327, 8706.259967902735, 8745.038045814956, 8432.325413966868, 8594.226519613234, 8613.397062205648, 8629.0, 8653.69712060078, 8829.514376709278, 8836.248918841875, 8876.911230887705, 8878.60046297915, 8916.73249802507, 8756.255718263923, 8767.693130740425, 8790.824183516326, 8809.691660791905, 8811.471311721318, 8681.392302538825, 8778.956105219497, 8782.297416206751, 8789.0, 8844.0, 40098.39852402217, 40403.59596404057, 40677.98305042368, 40707.18585628271, 40718.38922416166, 2815.5469745262462, 3220.7454781652705, 3306.6197387300526, 3309.652486488908, 3400.4049291373913, 26476.8676156618, 26745.331366715793, 26804.59793103105, 27580.310492237655, 27913.0, 3714.814259287025, 3752.2307926875196, 3797.487339209199, 3845.5404489454245, 3880.3597406427907, 219265.84404935755, 220233.0, 220653.9999999984, 221000.0, 221047.0, 41738.79130604328, 56498.0, 62888.37111628916, 62942.68528657327, 63080.0, 40477.39283910744, 40729.0, 40969.38545921814, 41023.7948810254, 41288.793556032026, 12869.4208760606, 12869.485220591072, 13000.67498312531, 13024.54414095502, 13050.216986980811, 11009.779804404026, 11053.17101217412, 11086.778264434666, 11103.222774405715, 11117.166212534092, 14113.153210807179, 14138.57584272453, 14354.210518421587, 14423.92788036053, 14546.0, 5783.826485205451, 5897.64614123154, 5905.911411328833, 5913.408659134052, 5914.526837852962, 918.7519369770125, 958.5734348214977, 969.3021024862088, 1057.5769692123213, 1088.9945550272198, 27443.725562744516, 27680.0, 27686.537761397292, 27898.860505697343, 28100.578491322645, 1099.9890001099886, 1105.1766434006556, 1108.955641774336, 1120.6581992492206, 1135.3244819332483, 14914.0, 14921.40314387434, 14970.27696800245, 14971.475998340224, 15070.321835517429, 291880.0, 293808.0, 294537.0, 296695.0, 298128.0, 54024.45975540273, 54702.45297547053, 54709.0, 54768.0, 55069.44930550723, 1264.9177803442747, 1272.1603741530546, 1280.884720375152, 1282.2691066092239, 1291.7739395605731, 27727.0, 28819.56770648484, 28819.711802882543, 28859.42281154323, 28877.71122288834, 48323.516764831904, 48617.0, 48726.64006959161, 48904.26643600278, 48953.5104648949, 274989.0, 277848.0, 278686.0, 279567.0, 280991.0, 32352.35295294128, 44333.556664432945, 44801.10397791961, 45135.32297015482, 45224.32163517616, 40306.193876121724, 41196.588034119275, 41220.79389603033, 41292.38061429141, 41624.79187604043, 34084.488732669524, 34253.31493370169, 34262.82868585641, 35813.46279805753, 37485.4377184337, 36576.0, 36907.44638830366, 37086.44370334393, 37101.6289837109, 37564.62435375611, 33904.3219135611, 36222.637773622984, 37307.81346093252, 39367.40948885826, 40224.798876005436, 30462.0, 31339.903103392186, 31923.521147182346, 31929.6807031936, 31972.20069498281, 23634.17280395178, 24169.879150604134, 24987.625185622594, 25011.749882500942, 25179.866905989642], "unit": "score", "name": "ext.html", "value": 17657.681720616187}, {"lowerIsBetter": false, "replicates": [348.64786565568767, 349.9047979823153, 353.86022521104167, 356.1914454188991, 358.53211558915604, 16464.259108340124, 16777.66444671106, 17074.402395916146, 17397.652046959054, 17475.825241747578, 16139.83860161401, 16171.35314587418, 16258.593535161626, 16350.182490875439, 16393.0, 5150.871228219287, 5202.4537423570355, 5347.572194224472, 5359.276497672823, 5362.624616276862, 5365.382980957201, 5408.972955135238, 5416.1063424534905, 5435.266239057716, 5437.13005919053, 5160.509751573594, 5384.461553844623, 5386.272853164832, 5389.51494365507, 5401.4328495508, 5363.544098751572, 5365.222042803791, 5392.460753924615, 5401.594880383967, 5409.702466364349, 4603.8158473661015, 4693.929591056137, 4751.501092385319, 4776.689515181502, 4780.952190478086, 20455.386338409724, 20580.86805225712, 20587.176512939466, 20760.792392076037, 20761.896190519103, 2190.9890450547646, 2247.0562363807076, 2293.7018187635667, 2822.181567345488, 2925.917410558086, 12462.252264864046, 12934.44391179292, 12952.676183095498, 13043.282619455926, 13068.215907045513, 1818.5453636590853, 1825.3884948542254, 1884.4703103745587, 1894.8294653481114, 1932.7390802241798, 53691.731541342044, 57437.0, 60870.0, 61857.38142618561, 62150.0, 9460.739824668153, 9652.9034709652, 9677.612895484242, 9800.11798938099, 9943.204543636492, 12703.809442858364, 12835.743285134431, 12838.422270997828, 12875.871241287654, 12904.80642790359, 7423.1092268927, 7476.738314158978, 7520.360769334558, 7605.467617266849, 7617.047869016373, 7397.149327827261, 7398.371138453184, 7410.814729631802, 7490.550566966, 7543.585102819397, 5831.125331200354, 5912.320083190402, 5931.7627294907725, 5951.9702401488585, 5966.3294277602345, 1753.0, 1759.2786957347425, 1794.6590147871862, 1804.6029873427824, 1814.5191524246086, 864.762190397633, 941.3739862991171, 943.8489841625444, 1015.7592053177952, 1033.395463653756, 16206.837931620768, 16428.75356869648, 16589.66820663604, 16761.07814070238, 16762.83237167637, 928.3362395886974, 940.9012053734259, 953.4184147669915, 955.044955044955, 963.8457846744487, 9590.280728945358, 9822.557984890696, 9823.459709716035, 9959.502024898726, 9999.50002499872, 414610.0, 416282.0, 417442.0, 418560.0, 429937.0, 50952.0, 63324.366756331845, 63434.0, 64020.0, 64811.351886481476, 1031.2214278219897, 1042.1870940666292, 1042.7966546523355, 1055.7067592199649, 1056.0917610854658, 14589.854101459274, 15042.473513427416, 15090.849091508944, 15139.243037848284, 15261.542153735405, 31097.8445107773, 31432.84283578659, 33402.49896251607, 33453.49819752657, 34896.65103348934, 39304.41043384409, 41682.79158604187, 42068.579314206465, 42467.0, 42516.51192208258, 7846.293833555007, 7868.527888326718, 7873.724419645514, 8090.52784667655, 8141.9185808141165, 9234.584443699916, 11356.432178391213, 11795.469203885674, 11862.0, 12044.21712588679, 9891.35706179096, 10056.798864022825, 10485.475726213812, 10659.09397701204, 10810.08114310261, 10273.84589231177, 10377.273590848568, 10461.372317660966, 10665.680029599125, 10841.945790270998, 10590.205734570092, 10703.839442408214, 10776.191785615953, 10989.560417583207, 11146.665600032013, 7584.886226706493, 7722.227777222233, 7817.296443320129, 7907.723229686933, 7984.321332686786, 10614.946925265323, 10806.945965270123, 10907.509162087883, 10960.56157753681, 10994.890051099706], "unit": "score", "name": "jquery.html", "value": 8352.170655073442}, {"lowerIsBetter": false, "replicates": [1501.8197816262048, 1508.8943773935825, 1702.7786387769588, 1810.7012342963412, 1841.2911029253733, 6836.7607133750325, 6929.307069293068, 7587.35507481864, 7815.257550532698, 7849.686012559498, 6857.657117144147, 7366.300201480851, 7406.59263740494, 7525.247475252486, 7553.735619253313, 2243.3157886844506, 2263.0608297556496, 2265.8753768542806, 2278.4759505313705, 2281.783230593091, 2212.1483228956886, 2236.1614394602025, 2266.8186545076437, 2268.5576312619046, 2277.772222777717, 2100.789921007902, 2257.2325409360815, 2267.4784799496124, 2273.874936878471, 2288.965665515019, 2255.8082562982167, 2260.4009937366695, 2270.262164796448, 2280.726312842453, 2280.771922807706, 2260.1411463643876, 2270.819174029512, 2271.704678391815, 2272.0, 2274.65880117982, 7628.427867909929, 7654.69870122075, 7681.308682218627, 7712.730054448068, 7740.071191457061, 4715.575598196145, 4821.566059054667, 4829.251466022772, 4842.467328593887, 4860.149473842063, 2972.9405411891858, 3065.9080227592985, 3167.7149056584785, 3185.3310804730804, 3190.0748782852943, 961.4135377419768, 961.4615815143472, 985.5811280205955, 989.1443901025561, 992.0327680511443, 10930.125589952784, 10932.781344373068, 10941.0, 10950.06924411418, 10953.288036277616, 4296.634786043159, 4310.28880234764, 4327.956720432755, 4350.934735978963, 4400.867973960786, 9215.90784092164, 9241.399309044891, 9298.37278476264, 9299.302552308603, 9328.533573321307, 4716.646251531149, 4736.834210802605, 4780.211265141213, 4782.378290822171, 4787.329773831666, 4154.0, 4263.936040959388, 4278.55075217104, 4288.506821715543, 4343.370211319341, 3429.331280400298, 3489.180042689966, 3493.2140268439907, 3533.2933413316923, 3581.4806853006166, 1037.6264544763878, 1042.8748550174028, 1049.0034467256137, 1049.4123290956936, 1057.7778666479971, 1293.6442478318538, 1295.8250636164187, 1320.2804471563022, 1322.0150987514364, 1326.0584984660807, 7195.820104497325, 7206.639668016578, 7337.33963943237, 7403.296686814744, 7418.888716669254, 488.2773495227013, 496.53077841439494, 515.5952577226859, 521.9947800522023, 526.9920951185735, 5811.215485909348, 5823.213866128019, 5834.154047663065, 5870.7945221917025, 5873.794417195378, 9146.496942668084, 9661.372010819274, 9684.75788105303, 9692.079252471003, 9796.461194634363, 9521.428714277166, 9539.47532885684, 9553.426794392359, 9570.425774453555, 9666.806663866684, 7264.564126152448, 7502.774916752506, 7522.0, 7594.392448604099, 7609.847803043908, 7190.388816950409, 7271.200167981412, 7334.96332518334, 7348.0, 7359.153697324876, 8366.414350995372, 8500.70247541333, 8553.272971797467, 8686.218240358397, 8714.215720584923, 8575.056743758307, 8605.870911936201, 8638.481691098554, 8788.516631585324, 8850.911490885266, 6618.569792963442, 6720.596764194164, 6912.896306555305, 7043.788686339213, 7068.257832927674, 7586.696532138652, 7655.846883062419, 7680.846383072419, 7714.652840622298, 7727.806804829925, 6796.2524122347495, 6808.046873437624, 6954.061201737701, 6986.825329366603, 7161.2122666507685, 6878.209005964378, 6964.26875178099, 6991.161060672752, 7024.578525288499, 7083.5041547091205, 6889.724411023503, 6998.650067496503, 7034.753783617549, 7175.641217939186, 7205.963970180115, 6423.229212494531, 6436.356364363526, 6447.968325067966, 6481.157449531531, 6492.31830657793, 6301.495880329654, 6335.208098987627, 6353.841153971188, 6376.968115159394, 6415.839604009937], "unit": "score", "name": "mootools.html", "value": 4409.287896906542}, {"lowerIsBetter": false, "replicates": [327.8819624935024, 329.9589794199302, 339.4924587741326, 339.65864306372094, 340.85343302379965, 6168.29064657564, 6259.4679452246555, 6298.464630506401, 6314.336994615568, 6318.368163183679, 6157.81526554203, 6180.660063696495, 6186.350433204516, 6193.969030154843, 6197.907031394533, 4506.346579745935, 4623.86128416148, 4726.692764970283, 4746.620270378361, 4788.856334309976, 4735.786889589959, 4747.691400058985, 4748.90502189956, 4756.215224487955, 4787.593054590364, 4704.200285951397, 4707.340972263886, 4707.90584188316, 4708.882277943045, 4715.41057367829, 4728.2198437257985, 4728.952710472903, 4736.431628204603, 4741.454732705749, 4751.382320298374, 4168.291390463629, 4169.207850508424, 4169.791510424467, 4174.352975288835, 4176.310908700061, 5744.540436765091, 5809.651420914759, 5916.0238560637445, 5931.73307201177, 5945.435183657545, 5488.890222195534, 5503.972480137613, 5514.476124768141, 5515.448455154493, 5517.0, 6542.084108224853, 6554.410103090697, 6555.6394398308075, 6555.967220163916, 6561.671916404161, 4557.612602928755, 4600.953990460086, 4601.861944141681, 4607.654425918036, 4611.262198048296, 6873.450123990069, 6883.242843287185, 6887.276835932255, 6888.104546408985, 6890.7941110306, 4361.193179261783, 4493.752843593634, 4721.291806229093, 4725.834595789131, 4730.881727956828, 4522.253828118323, 4554.476235232924, 4555.134524440346, 4566.634669226454, 4567.040921406476, 5325.733713314319, 5333.359996800409, 5344.038073146871, 5350.5184533392185, 5378.19327100938, 6575.50683698715, 6583.242927063353, 6590.143281373391, 6595.406413422815, 6608.603483790988, 1602.3110062673163, 1604.2219523531078, 1607.9919600402156, 1618.6519898221939, 1625.7154997875325, 993.6323560282742, 1012.2256473797551, 1027.7225149209671, 1037.1339931157418, 1056.8837427882927, 6333.240011198685, 6342.619442833445, 6359.268684101387, 6362.1093046973465, 6373.6175829450385, 6754.696038678271, 6812.795616131425, 6815.318468153145, 6827.52207345481, 6841.486888483384, 6237.906431403532, 6415.0, 6441.452476539546, 6450.935490645127, 6461.224653041665, 3692.9261414771554, 3698.7780733156096, 3713.9814300928324, 3721.981390093032, 3725.3294407006997, 7301.780946571611, 7302.087239095114, 7311.305425984523, 7316.853662926712, 7321.341079302888, 7018.719251229996, 7050.541714788523, 7053.964730176419, 7064.611446370499, 7081.752138675121, 7102.964485177645, 7303.30618591233, 7412.666430010662, 7418.666160022812, 7424.443166762514, 6842.281560436082, 6848.9657551711925, 6871.828204294932, 6875.209350924708, 6893.482988775761, 6757.00668302842, 6790.8641827164165, 6795.218549866829, 6805.795826125224, 6810.455163586802, 7272.636368181464, 7323.926760732537, 7325.340719335072, 7325.377342925698, 7327.8534429312185, 4417.469903611587, 4562.041971185955, 4576.565226303496, 4580.541945805393, 4586.541345865387, 6864.519483636297, 6882.070920425878, 6886.276940921131, 6895.931040689529, 6896.965515172392, 6633.9336606633315, 6654.700538475877, 6664.500162487736, 6670.099536562502, 6677.966610166918, 6629.337066293332, 6669.433098186709, 6688.398044176048, 6688.699008544724, 6695.06269122333, 6368.936310636835, 6527.608343499405, 6587.242467116343, 6597.208334999831, 6601.471882249504, 6696.1629796275465, 6704.195496540447, 6721.193456785217, 6737.66311684404, 6748.561343512656, 6562.081308616702, 6577.309382514958, 6579.111819904251, 6580.341965803573, 6591.571547849375], "unit": "score", "name": "prototype.html", "value": 4970.920121432073}, {"lowerIsBetter": false, "replicates": [682.7337338438007, 689.5483458334793, 736.4108713029576, 832.1595188859254, 844.7676888855564, 15297.388104475822, 15689.607759806011, 15711.607209819746, 15787.447439339625, 15826.28781704823, 14820.555383338517, 14865.628359291024, 14955.252237388142, 14981.625459363522, 14986.475473358434, 838.9622466988985, 841.1672444280149, 859.0850743957665, 859.1751918158575, 860.9354298427612, 856.4989481153501, 860.7331727164568, 864.9005364383082, 865.398548009134, 867.9479231246114, 885.4156256870467, 888.6667499687617, 891.3359547137392, 896.6771962093674, 899.1278459893892, 889.9644014239423, 890.875277461156, 891.2468963725642, 891.4027601507006, 891.6433426629368, 664.1565212180503, 664.9035889796, 665.1386454541332, 665.3180489997791, 665.5574043261225, 14157.150570965672, 14201.289935503184, 14287.928560357235, 14311.0, 14346.784798228035, 12695.365231738377, 12793.232406055666, 12830.486780528767, 12922.095453318272, 13073.346332683328, 10288.588456461732, 10552.736181595445, 10568.735781605521, 10769.192310576738, 10843.51204195813, 4276.5295817460055, 4308.569143085698, 4370.431843860278, 4497.280435130396, 4501.617362524189, 49909.0, 50010.9997800042, 50200.24299149512, 50341.496585034416, 50596.241056384184, 9670.806583868283, 10128.162865733742, 10589.57641694339, 10599.62901298451, 10609.098226650667, 18196.09019549017, 18311.450656480327, 18444.07779611014, 18450.815491845176, 18489.0, 7836.960815196002, 7895.644695988694, 7938.0, 8176.7955801105445, 8248.381371397169, 4311.568843115726, 4382.364557139197, 4442.755648439303, 4464.374987501752, 4618.792154353062, 3112.0041586692496, 3137.51368537877, 3162.130414136085, 3169.6196456425378, 3180.9522857157162, 556.774506324939, 560.7869009776259, 562.1202817590458, 565.2058857305492, 584.8800995795851, 686.6395142550201, 689.7206631314326, 704.8968364509526, 710.7313494974277, 713.6717110129399, 7745.225477452323, 7781.338586220121, 7834.0, 8008.27925486709, 8037.638306276114, 652.1391762873056, 668.9197296324375, 671.9685283090432, 674.8852695041854, 677.4072686399401, 3717.4795528626014, 3775.2072064866684, 3809.238152369537, 3824.0631045394057, 3970.980145099256, 53458.73270633622, 53807.46192538103, 54116.188257176174, 54355.72822135864, 54608.453915461134, 46422.07155856864, 46860.0, 46994.0, 47214.0, 47273.0, 42545.36181957273, 43284.350734739004, 43429.0, 43603.781981089895, 43748.15636983586, 7231.2768723129375, 7274.709011639475, 7325.670344834602, 7348.595827229554, 7426.331630153312, 32967.83516082404, 33003.66996330102, 33230.66769332276, 33353.332933341684, 33969.32061358709, 39058.414123787596, 40269.0, 41098.794506027276, 41711.58288417077, 42128.3680744783, 9600.375975561567, 9837.508124593598, 9848.655297064568, 9873.308868379145, 10105.848412273675, 10910.072643825364, 11123.110151187724, 11144.777104457704, 11179.72050698739, 11887.940560297144, 9806.411615303105, 9839.901600983898, 9980.451075190935, 10063.446510441996, 10193.43936083493, 10615.150787936793, 10621.468926553796, 10933.507992140532, 11005.559777608805, 11009.504572294427, 9828.803423931338, 10014.799704006025, 10082.546285417027, 10119.7470063249, 10473.790524189626, 8892.86660700103, 9217.76955576116, 9234.676786312446, 9361.531923403938, 9395.859062113937, 8542.914570854213, 8763.167499087576, 8854.822903542023, 9003.189712925869, 9162.129597688208], "unit": "score", "name": "yui.html", "value": 6285.4511028346515}], "name": "dromaeo_css", "value": 6883.3783575254265}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 114.0, 112.0, 113.0, 125.0, 114.0, 111.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.9}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 156.0, 167.0, 128.0, 155.0, 152.0, 133.0, 173.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 163.0, 162.0, 162.0, 167.0, 172.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 72.0, 75.0, 75.0, 154.0, 74.0, 73.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 149.0, 95.0, 96.0, 97.0, 142.0, 96.0, 96.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 115.0, 117.0, 118.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.2}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 145.0, 148.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 99.0, 96.0, 97.0, 96.0, 96.0, 98.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 58.0, 60.0, 64.0, 56.0, 58.0, 68.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 70.0, 69.0, 68.0, 67.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 94.0, 84.0, 85.0, 85.0, 84.0, 94.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [119.0, 123.0, 120.0, 127.0, 123.0, 124.0, 120.0, 135.0, 136.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [143.0, 159.0, 158.0, 159.0, 158.0, 143.0, 159.0, 147.0, 158.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.9}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 73.0, 73.0, 72.0, 72.0, 71.0, 70.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.9}], "name": "kraken", "value": 1542.4000000000005}]} 11:57:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1542.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6883.38"}}} 11:57:25 INFO - Return code: 0 11:57:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:57:25 ERROR - # TBPL SUCCESS # 11:57:25 INFO - Running post-action listener: _resource_record_post_action 11:57:25 INFO - Running post-run listener: _resource_record_post_run 11:57:26 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 541020160; Read time: 0; Write time: 501800 11:57:26 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 240934912; Read time: 0; Write time: 330984 11:57:26 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 300085248; Read time: 0; Write time: 170816 11:57:26 INFO - Running post-run listener: _upload_blobber_files 11:57:26 INFO - Blob upload gear active. 11:57:26 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:57:26 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 11:57:26 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:57:26 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:57:27 INFO - (blobuploader) - INFO - Open directory for files ... 11:57:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:57:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:57:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:28 INFO - (blobuploader) - INFO - Done attempting. 11:57:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:57:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:57:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:29 INFO - (blobuploader) - INFO - Done attempting. 11:57:29 INFO - (blobuploader) - INFO - Iteration through files over. 11:57:29 INFO - Return code: 0 11:57:29 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:57:29 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:57:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eadf3f8a15ba226ba56542c55963249dfca6f7e87a02db623cb3b07d3386731336b259ab65f45272982472f1dd6300634830c809074c90c1f5762b62eceec99c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136ecc9c09b5491a79f2a10ed572bb456f173e680e76c08e8ebd451e15abb972a945fc42ddedfac4214b19df1996260e03414fcf94a187cf72d3bc9d29eb2440"} 11:57:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:57:29 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:57:29 INFO - Contents: 11:57:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eadf3f8a15ba226ba56542c55963249dfca6f7e87a02db623cb3b07d3386731336b259ab65f45272982472f1dd6300634830c809074c90c1f5762b62eceec99c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136ecc9c09b5491a79f2a10ed572bb456f173e680e76c08e8ebd451e15abb972a945fc42ddedfac4214b19df1996260e03414fcf94a187cf72d3bc9d29eb2440"} 11:57:29 INFO - Running post-run listener: copy_logs_to_upload_dir 11:57:29 INFO - Copying logs to upload dir... 11:57:29 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:57:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.777514 ========= master_lag: 1.94 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-29 11:57:30.742210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 11:57:30.745346) ========= 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=3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066 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/Fx-Team/sha512/eadf3f8a15ba226ba56542c55963249dfca6f7e87a02db623cb3b07d3386731336b259ab65f45272982472f1dd6300634830c809074c90c1f5762b62eceec99c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136ecc9c09b5491a79f2a10ed572bb456f173e680e76c08e8ebd451e15abb972a945fc42ddedfac4214b19df1996260e03414fcf94a187cf72d3bc9d29eb2440"} build_url:https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/JVZ9Gd0AQk6ucaWKcJEwOA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eadf3f8a15ba226ba56542c55963249dfca6f7e87a02db623cb3b07d3386731336b259ab65f45272982472f1dd6300634830c809074c90c1f5762b62eceec99c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136ecc9c09b5491a79f2a10ed572bb456f173e680e76c08e8ebd451e15abb972a945fc42ddedfac4214b19df1996260e03414fcf94a187cf72d3bc9d29eb2440"}' ========= master_lag: 0.34 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 11:57:31.094194) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-02-29 11:57:31.094531) ========= 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=3a3620fb28aea1604ab609ef000001d2-1456774360.545345-852578066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 5.75 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-02-29 11:57:36.848633) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 11:57:36.849447) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 11:57:37.058558) ========= ========= Total master_lag: 9.15 =========