builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1456815274.71 results: success (0) buildid: 20160229203554 builduid: e6e74ce1295149ba95abd8f8f03257e3 revision: aefae03959a33e8e5761e448e7ff6aad0610402e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:34.708170) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:34.708600) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:34.708880) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:34.737923) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:34.738206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:34.806567) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:34.806846) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:34.855631) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:34.855915) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:34.856272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:34.856544) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 22:54:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.6M=0s 2016-02-29 22:54:35 (40.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180701 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:35.049758) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:35.050074) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018599 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:35.100621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:35.100949) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aefae03959a33e8e5761e448e7ff6aad0610402e --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 aefae03959a33e8e5761e448e7ff6aad0610402e --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=74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 22:54:35,777 truncating revision to first 12 chars 2016-02-29 22:54:35,777 Setting DEBUG logging. 2016-02-29 22:54:35,777 attempt 1/10 2016-02-29 22:54:35,777 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aefae03959a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 22:54:36,094 unpacking tar archive at: fx-team-aefae03959a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583050 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:35.696437) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:35.696775) ========= echo aefae03959a33e8e5761e448e7ff6aad0610402e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'aefae03959a33e8e5761e448e7ff6aad0610402e'] 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=74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False aefae03959a33e8e5761e448e7ff6aad0610402e program finished with exit code 0 elapsedTime=0.003369 script_repo_revision: 'aefae03959a33e8e5761e448e7ff6aad0610402e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:35.743520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:35.743794) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 22:54:35.753631) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-02-29 22:54:35.753927) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:54:36 INFO - MultiFileLogger online at 20160229 22:54:36 in /builds/slave/test-pgo 22:54:36 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 22:54:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:54:36 INFO - {'append_to_log': False, 22:54:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:54:36 INFO - 'blob_upload_branch': 'Fx-Team', 22:54:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:54:36 INFO - 'branch': 'Fx-Team', 22:54:36 INFO - 'buildbot_json_path': 'buildprops.json', 22:54:36 INFO - 'config_files': ('talos/linux_config.py',), 22:54:36 INFO - 'default_actions': ('clobber', 22:54:36 INFO - 'read-buildbot-config', 22:54:36 INFO - 'download-and-extract', 22:54:36 INFO - 'populate-webroot', 22:54:36 INFO - 'create-virtualenv', 22:54:36 INFO - 'install', 22:54:36 INFO - 'run-tests'), 22:54:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:54:36 INFO - 'download_minidump_stackwalk': True, 22:54:36 INFO - 'download_symbols': 'ondemand', 22:54:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:54:36 INFO - 'tooltool.py': '/tools/tooltool.py', 22:54:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:54:36 INFO - '/tools/misc-python/virtualenv.py')}, 22:54:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:54:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:54:36 INFO - 'installer_path': 'installer.exe', 22:54:36 INFO - 'log_level': 'info', 22:54:36 INFO - 'log_name': 'talos', 22:54:36 INFO - 'log_to_console': True, 22:54:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:54:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:54:36 INFO - 'opt_config_files': (), 22:54:36 INFO - 'pip_index': False, 22:54:36 INFO - 'sps_profile': False, 22:54:36 INFO - 'sps_profile_interval': 0, 22:54:36 INFO - 'suite': 'dromaeojs-e10s', 22:54:36 INFO - 'system_bits': '32', 22:54:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:54:36 INFO - 'title': 'talos-linux64-ix-042', 22:54:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:54:36 INFO - 'use_talos_json': True, 22:54:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:54:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:54:36 INFO - 'work_dir': 'build'} 22:54:36 INFO - ##### 22:54:36 INFO - ##### Running clobber step. 22:54:36 INFO - ##### 22:54:36 INFO - Running pre-action listener: _resource_record_pre_action 22:54:36 INFO - Running main action method: clobber 22:54:36 INFO - rmtree: /builds/slave/test-pgo/build 22:54:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:54:36 INFO - Running post-action listener: _resource_record_post_action 22:54:36 INFO - ##### 22:54:36 INFO - ##### Running read-buildbot-config step. 22:54:36 INFO - ##### 22:54:36 INFO - Running pre-action listener: _resource_record_pre_action 22:54:36 INFO - Running main action method: read_buildbot_config 22:54:36 INFO - Using buildbot properties: 22:54:36 INFO - { 22:54:36 INFO - "project": "", 22:54:36 INFO - "product": "firefox", 22:54:36 INFO - "script_repo_revision": "production", 22:54:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:54:36 INFO - "repository": "", 22:54:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:54:36 INFO - "buildid": "20160229203554", 22:54:36 INFO - "pgo_build": "True", 22:54:36 INFO - "basedir": "/builds/slave/test-pgo", 22:54:36 INFO - "buildnumber": 208, 22:54:36 INFO - "slavename": "talos-linux64-ix-042", 22:54:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:54:36 INFO - "platform": "ubuntu64_hw", 22:54:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:54:36 INFO - "branch": "fx-team", 22:54:36 INFO - "repo_path": "integration/fx-team", 22:54:36 INFO - "revision": "aefae03959a33e8e5761e448e7ff6aad0610402e", 22:54:36 INFO - "stage_platform": "linux64-pgo", 22:54:36 INFO - "builduid": "e6e74ce1295149ba95abd8f8f03257e3", 22:54:36 INFO - "slavebuilddir": "test" 22:54:36 INFO - } 22:54:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:54:36 INFO - Running post-action listener: _resource_record_post_action 22:54:36 INFO - ##### 22:54:36 INFO - ##### Running download-and-extract step. 22:54:36 INFO - ##### 22:54:36 INFO - Running pre-action listener: _resource_record_pre_action 22:54:36 INFO - Running main action method: download_and_extract 22:54:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:36 INFO - https://queue.taskcluster.net/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:54:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/test_packages.json 22:54:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/test_packages.json 22:54:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:54:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:54:38 INFO - Downloaded 1448 bytes. 22:54:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:54:38 INFO - Using the following test package requirements: 22:54:38 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:38 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:54:38 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:54:38 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:38 INFO - u'jsshell-linux-x86_64.zip'], 22:54:38 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:54:38 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:38 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:54:38 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:54:38 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:54:38 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:38 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:54:38 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:38 INFO - https://queue.taskcluster.net/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/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 22:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/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 22:54:39 INFO - Downloaded 23380006 bytes. 22:54:39 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'] 22:54:39 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 22:54:40 INFO - Return code: 0 22:54:40 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 22:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:40 INFO - https://queue.taskcluster.net/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/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 22:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/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 22:54:44 INFO - Downloaded 23380006 bytes. 22:54:44 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'] 22:54:44 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 22:54:45 INFO - Return code: 0 22:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:45 INFO - https://queue.taskcluster.net/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:54:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/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 22:54:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/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 22:54:46 INFO - Downloaded 10713410 bytes. 22:54:46 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'] 22:54:46 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 22:54:46 INFO - Return code: 0 22:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:46 INFO - https://queue.taskcluster.net/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:54:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/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 22:54:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HogXBHcZR6WTWWVJm-cETg/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 22:54:48 INFO - Downloaded 56645038 bytes. 22:54:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:48 INFO - mkdir: /builds/slave/test-pgo/properties 22:54:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:54:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:54:48 INFO - Contents: 22:54:48 INFO - build_url:https://queue.taskcluster.net/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:49 INFO - Running post-action listener: _resource_record_post_action 22:54:49 INFO - Running post-action listener: set_extra_try_arguments 22:54:49 INFO - ##### 22:54:49 INFO - ##### Running populate-webroot step. 22:54:49 INFO - ##### 22:54:49 INFO - Running pre-action listener: _resource_record_pre_action 22:54:49 INFO - Running main action method: populate_webroot 22:54:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:54:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:54:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:54:49 INFO - '--tppagecycles', 22:54:49 INFO - '7'], 22:54:49 INFO - 'tests': ['tsvgm']}}, 22:54:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:54:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:54:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:54:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:54:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:54:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:54:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:49 INFO - 'talos_options': ['--e10s'], 22:54:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:49 INFO - 'tests': ['damp', 'tps']}, 22:54:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:49 INFO - 'talos_options': ['--e10s'], 22:54:49 INFO - 'tests': ['damp', 'tps']}, 22:54:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:54:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:54:49 INFO - 'other': {'tests': ['a11yr', 22:54:49 INFO - 'ts_paint', 22:54:49 INFO - 'tpaint', 22:54:49 INFO - 'sessionrestore', 22:54:49 INFO - 'sessionrestore_no_auto_restore']}, 22:54:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:54:49 INFO - 'tests': ['a11yr', 22:54:49 INFO - 'ts_paint', 22:54:49 INFO - 'tpaint', 22:54:49 INFO - 'sessionrestore', 22:54:49 INFO - 'sessionrestore_no_auto_restore']}, 22:54:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:54:49 INFO - 'tests': ['a11yr', 22:54:49 INFO - 'ts_paint', 22:54:49 INFO - 'tpaint', 22:54:49 INFO - 'sessionrestore', 22:54:49 INFO - 'sessionrestore_no_auto_restore']}, 22:54:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:54:49 INFO - 'tests': ['a11yr', 22:54:49 INFO - 'ts_paint', 22:54:49 INFO - 'tpaint', 22:54:49 INFO - 'sessionrestore', 22:54:49 INFO - 'sessionrestore_no_auto_restore']}, 22:54:49 INFO - 'other_l64': {'tests': ['a11yr', 22:54:49 INFO - 'ts_paint', 22:54:49 INFO - 'tpaint', 22:54:49 INFO - 'sessionrestore', 22:54:49 INFO - 'sessionrestore_no_auto_restore']}, 22:54:49 INFO - 'other_nol64': {'tests': ['a11yr', 22:54:49 INFO - 'ts_paint', 22:54:49 INFO - 'tpaint', 22:54:49 INFO - 'sessionrestore', 22:54:49 INFO - 'sessionrestore_no_auto_restore']}, 22:54:49 INFO - 'svgr': {'tests': ['tsvgx', 22:54:49 INFO - 'tsvgr_opacity', 22:54:49 INFO - 'tart', 22:54:49 INFO - 'tscrollx', 22:54:49 INFO - 'cart']}, 22:54:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:54:49 INFO - 'tests': ['tsvgx', 22:54:49 INFO - 'tsvgr_opacity', 22:54:49 INFO - 'tart', 22:54:49 INFO - 'tscrollx', 22:54:49 INFO - 'cart']}, 22:54:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:49 INFO - 'tests': ['tp5o']}, 22:54:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:49 INFO - 'talos_options': ['--e10s'], 22:54:49 INFO - 'tests': ['tp5o']}, 22:54:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:49 INFO - 'talos_options': ['--xperf_path', 22:54:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:49 INFO - 'tests': ['tp5n']}, 22:54:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:49 INFO - 'talos_options': ['--e10s', 22:54:49 INFO - '--xperf_path', 22:54:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:49 INFO - 'tests': ['tp5n']}}, 22:54:49 INFO - 'talos.zip': {'path': '', 22:54:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:54:49 INFO - Running post-action listener: _resource_record_post_action 22:54:49 INFO - ##### 22:54:49 INFO - ##### Running create-virtualenv step. 22:54:49 INFO - ##### 22:54:49 INFO - Running pre-action listener: _resource_record_pre_action 22:54:49 INFO - Running main action method: create_virtualenv 22:54:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:54:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:54:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:54:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:54:49 INFO - Using real prefix '/usr' 22:54:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:54:50 INFO - Installing distribute.............................................................................................................................................................................................done. 22:54:52 INFO - Installing pip.................done. 22:54:52 INFO - Return code: 0 22:54:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7038adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe39670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec88c0>, '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 0xec97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec9c50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', '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 22:54:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:54:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:54:52 INFO - Using env: {'DISPLAY': ':0', 22:54:52 INFO - 'HOME': '/home/cltbld', 22:54:52 INFO - 'LANG': 'en_US.UTF-8', 22:54:52 INFO - 'LANGUAGE': 'en_US:en', 22:54:52 INFO - 'LOGNAME': 'cltbld', 22:54:52 INFO - 'MAIL': '/var/mail/cltbld', 22:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:52 INFO - 'MOZ_NO_REMOTE': '1', 22:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:52 INFO - 'NO_EM_RESTART': '1', 22:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:52 INFO - 'SHELL': '/bin/bash', 22:54:52 INFO - 'SHLVL': '1', 22:54:52 INFO - 'TERM': 'linux', 22:54:52 INFO - 'TMOUT': '86400', 22:54:52 INFO - 'USER': 'cltbld', 22:54:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', 22:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:52 INFO - '_': '/tools/buildbot/bin/python'} 22:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:54:52 INFO - Cleaning up... 22:54:52 INFO - Return code: 0 22:54:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7038adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe39670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec88c0>, '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 0xec97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec9c50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', '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 22:54:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:54:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:54:52 INFO - Using env: {'DISPLAY': ':0', 22:54:52 INFO - 'HOME': '/home/cltbld', 22:54:52 INFO - 'LANG': 'en_US.UTF-8', 22:54:52 INFO - 'LANGUAGE': 'en_US:en', 22:54:52 INFO - 'LOGNAME': 'cltbld', 22:54:52 INFO - 'MAIL': '/var/mail/cltbld', 22:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:52 INFO - 'MOZ_NO_REMOTE': '1', 22:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:52 INFO - 'NO_EM_RESTART': '1', 22:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:52 INFO - 'SHELL': '/bin/bash', 22:54:52 INFO - 'SHLVL': '1', 22:54:52 INFO - 'TERM': 'linux', 22:54:52 INFO - 'TMOUT': '86400', 22:54:52 INFO - 'USER': 'cltbld', 22:54:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', 22:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:52 INFO - '_': '/tools/buildbot/bin/python'} 22:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:52 INFO - Downloading/unpacking psutil>=0.7.1 22:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:54:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:54 INFO - Installing collected packages: psutil 22:54:54 INFO - Running setup.py install for psutil 22:54:54 INFO - building 'psutil._psutil_linux' extension 22:54:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:54:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:54:54 INFO - building 'psutil._psutil_posix' extension 22:54:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:54:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:54:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:54 INFO - Successfully installed psutil 22:54:54 INFO - Cleaning up... 22:54:54 INFO - Return code: 0 22:54:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:54:54 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')]} 22:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:54 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')]} 22:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:54 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 0x7fd7038adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe39670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec88c0>, '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 0xec97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec9c50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', '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 22:54:54 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 22:54:54 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 22:54:54 INFO - Using env: {'DISPLAY': ':0', 22:54:54 INFO - 'HOME': '/home/cltbld', 22:54:54 INFO - 'LANG': 'en_US.UTF-8', 22:54:54 INFO - 'LANGUAGE': 'en_US:en', 22:54:54 INFO - 'LOGNAME': 'cltbld', 22:54:54 INFO - 'MAIL': '/var/mail/cltbld', 22:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:54 INFO - 'MOZ_NO_REMOTE': '1', 22:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:54 INFO - 'NO_EM_RESTART': '1', 22:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:54 INFO - 'SHELL': '/bin/bash', 22:54:54 INFO - 'SHLVL': '1', 22:54:54 INFO - 'TERM': 'linux', 22:54:54 INFO - 'TMOUT': '86400', 22:54:54 INFO - 'USER': 'cltbld', 22:54:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', 22:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:54 INFO - '_': '/tools/buildbot/bin/python'} 22:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:54:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:54:57 INFO - Installing collected packages: mozsystemmonitor 22:54:57 INFO - Running setup.py install for mozsystemmonitor 22:54:57 INFO - Successfully installed mozsystemmonitor 22:54:57 INFO - Cleaning up... 22:54:57 INFO - Return code: 0 22:54:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd7038adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe39670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec88c0>, '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 0xec97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec9c50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', '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 22:54:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:54:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:54:57 INFO - Using env: {'DISPLAY': ':0', 22:54:57 INFO - 'HOME': '/home/cltbld', 22:54:57 INFO - 'LANG': 'en_US.UTF-8', 22:54:57 INFO - 'LANGUAGE': 'en_US:en', 22:54:57 INFO - 'LOGNAME': 'cltbld', 22:54:57 INFO - 'MAIL': '/var/mail/cltbld', 22:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:57 INFO - 'MOZ_NO_REMOTE': '1', 22:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:57 INFO - 'NO_EM_RESTART': '1', 22:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:57 INFO - 'SHELL': '/bin/bash', 22:54:57 INFO - 'SHLVL': '1', 22:54:57 INFO - 'TERM': 'linux', 22:54:57 INFO - 'TMOUT': '86400', 22:54:57 INFO - 'USER': 'cltbld', 22:54:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', 22:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:57 INFO - '_': '/tools/buildbot/bin/python'} 22:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:57 INFO - Downloading/unpacking blobuploader==1.2.4 22:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:59 INFO - Downloading blobuploader-1.2.4.tar.gz 22:54:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:54:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:54:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:59 INFO - Downloading docopt-0.6.1.tar.gz 22:54:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:54:59 INFO - Installing collected packages: blobuploader, requests, docopt 22:54:59 INFO - Running setup.py install for blobuploader 22:55:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:55:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:55:00 INFO - Running setup.py install for requests 22:55:00 INFO - Running setup.py install for docopt 22:55:00 INFO - Successfully installed blobuploader requests docopt 22:55:00 INFO - Cleaning up... 22:55:00 INFO - Return code: 0 22:55:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7038adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe39670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec88c0>, '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 0xec97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec9c50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', '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 22:55:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:55:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:55:00 INFO - Using env: {'DISPLAY': ':0', 22:55:00 INFO - 'HOME': '/home/cltbld', 22:55:00 INFO - 'LANG': 'en_US.UTF-8', 22:55:00 INFO - 'LANGUAGE': 'en_US:en', 22:55:00 INFO - 'LOGNAME': 'cltbld', 22:55:00 INFO - 'MAIL': '/var/mail/cltbld', 22:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:00 INFO - 'MOZ_NO_REMOTE': '1', 22:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:00 INFO - 'NO_EM_RESTART': '1', 22:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:00 INFO - 'SHELL': '/bin/bash', 22:55:00 INFO - 'SHLVL': '1', 22:55:00 INFO - 'TERM': 'linux', 22:55:00 INFO - 'TMOUT': '86400', 22:55:00 INFO - 'USER': 'cltbld', 22:55:00 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', 22:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:00 INFO - '_': '/tools/buildbot/bin/python'} 22:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:55:00 INFO - Running setup.py (path:/tmp/pip-peqrOj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:55:00 INFO - Running setup.py (path:/tmp/pip-NkDSjc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:55:00 INFO - Running setup.py (path:/tmp/pip-guTRXp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:55:00 INFO - Running setup.py (path:/tmp/pip-epE2FP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:55:01 INFO - Running setup.py (path:/tmp/pip-QkSDIt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:55:01 INFO - Running setup.py (path:/tmp/pip-0c_R7Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:55:01 INFO - Running setup.py (path:/tmp/pip-BxaYbx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:55:01 INFO - Running setup.py (path:/tmp/pip-5K_7vq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:55:01 INFO - Running setup.py (path:/tmp/pip-5wYjyV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:55:01 INFO - Running setup.py (path:/tmp/pip-8VioOs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:55:01 INFO - Running setup.py (path:/tmp/pip-izqrH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:55:01 INFO - Running setup.py (path:/tmp/pip-oGjCbu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:55:01 INFO - Running setup.py (path:/tmp/pip-kk5fT7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:55:01 INFO - Running setup.py (path:/tmp/pip-22cBF5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:55:01 INFO - Running setup.py (path:/tmp/pip-kTAPfJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:55:01 INFO - Running setup.py (path:/tmp/pip-MjBdxb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:55:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:55:01 INFO - Running setup.py (path:/tmp/pip-oSTemP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:55:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:55:01 INFO - Running setup.py install for manifestparser 22:55:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:55:02 INFO - Running setup.py install for mozcrash 22:55:02 INFO - Running setup.py install for mozdebug 22:55:02 INFO - Running setup.py install for mozdevice 22:55:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:55:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:55:02 INFO - Running setup.py install for mozfile 22:55:02 INFO - Running setup.py install for mozhttpd 22:55:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:55:02 INFO - Running setup.py install for mozinfo 22:55:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:55:02 INFO - Running setup.py install for mozInstall 22:55:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:55:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:55:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:55:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:55:02 INFO - Running setup.py install for mozleak 22:55:02 INFO - Running setup.py install for mozlog 22:55:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:55:03 INFO - Running setup.py install for moznetwork 22:55:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:55:03 INFO - Running setup.py install for mozprocess 22:55:03 INFO - Running setup.py install for mozprofile 22:55:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:55:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:55:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:55:03 INFO - Running setup.py install for mozrunner 22:55:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:55:03 INFO - Running setup.py install for mozscreenshot 22:55:03 INFO - Running setup.py install for moztest 22:55:03 INFO - Running setup.py install for mozversion 22:55:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:55:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:55:03 INFO - Cleaning up... 22:55:03 INFO - Return code: 0 22:55:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:55: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')]} 22:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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')]} 22:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7038adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe39670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec88c0>, '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 0xec97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec9c50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', '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 22:55:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:55:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:55:03 INFO - Using env: {'DISPLAY': ':0', 22:55:03 INFO - 'HOME': '/home/cltbld', 22:55:03 INFO - 'LANG': 'en_US.UTF-8', 22:55:03 INFO - 'LANGUAGE': 'en_US:en', 22:55:03 INFO - 'LOGNAME': 'cltbld', 22:55:03 INFO - 'MAIL': '/var/mail/cltbld', 22:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:03 INFO - 'MOZ_NO_REMOTE': '1', 22:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:03 INFO - 'NO_EM_RESTART': '1', 22:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:03 INFO - 'SHELL': '/bin/bash', 22:55:03 INFO - 'SHLVL': '1', 22:55:03 INFO - 'TERM': 'linux', 22:55:03 INFO - 'TMOUT': '86400', 22:55:03 INFO - 'USER': 'cltbld', 22:55:03 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', 22:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:03 INFO - '_': '/tools/buildbot/bin/python'} 22:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:55:03 INFO - Running setup.py (path:/tmp/pip-g3Hbv5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:55:04 INFO - Running setup.py (path:/tmp/pip-lCFB1j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:55:04 INFO - Running setup.py (path:/tmp/pip-0D73XN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:55:04 INFO - Running setup.py (path:/tmp/pip-0MQPkc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:55:04 INFO - Running setup.py (path:/tmp/pip-TfCrDj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:55:04 INFO - Running setup.py (path:/tmp/pip-Rzq2Ic-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:55:04 INFO - Running setup.py (path:/tmp/pip-UvsvSv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:55:04 INFO - Running setup.py (path:/tmp/pip-dUbcTf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:55:04 INFO - Running setup.py (path:/tmp/pip-vIExds-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:55:04 INFO - Running setup.py (path:/tmp/pip-PFihq4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:55:04 INFO - Running setup.py (path:/tmp/pip-933SDu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:55:04 INFO - Running setup.py (path:/tmp/pip-vR_pmx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:55:04 INFO - Running setup.py (path:/tmp/pip-aHqHlc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:55:04 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)) 22:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:55:04 INFO - Running setup.py (path:/tmp/pip-EgDI6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:55:05 INFO - Running setup.py (path:/tmp/pip-41JbZa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:55:05 INFO - Running setup.py (path:/tmp/pip-oiFvJd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:55:05 INFO - Running setup.py (path:/tmp/pip-SmDwad-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:55:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:07 INFO - Downloading blessings-1.6.tar.gz 22:55:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:55:07 INFO - Installing collected packages: blessings 22:55:07 INFO - Running setup.py install for blessings 22:55:07 INFO - Successfully installed blessings 22:55:07 INFO - Cleaning up... 22:55:07 INFO - Return code: 0 22:55:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:55:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:55:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:55:07 INFO - Reading from file tmpfile_stdout 22:55:07 INFO - Current package versions: 22:55:07 INFO - argparse == 1.2.1 22:55:07 INFO - blessings == 1.6 22:55:07 INFO - blobuploader == 1.2.4 22:55:07 INFO - docopt == 0.6.1 22:55:07 INFO - manifestparser == 1.1 22:55:07 INFO - mozInstall == 1.12 22:55:07 INFO - mozcrash == 0.16 22:55:07 INFO - mozdebug == 0.1 22:55:07 INFO - mozdevice == 0.48 22:55:07 INFO - mozfile == 1.2 22:55:07 INFO - mozhttpd == 0.7 22:55:07 INFO - mozinfo == 0.9 22:55:07 INFO - mozleak == 0.1 22:55:07 INFO - mozlog == 3.1 22:55:07 INFO - moznetwork == 0.27 22:55:07 INFO - mozprocess == 0.22 22:55:07 INFO - mozprofile == 0.28 22:55:07 INFO - mozrunner == 6.11 22:55:07 INFO - mozscreenshot == 0.1 22:55:07 INFO - mozsystemmonitor == 0.0 22:55:07 INFO - moztest == 0.7 22:55:07 INFO - mozversion == 1.4 22:55:07 INFO - psutil == 3.1.1 22:55:07 INFO - requests == 1.2.3 22:55:07 INFO - wsgiref == 0.1.2 22:55:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7038adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe39670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec88c0>, '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 0xec97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec9c50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', '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 22:55:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:55:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:55:07 INFO - Using env: {'DISPLAY': ':0', 22:55:07 INFO - 'HOME': '/home/cltbld', 22:55:07 INFO - 'LANG': 'en_US.UTF-8', 22:55:07 INFO - 'LANGUAGE': 'en_US:en', 22:55:07 INFO - 'LOGNAME': 'cltbld', 22:55:07 INFO - 'MAIL': '/var/mail/cltbld', 22:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:07 INFO - 'MOZ_NO_REMOTE': '1', 22:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:07 INFO - 'NO_EM_RESTART': '1', 22:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:07 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:07 INFO - 'SHELL': '/bin/bash', 22:55:07 INFO - 'SHLVL': '1', 22:55:07 INFO - 'TERM': 'linux', 22:55:07 INFO - 'TMOUT': '86400', 22:55:07 INFO - 'USER': 'cltbld', 22:55:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', 22:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:07 INFO - '_': '/tools/buildbot/bin/python'} 22:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:55:07 INFO - Cleaning up... 22:55:07 INFO - Return code: 0 22:55:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7038adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe39670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec88c0>, '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 0xec97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec9c50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', '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 22:55:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:55:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:55:07 INFO - Using env: {'DISPLAY': ':0', 22:55:07 INFO - 'HOME': '/home/cltbld', 22:55:07 INFO - 'LANG': 'en_US.UTF-8', 22:55:07 INFO - 'LANGUAGE': 'en_US:en', 22:55:07 INFO - 'LOGNAME': 'cltbld', 22:55:07 INFO - 'MAIL': '/var/mail/cltbld', 22:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:07 INFO - 'MOZ_NO_REMOTE': '1', 22:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:07 INFO - 'NO_EM_RESTART': '1', 22:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:07 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:07 INFO - 'SHELL': '/bin/bash', 22:55:07 INFO - 'SHLVL': '1', 22:55:07 INFO - 'TERM': 'linux', 22:55:07 INFO - 'TMOUT': '86400', 22:55:07 INFO - 'USER': 'cltbld', 22:55:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', 22:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:07 INFO - '_': '/tools/buildbot/bin/python'} 22:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:07 INFO - Downloading/unpacking jsonschema 22:55:07 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 22:55:07 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 22:55:07 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 22:55:07 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 22:55:07 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 22:55:07 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 22:55:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:55:09 INFO - Downloading/unpacking functools32 (from jsonschema) 22:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:09 INFO - Downloading functools32-3.2.3-2.tar.gz 22:55:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:55:10 INFO - warning: no files found matching '*.txt' 22:55:10 INFO - no previously-included directories found matching 'build' 22:55:10 INFO - no previously-included directories found matching 'dist' 22:55:10 INFO - no previously-included directories found matching '.git*' 22:55:10 INFO - Installing collected packages: jsonschema, functools32 22:55:10 INFO - Running setup.py install for functools32 22:55:10 INFO - warning: no files found matching '*.txt' 22:55:10 INFO - no previously-included directories found matching 'build' 22:55:10 INFO - no previously-included directories found matching 'dist' 22:55:10 INFO - no previously-included directories found matching '.git*' 22:55:10 INFO - Successfully installed jsonschema functools32 22:55:10 INFO - Cleaning up... 22:55:10 INFO - Return code: 0 22:55:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:55: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')]} 22:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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')]} 22:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7038adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe39670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec88c0>, '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 0xec97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec9c50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', '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 22:55:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:55:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:55:10 INFO - Using env: {'DISPLAY': ':0', 22:55:10 INFO - 'HOME': '/home/cltbld', 22:55:10 INFO - 'LANG': 'en_US.UTF-8', 22:55:10 INFO - 'LANGUAGE': 'en_US:en', 22:55:10 INFO - 'LOGNAME': 'cltbld', 22:55:10 INFO - 'MAIL': '/var/mail/cltbld', 22:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:10 INFO - 'MOZ_NO_REMOTE': '1', 22:55:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:10 INFO - 'NO_EM_RESTART': '1', 22:55:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:10 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:10 INFO - 'SHELL': '/bin/bash', 22:55:10 INFO - 'SHLVL': '1', 22:55:10 INFO - 'TERM': 'linux', 22:55:10 INFO - 'TMOUT': '86400', 22:55:10 INFO - 'USER': 'cltbld', 22:55:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', 22:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:10 INFO - '_': '/tools/buildbot/bin/python'} 22:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:10 INFO - Downloading/unpacking flake8 22:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:55:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:55:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:55:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:12 INFO - no previously-included directories found matching 'docs/_build' 22:55:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:55:13 INFO - Running setup.py install for pep8 22:55:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:13 INFO - no previously-included directories found matching 'docs/_build' 22:55:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:55:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:55:13 INFO - Cleaning up... 22:55:13 INFO - Return code: 0 22:55:13 INFO - Running post-action listener: _resource_record_post_action 22:55:13 INFO - Running post-action listener: _start_resource_monitoring 22:55:13 INFO - Starting resource monitoring. 22:55:13 INFO - ##### 22:55:13 INFO - ##### Running install step. 22:55:13 INFO - ##### 22:55:13 INFO - Running pre-action listener: _resource_record_pre_action 22:55:13 INFO - Running main action method: install 22:55:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:55:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:55:13 INFO - Reading from file tmpfile_stdout 22:55:13 INFO - Detecting whether we're running mozinstall >=1.0... 22:55:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:55:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:55:13 INFO - Reading from file tmpfile_stdout 22:55:13 INFO - Output received: 22:55:13 INFO - Usage: mozinstall [options] installer 22:55:13 INFO - Options: 22:55:13 INFO - -h, --help show this help message and exit 22:55:13 INFO - -d DEST, --destination=DEST 22:55:13 INFO - Directory to install application into. [default: 22:55:13 INFO - "/builds/slave/test-pgo"] 22:55:13 INFO - --app=APP Application being installed. [default: firefox] 22:55:13 INFO - mkdir: /builds/slave/test-pgo/build/application 22:55:13 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'] 22:55:13 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 22:55:29 INFO - Reading from file tmpfile_stdout 22:55:29 INFO - Output received: 22:55:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:55:29 INFO - Running post-action listener: _resource_record_post_action 22:55:29 INFO - ##### 22:55:29 INFO - ##### Running run-tests step. 22:55:29 INFO - ##### 22:55:29 INFO - Running pre-action listener: _resource_record_pre_action 22:55:29 INFO - Running main action method: run_tests 22:55:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:55:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:55:29 INFO - Python 2.7.3 22:55:29 INFO - Return code: 0 22:55:29 INFO - grabbing minidump binary from tooltool 22:55:29 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')]} 22:55:29 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 0xec88c0>, '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 0xec97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec9c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:55:29 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 22:55:29 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 22:55:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:55:29 INFO - Return code: 0 22:55:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:55:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:55:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:55:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:55:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:55:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:55:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:55:30 INFO - Return code: 0 22:55:30 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/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 22:55:30 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/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 22:55:30 INFO - Using env: {'DISPLAY': ':0', 22:55:30 INFO - 'HOME': '/home/cltbld', 22:55:30 INFO - 'LANG': 'en_US.UTF-8', 22:55:30 INFO - 'LANGUAGE': 'en_US:en', 22:55:30 INFO - 'LOGNAME': 'cltbld', 22:55:30 INFO - 'MAIL': '/var/mail/cltbld', 22:55:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:55:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:30 INFO - 'MOZ_NO_REMOTE': '1', 22:55:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:30 INFO - 'NO_EM_RESTART': '1', 22:55:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:55:30 INFO - 'SHELL': '/bin/bash', 22:55:30 INFO - 'SHLVL': '1', 22:55:30 INFO - 'TERM': 'linux', 22:55:30 INFO - 'TMOUT': '86400', 22:55:30 INFO - 'USER': 'cltbld', 22:55:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263', 22:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:30 INFO - '_': '/tools/buildbot/bin/python'} 22:55:30 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/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 22:55:31 INFO - mozversion application_buildid: 20160229203554 22:55:31 INFO - mozversion application_changeset: aefae03959a33e8e5761e448e7ff6aad0610402e 22:55:31 INFO - mozversion application_display_name: Nightly 22:55:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:55:31 INFO - mozversion application_name: Firefox 22:55:31 INFO - mozversion application_remotingname: firefox 22:55:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:55:31 INFO - mozversion application_vendor: Mozilla 22:55:31 INFO - mozversion application_version: 47.0a1 22:55:31 INFO - mozversion platform_buildid: 20160229203554 22:55:31 INFO - mozversion platform_changeset: aefae03959a33e8e5761e448e7ff6aad0610402e 22:55:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:55:31 INFO - mozversion platform_version: 47.0a1 22:55:31 INFO - using testdate: 1456815331 22:55:31 INFO - actual date: 1456815331 22:55:31 INFO - starting webserver on 'localhost:56840' 22:55:31 INFO - SUITE-START | Running 2 tests 22:55:31 INFO - TEST-START | dromaeo_css 22:55:31 INFO - operating with platform_type : linux_ 22:55:31 INFO - Initialising browser for dromaeo_css test... 22:55:31 INFO - TEST-INFO | started process 18775 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkDw3nL/profile http://localhost:56840/getInfo.html) 22:55:35 INFO - PROCESS | 18775 | 22:55:35 INFO - PROCESS | 18775 | (process:18856): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:55:35 INFO - PROCESS | 18775 | __metrics Screen width/height:1600/1200 22:55:35 INFO - PROCESS | 18775 | colorDepth:24 22:55:35 INFO - PROCESS | 18775 | Browser inner width/height: 1024/697 22:55:35 INFO - PROCESS | 18775 | __metrics 22:55:36 ERROR - PROCESS | 18775 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 22:55:36 INFO - PROCESS | 18775 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:55:36 INFO - PROCESS | 18775 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:55:36 INFO - PROCESS | 18775 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:55:36 INFO - PROCESS | 18775 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:55:36 INFO - PROCESS | 18775 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:55:36 INFO - PROCESS | 18775 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:55:36 INFO - PROCESS | 18775 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:55:36 INFO - PROCESS | 18775 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:55:36 INFO - PROCESS | 18775 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:55:37 INFO - TEST-INFO | 18775: exit 0 22:55:37 INFO - Browser initialized. 22:55:37 INFO - Running cycle 1/1 for dromaeo_css test... 22:55:37 INFO - TEST-INFO | started process 18907 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkDw3nL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:55:38 INFO - PROCESS | 18907 | 22:55:38 INFO - PROCESS | 18907 | (process:18965): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:55:49 INFO - PROCESS | 18907 | RSS: Main: 161239040 22:55:49 INFO - PROCESS | 18907 | 22:56:38 INFO - PROCESS | 18907 | 1456815398962 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] 22:58:47 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:56840/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56840/tests/dromaeo/cssquery-ext.html) 22:58:48 INFO - PROCESS | 18907 | RSS: Main: 169525248 22:58:48 INFO - PROCESS | 18907 | 23:01:50 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:56840/tests/dromaeo/cssquery-ext.html (next: http://localhost:56840/tests/dromaeo/cssquery-jquery.html) 23:01:50 INFO - PROCESS | 18907 | RSS: Main: 165695488 23:01:50 INFO - PROCESS | 18907 | 23:04:52 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:56840/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56840/tests/dromaeo/cssquery-mootools.html) 23:04:53 INFO - PROCESS | 18907 | RSS: Main: 167534592 23:04:53 INFO - PROCESS | 18907 | 23:07:54 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:56840/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56840/tests/dromaeo/cssquery-prototype.html) 23:07:55 INFO - PROCESS | 18907 | RSS: Main: 164376576 23:07:55 INFO - PROCESS | 18907 | 23:10:57 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:56840/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56840/tests/dromaeo/cssquery-yui.html) 23:10:58 INFO - PROCESS | 18907 | RSS: Main: 165556224 23:10:58 INFO - PROCESS | 18907 | 23:14:00 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:56840/tests/dromaeo/cssquery-yui.html (next: http://localhost:56840/tests/dromaeo/cssquery-dojo.html) 23:14:00 INFO - PROCESS | 18907 | RSS: Main: 168984576 23:14:00 INFO - PROCESS | 18907 | 23:14:00 INFO - PROCESS | 18907 | __start_tp_report 23:14:00 INFO - PROCESS | 18907 | _x_x_mozilla_page_load 23:14:00 INFO - PROCESS | 18907 | _x_x_mozilla_page_load_details 23:14:00 INFO - PROCESS | 18907 | |i|pagename|runs| 23:14:00 INFO - PROCESS | 18907 | |0;dojo.html;3182.1726351148695;3190.920226994325;3219.5331676906835;3233.49880768481;3243.448613735665;5047.873803154923;5158.845234642962;5183.637145399819;5195.532402083812;5293.073712100377;5048.192289233723;5064.164412871881;5141.331626888508;5214.504622060907;5227.32044834171;4709.670323077377;4723.740194289313;4753.833615823447;4794.448638406576;4837.9598386346925;4653;4760.571548560629;4839.370881785363;4839.78220980055;4855.6115510759055;4705.505921878188;4740;4766.618670506386;4779.068081724083;4819.204831202847;4690.5778479936625;4699.859004229878;4707.176244157293;4729.196036673774;4754.572088512016;4667.836625718118;4691.695039822434;4695.413073365829;4702.576768090888;4731.668783185179;4968.950310496885;4993.525615066563;5004.374453193351;5087.236914462823;5114.156164232897;5459.808906688287;5471.562275018029;5491.28613280271;5514.724263786795;5528;5535.086710692771;5544.279243698294;5544.944550554484;5547.223388725582;5602.439756024365;5108.055009823194;5186.24799404088;5241.895162096736;5274.367075950872;5287.365516138088;5550.750216240279;5561.388247292794;5562.249096372019;5564.666120032811;5565.693886836182;5297.973510132501;5366;5371.677699338053;5375;5410.783568657288;5549.528290095387;5555.444455554412;5579.525740312038;5591.916121258185;5621.409751976065;5366.543843773245;5452.482014208644;5523.7238138092935;5534.08687566547;5552.056150454432;5403.756830942617;5503;5507.586930980193;5517.1172612382625;5539.833804985777;4217.367394890791;4241.97879010603;4244.554321796229;4251.234777740036;4290.806913688892;3819.770813751128;3840.1743625120735;3841.0973421245985;3865.323568375523;3865.4781604483037;5169.53474187325;5227.947720522822;5248.107821670325;5273.2617433559335;5323.707196104174;5526.640768350045;5601.579881508903;5608.579356548275;5614.29821272341;5654.9151762723595;5300.9734951325;5306.495882891119;5316.9202461963105;5322.148456246982;5366.114591092426;4695.460022097503;4721.95278047222;4732.195526760459;4744.146053710365;4783.545563171493;5859.326177489558;5869.911951320733;5871.647701137946;5886.499647529922;5922;5569.4709002645495;5610.326760788732;5616.326040875121;5623.128415095667;5635.042042852643;5707.7716891325545;5813.854653633693;5857.326407463196;5862.94137058624;5887.793927212527;5468.179773034077;5487.451254874481;5500.614956952975;5501.477359650827;5507.862303442285;5585.944140558542;5586.078297080936;5587.832365029056;5602.52378547828;5621.971890140523;5318.122509785997;5338.386085600206;5342.278792362981;5363.383210930793;5400.05499037659;5311.044012077863;5329.413764485981;5352.759125839269;5361.142217245378;5409.134538473825;5288.524032837063;5315.813946511854;5355.30381050461;5365.195220716923;5431.728413579384;5329.760160792696;5381.48875856793;5416.945830541644;5434.701091440009;5460.3993560707495;5289.814856480005;5297.576193904555;5300.469953004668;5307.708076055699;5326.866828329323 23:14:00 INFO - PROCESS | 18907 | |1;ext.html;526.4235661950163;531.9840404787856;538.262580265037;550.226931161718;553.9944600553995;32800.67199328006;33892.15269618261;34130.31739365214;34251.82874085626;34289.48565771512;35629.2874142517;35699;36217.45673814895;36226;36233.45649815248;8173;8260.586970651473;8275.213854683796;8329.583520823964;8410.411271211018;8336.124706905779;8575.399722019461;8580.613872375758;8596.785080372978;8663.913360866405;8604.612792424356;8669.869951950726;8685.131486851327;8726.912730872706;8730.607122679494;8541.316694664443;8641.870371944426;8645.827083458358;8646.178613031752;8672.566371681454;8439.535825529594;8629.482231066157;8649.913500864974;8668.479891206547;8674.392792504526;35504.11239719028;36194;36285.63714362849;36350;36428.27143457116;2754.449110177972;3038.073387616776;3268.7711860169798;3349.8995030149135;3359.0930448778695;26137.869310653514;26973.595396069075;26978.865105674347;27035.729642703518;27135.592966105523;3676.9448458273146;3737.439384092381;3773.716971227169;3792.317382871082;3835.232953409329;255269;256771;258514;258724.9999999981;259108;40044.39933401001;40766;40799;57960.71019644959;58077.70961145252;37246.25507489835;37616.24767504635;37854.81072594619;37870.81064594659;38013;13116.0818742689;13173.868261317455;13268.93365533166;13324.666883327995;13341.066125371324;10940.890591094147;11001.17491188148;11075.944620276847;11120.332780033063;11134.777304454028;13343.866561334262;13361.398737056856;13365.064445488722;13384.464621415229;13415.262160581067;5474.534664553478;5516.255305533782;5519.806806761744;5574.60977731563;5636.323641163005;945.9905400945902;996.2528103921913;997.0278977996395;1023.8668973033607;1026.9127124194526;28271.858640706665;28757.424851502852;28955.13134605965;29019.274518136794;29057.85471072631;1056.4612047855496;1058.439027315524;1082.9241953063367;1086.788076325109;1145.3242586873785;14238.28808559568;14554.636134096521;14625.78061329081;14669.706605868036;14783.556493305217;288939;289350;290349;292367.07632923825;292930;51097;51326.23010654843;51484.74257628688;51627.48372516227;51695.741521292155;1287.575100216926;1331.5006872422841;1332.5336132353598;1342.852286248512;1358.6942937839106;26557.203283901516;27978.44043119167;28282.57576136401;28584.142475725763;28590.71409285964;45247.32129018133;45402.54597454115;45503.31745023761;45569;45615.771921140185;272384;272782;273070;274837;275260;28307.858460707565;28407.573886391307;28490.287742806595;41743.373849391675;45166.32250516179;42473.36289955715;42997.785011074746;43335.566644334416;45505.77247113743;45703.542964569926;33346.4998025025;33371.499427509094;33469;33713.32573348568;33717;34531.827340863136;35329.47005794864;35678;35858.46212306766;35858.46212306766;34906.825465872505;35283.82358088193;35494.822525887204;35668.82165589155;35786.8210658945;31248.21879452941;32217.51673724849;32913.83543082269;32949;32996.34007319888;24468.388290292885;24881.377965551004;24977.625335619618;25175.74824251807;25219.747802522474 23:14:00 INFO - PROCESS | 18907 | |2;jquery.html;340.2090140423516;344.1121905483852;347.0892735491122;351.3149358750437;352.51001108459246;16707.248173832177;17100.74348884768;17382.91308543457;17621.207045682942;18298.085095745228;16315;16410.753838692428;16456.588585285375;16473.423430179948;16649.33402663892;4456.643468522519;4590.632749380042;4619;4626.953730462703;4653.581177694007;4392.0776636906285;4586.7477288749105;4600.6549508786975;4618.330342100394;4619.884502887421;4570.611498022672;4602.884927876813;4612.953870461286;4624.12141693079;4631.305304204363;4582.518835522255;4595.977020114911;4597.678162528624;5180.559652429548;5268.868278293035;4625.098105869357;4651.348811166439;4655.790489427984;4659.534046595347;4672.976635116803;9942.552585133686;10224;10241.84637230442;15648.843511564966;19531.902340488206;1964.803519648038;1999.2502811445709;2059.8970051497513;2093.413844123648;2125.0543508138885;8675.26260267878;8921.15249051339;9049.502277374742;9051.185393314567;9232.030636783174;1799.4331785487661;1835.7338185963094;1845.5201647571594;1875.8405535529496;1891.8581106417073;62878.371216287705;64051.35948640547;65950.67024664846;66296.66851665711;66507.66746166335;9274.30442716799;9277.58250878712;9475.241980641533;9529.332946693803;9736.659216927515;10454.63408780689;11102.833457498144;12227.327496987751;12265.632031039084;12333.876661233453;6518;6590.472762179014;6635.270120286765;6888;6976.441884649216;7076.646167691595;7153.35619794221;7216.96391518039;7617.923820761722;7658.463907526531;3473.6526347365566;3487.773294735834;3557.8221088945447;3573.8034408107806;3653.8173091345325;1622.6430185359202;1632.3389027443905;1635.3295148988857;1672.6152984813561;1682.1757338904094;898.6315610599622;901.8151278987792;935.209747763139;937.4984383354872;1005.9647912323034;16020.439284624983;16342.182890855647;16352.672946541003;16676.33294668224;16730;902.9548522573845;929.9256059515222;941.3034354577563;949.9050094990583;1001.9649312274036;9318.254539636813;9340.813183736287;9476.763080923032;9672.274579406572;9750.26872984529;390319;402217;402948;405412;406244;68783.65608172027;73215;73630.63184684042;74162.62918685372;75093.624531877;979.6865003198908;989.391524212604;990.9554070066864;995.7709726762885;997.2420960070253;14492.420303187755;14572.344244509235;14574.198419087052;14668;14854.554363369116;32177.678223217466;32918.835405822814;33434.83282583669;33566.160845979044;34764.30471390609;39283.21433571255;41699;41993;42249.155016898876;42611.57388426076;7307.707691692272;7457.291557302047;7527.88708169367;7617.352525035434;7719.691212351443;11313.490892910004;12365.690857728629;12374.75250494967;12510.624681259576;12603.74792504163;10113.949430252802;10901.618443354444;10933;10996.780064398827;11317.490712918103;10644.574217031231;11196.440177991231;11231.26996745209;11372;11454.083673306282;10232.795344093225;11037.889621104008;11204.159688023594;11461.598844040418;11769.52921883115;7587.620618968919;7728.574928378993;7753.844923101394;7866.803329916569;7952.761417157494;10970.670879873616;11047.337159770439;11186.776264474827;11268.492917818554;11349.659510214708 23:14:00 INFO - PROCESS | 18907 | |3;mootools.html;1432.2051261549839;1434.2971943747561;1542.5680809373373;1669.2571805546536;1696.151924037981;6121.938780612192;6660.100886380337;6670.6331151786635;6804.251532331446;6814.557053791506;6655.700493477793;6674.43267322277;6710.798676039714;6722.663866806664;6740.52816302859;2104.8316134709225;2112.2818241797786;2130.3502431758307;2132.296342207068;2139.4330502416874;2099;2117.8199853012434;2122.501212215136;2124.4051665533675;2128.053016407699;2086.238522939124;2095.6961240620103;2109.48317662173;2112.6408510553165;2114.947126321839;2107.968380474294;2112.8309735221223;2119.0146581839517;2122.713433686448;2123.1295168980646;2097.0772859941576;2180.8146307563875;2183.039462636435;2194.6049711052005;2195.9780402196093;6725.495587830883;6758.121444212221;6763.628000459973;6772.966135169293;6783.050372947791;4263.872083837458;4306.310990241546;4308.439902812645;4314.115606300701;4335.263005289077;2868.5983962245305;2935.6330458692664;2947.1747910585073;2954.4091181763733;2965.733084022448;910.6903652758094;934.8270569944514;936.3603345423478;940.5250348573995;953.0326718380849;8780.297576193889;8793.428427152214;8802.295816334678;8806.515641639708;8810.559472026373;3818.3699689551468;3850.730448868608;3909.706771992112;3922.3135951208424;3930.292547341506;7845.646945887334;7849.01887264092;7858.921410785933;7869.527828330319;7872.094709108412;4337.8264869404875;4374.759388233614;4385.254506733863;4408.074304396113;4421.977890110529;3437.570303712036;3836.4245363195746;3931.0368959604507;3959.6832253419657;3962.286788378062;3331.3337332533106;3357.462805951036;3362.2098806780386;3396.4735466002808;3415.6755108264674;1060.9469526523642;1068.4924660786219;1072.2815713471994;1084.9783004340027;1098.5880294889416;1280.9551665691656;1293.9611811645666;1319.2678063674562;1319.3864852843474;1320.2540564580981;6424.560089853987;6431.485481161496;6539.280679125292;6566.277709451956;6599.73601055962;425.31736562816855;434.548070007189;436.4631503251019;439.13928699748215;440.970334269478;5206.687598744012;5254.106801843695;5260.92108618371;5296.1261391870685;5297.54970827484;7904.802379940433;8146.5519396433765;8213.055498617616;8371.37214708887;8423.326133909273;8293;8304.626291816883;8332.958335208285;8333.458325208841;8390.538520381315;6176.99999999991;6593.3736295051895;6711.429528490035;6716.194056713226;6759.459243260528;6452.580582262138;6490.123833282447;6500.967495162683;6504.707288171949;6537.1501704778075;7376.114866216089;7405.7778266652085;7406.07424071991;7514.849703006019;7594.924050759642;7383.2985866342615;7475.663595138123;7539.962300188464;7609.353204977639;7638.083429988437;5630.887382252414;5975.223220981245;6066.514678825772;6092.512598991982;6255.374462553708;6625.933740662532;6654.13496245485;6691.063251144747;6694.698738556679;6700.195976482853;5719;5905.291365036223;5947;6126.264848218242;6293.748250069946;5921.526277897672;6024.759009639741;6042.214512113573;6103.11504831788;6138.846528836815;6040.577159598786;6067.302260239952;6086.695665216633;6207.255129384503;6207.96896015517;5893.970530147321;5897.026990546512;5923.644581325134;5930.644161350333;5945.40545945402;5772.826815195551;5797.9420205797405;5810.041343178328;5994.820155395345;6010.1285313628405 23:14:00 INFO - PROCESS | 18907 | |4;prototype.html;288.29943237931815;289.0547908339729;294.7774430305121;297.3918337000833;298.5998761659376;6114.296855861578;6207.751689932403;6237.563370564057;6255.499560035198;6288;6110.572259941806;6112.29708583513;6139.447449729523;6154.661493617849;6172.351903050182;4469.687121901468;4570.588647021767;4591.012932219573;4630.8147674093;4634.884127896796;4618.5381461853885;4621.052684199748;4623.190941585209;4623.352730617717;4624.630029597624;4583.793729282191;4584.885377865547;4585.518520555327;4585.679002469828;4587.334836448713;4593.908121837561;4595.701279416827;4599.126166028477;4603.079384123172;4605.608523275526;3935.488386509764;3939.2909276330247;3940.6847452203756;3943.132510847609;3944.3886197639126;5897.908886855946;5901.852453688693;5921.171036054956;5940.168376427304;5949.494292985101;5134.512221338967;5284.233786100994;5286.762095705702;5289.338832645919;5319.255304257407;6528.37980391862;6549.7882891665195;6563.967180164069;6565.606063636197;6567.605943643397;4283.336082907154;4302.161078589676;4312.5903039211225;4331.480222373335;4339.370791235285;6783.694733736994;6854.383105520477;6879.552829066095;6884.621345825977;6889.965550172267;4344.23975804233;4346.587074227943;4352.956470435319;4353.194658988034;4365.607095361433;4297.226499230169;4384.276594361958;4414.09511050234;4421.137878113737;4424.911501769947;5231.346081739783;5236.895262094737;5248.501392367719;5255.710935898486;5257.921131183035;6566.179227596551;6585;6592.077109204715;6618.933810661928;6632.43624291931;1554.2228885557222;1584.3583348743778;1584.9683006339808;1587.484067677986;1591.7504758764314;1005.8742657167854;1007.1187710753092;1023.9641612543526;1030.07808011829;1046.4663021858755;6326.304106548276;6327.114204011442;6328.968355158195;6387.297397286295;6410.711517981702;6777.2545020047755;6784.898226526606;6809.455243580502;6813.1142951415995;6825.317468253135;6238.719257633417;6303.117563541108;6307.306196318401;6380;6488.610683359014;3682.4844521766972;3693.1874987502706;3704.9811301892196;3710.109573702346;3721.7580857244734;7278.417726581861;7324.743633972892;7345.118585769742;7352.926470735224;7352.963235183897;6975.755848545378;7017.89473157903;7059.2234854166;7068;7069.646517674096;7127.7148914042855;7260.2013778484325;7271.418286537064;7295.744648937261;7345.375643070399;6820.556663816836;6846.828829279308;6850.280720524473;6863.519553631198;6877.2091209509545;6747.392734653905;6758.155230596176;6764.86470270582;6767.187937447341;6781.186257649114;7301.160366557701;7305.41556675454;7306.707731690885;7323.63381830917;7349.889751653623;4206.179794939957;4377.627901628397;4453.710508816916;4513.480949690827;4520.796564154687;6807.285235050248;6812.795616131524;6816.113905192492;6823.727050917908;6841.692123854339;6570.08018877348;6609;6616.272210056986;6616.966915165393;6621.404073633396;6503.349665033459;6570.11303474044;6614.603123812587;6616.470682345497;6616.536842420985;6329.810105696836;6458.967705161632;6486.870262594816;6488.351164883663;6542.313057128933;6692.59455514328;6701.597904125768;6715.932840671726;6727.159105111861;6753.2909044549615;6522.249941256627;6529.771457998947;6533.281339052795;6535.313792051957;6548.116004339544 23:14:00 INFO - PROCESS | 18907 | |5;yui.html;742.3059439424139;778.0585491555217;786.5320134519959;792.2275781113414;819.4632515702214;13304.201747895133;13519.662008449794;13520;13548.864511354883;13605;12024.939875300612;12088.093392995517;12162.878371216286;12168.965637920764;12263.938680306586;659.6207180870995;788.9881651775228;794.8529522038413;809.5709274084744;809.5992483720566;804.7666176808718;809.8420807942454;813.894193754811;814.2915663372873;815.6615004773012;840.3907167303717;843.1315744782884;843.2326582809644;845.471580262336;846.0101681033175;839.9286060684849;840.2857571064577;840.3319361107934;840.6343240690319;840.9579521023925;626.627156841683;628.7736414890636;629.9181106456132;631.9304876463585;632.8481164520527;13256.86743132566;13357;13412.731745365038;13465.932670336684;13475.595732127953;12865.614031579067;12883.613491595173;13095.672608184776;13534.052616316862;13658.658533536642;10441.947790261076;10534.157267418588;10605.575776968912;10630.681079567625;10773.5690572377;3623.0942264433893;3667.9816600917093;3701.148735790783;3705.110773414388;3829.463875057494;48903.75548122237;48908.26637600439;48946.26580601294;49122;49281.75359123218;10384.636537721144;10398.220133490018;10441.791164176673;10480.371177729361;10624.787504250025;19005.334813281468;19095.427137185907;19102.044897755055;19234;19260.422187334403;7265.9273407265255;7392.186859445456;7425;7543.283388078124;7544.132424771222;3979.7413168143976;4019.457373254573;4192.958070419318;4201.747895126302;4270.380794784739;2963.525835866251;2989.387175628991;3019.426309001283;3024.6975302469577;3027.9250865942713;518.8884389856199;533.6904595334696;535.9196120581865;540.6755946432188;548.2954403591445;510.1760656539662;582.3419535924463;595.3894714796465;620.4241227282741;646.1696719715144;8560.57197140153;8876.245519130816;8879.600417981206;8962.82074358509;8987.820243595092;578.006027918782;627.0093252660876;649.6751624187906;674.0664180110582;680.6052489556046;3780.7353485255767;3912.3349030664854;3959.9010024749614;3969.960300397017;4035.1727895781296;49582.752086240056;50206.748966254934;50932;51249;52278.21582676263;47828.7608561955;47915.520844791805;49235;49588;50038.49961500411;43501.34747978783;43856.56143438588;44581.108377832265;44586.770661467446;44623.98384145443;8048.83902321962;8264.876026859481;8454;8454.36592255571;8872.600732967161;32973.34053318968;33258.334833303685;33610.327793444485;34104.48843267303;34413.31173376468;42057.57942420537;43158.784206080025;43178;43254.783726081165;43338.56661433345;10958.39728814891;10995.34027958325;11041.730201026985;11133.220674552704;11173.88826111761;11912.40437978115;12019.278843269432;12130.393480326125;12266.75466490683;12284.447199875849;11151.944240278746;11556.248843825124;11581.594644187413;11703.23928944616;12050.698732531757;10945.562177512811;11127.276727012719;11147.163962702993;11442.94278528602;11477.36874471912;11075.833862491907;11287;11421.31472111676;11625.88374116282;12005.579804706793;9252.259819214582;9310.162085412345;9357.111074447917;9382.343235973416;9557.092076252746;8790.736277911672;9044.638214471348;9122.498262595622;9332.113449222314;9679.564419600994 23:14:00 INFO - PROCESS | 18907 | __end_tp_report 23:14:00 INFO - PROCESS | 18907 | __start_cc_report 23:14:00 INFO - PROCESS | 18907 | _x_x_mozilla_cycle_collect,325 23:14:00 INFO - PROCESS | 18907 | __end_cc_report 23:14:00 INFO - PROCESS | 18907 | __startTimestamp1456816440844__endTimestamp 23:14:00 INFO - PROCESS | 18907 | 23:14:00 INFO - PROCESS | 18907 | ------- Summary: start ------- 23:14:00 INFO - PROCESS | 18907 | Number of tests: 6 23:14:00 INFO - PROCESS | 18907 | 23:14:00 INFO - PROCESS | 18907 | [#0] dojo.html Cycles:165 Average:5158.24 Median:5323.71 stddev:558.14 (10.5%) stddev-sans-first:537.89 23:14:00 INFO - PROCESS | 18907 | Values: 3182.2 3190.9 3219.5 3233.5 3243.4 5047.9 5158.8 5183.6 5195.5 5293.1 5048.2 5064.2 5141.3 5214.5 5227.3 4709.7 4723.7 4753.8 4794.4 4838.0 4653.0 4760.6 4839.4 4839.8 4855.6 4705.5 4740.0 4766.6 4779.1 4819.2 4690.6 4699.9 4707.2 4729.2 4754.6 4667.8 4691.7 4695.4 4702.6 4731.7 4969.0 4993.5 5004.4 5087.2 5114.2 5459.8 5471.6 5491.3 5514.7 5528.0 5535.1 5544.3 5544.9 5547.2 5602.4 5108.1 5186.2 5241.9 5274.4 5287.4 5550.8 5561.4 5562.2 5564.7 5565.7 5298.0 5366.0 5371.7 5375.0 5410.8 5549.5 5555.4 5579.5 5591.9 5621.4 5366.5 5452.5 5523.7 5534.1 5552.1 5403.8 5503.0 5507.6 5517.1 5539.8 4217.4 4242.0 4244.6 4251.2 4290.8 3819.8 3840.2 3841.1 3865.3 3865.5 5169.5 5227.9 5248.1 5273.3 5323.7 5526.6 5601.6 5608.6 5614.3 5654.9 5301.0 5306.5 5316.9 5322.1 5366.1 4695.5 4722.0 4732.2 4744.1 4783.5 5859.3 5869.9 5871.6 5886.5 5922.0 5569.5 5610.3 5616.3 5623.1 5635.0 5707.8 5813.9 5857.3 5862.9 5887.8 5468.2 5487.5 5500.6 5501.5 5507.9 5585.9 5586.1 5587.8 5602.5 5622.0 5318.1 5338.4 5342.3 5363.4 5400.1 5311.0 5329.4 5352.8 5361.1 5409.1 5288.5 5315.8 5355.3 5365.2 5431.7 5329.8 5381.5 5416.9 5434.7 5460.4 5289.8 5297.6 5300.5 5307.7 5326.9 23:14:00 INFO - PROCESS | 18907 | 23:14:00 INFO - PROCESS | 18907 | [#1] ext.html Cycles:180 Average:42934.80 Median:34719.33 stddev:71623.94 (206.3%) stddev-sans-first:71754.08 23:14:00 INFO - PROCESS | 18907 | Values: 526.4 532.0 538.3 550.2 554.0 32800.7 33892.2 34130.3 34251.8 34289.5 35629.3 35699.0 36217.5 36226.0 36233.5 8173.0 8260.6 8275.2 8329.6 8410.4 8336.1 8575.4 8580.6 8596.8 8663.9 8604.6 8669.9 8685.1 8726.9 8730.6 8541.3 8641.9 8645.8 8646.2 8672.6 8439.5 8629.5 8649.9 8668.5 8674.4 35504.1 36194.0 36285.6 36350.0 36428.3 2754.4 3038.1 3268.8 3349.9 3359.1 26137.9 26973.6 26978.9 27035.7 27135.6 3676.9 3737.4 3773.7 3792.3 3835.2 255269.0 256771.0 258514.0 258725.0 259108.0 40044.4 40766.0 40799.0 57960.7 58077.7 37246.3 37616.2 37854.8 37870.8 38013.0 13116.1 13173.9 13268.9 13324.7 13341.1 10940.9 11001.2 11075.9 11120.3 11134.8 13343.9 13361.4 13365.1 13384.5 13415.3 5474.5 5516.3 5519.8 5574.6 5636.3 946.0 996.3 997.0 1023.9 1026.9 28271.9 28757.4 28955.1 29019.3 29057.9 1056.5 1058.4 1082.9 1086.8 1145.3 14238.3 14554.6 14625.8 14669.7 14783.6 288939.0 289350.0 290349.0 292367.1 292930.0 51097.0 51326.2 51484.7 51627.5 51695.7 1287.6 1331.5 1332.5 1342.9 1358.7 26557.2 27978.4 28282.6 28584.1 28590.7 45247.3 45402.5 45503.3 45569.0 45615.8 272384.0 272782.0 273070.0 274837.0 275260.0 28307.9 28407.6 28490.3 41743.4 45166.3 42473.4 42997.8 43335.6 45505.8 45703.5 33346.5 33371.5 33469.0 33713.3 33717.0 34531.8 35329.5 35678.0 35858.5 35858.5 34906.8 35283.8 35494.8 35668.8 35786.8 31248.2 32217.5 32913.8 32949.0 32996.3 24468.4 24881.4 24977.6 25175.7 25219.7 23:14:00 INFO - PROCESS | 18907 | 23:14:00 INFO - PROCESS | 18907 | [#2] jquery.html Cycles:180 Average:23713.57 Median:405828.00 stddev:66009.22 (16.3%) stddev-sans-first:66171.06 23:14:00 INFO - PROCESS | 18907 | Values: 340.2 344.1 347.1 351.3 352.5 16707.2 17100.7 17382.9 17621.2 18298.1 16315.0 16410.8 16456.6 16473.4 16649.3 4456.6 4590.6 4619.0 4627.0 4653.6 4392.1 4586.7 4600.7 4618.3 4619.9 4570.6 4602.9 4613.0 4624.1 4631.3 4582.5 4596.0 4597.7 5180.6 5268.9 4625.1 4651.3 4655.8 4659.5 4673.0 9942.6 10224.0 10241.8 15648.8 19531.9 1964.8 1999.3 2059.9 2093.4 2125.1 8675.3 8921.2 9049.5 9051.2 9232.0 1799.4 1835.7 1845.5 1875.8 1891.9 62878.4 64051.4 65950.7 66296.7 66507.7 9274.3 9277.6 9475.2 9529.3 9736.7 10454.6 11102.8 12227.3 12265.6 12333.9 6518.0 6590.5 6635.3 6888.0 6976.4 7076.6 7153.4 7217.0 7617.9 7658.5 3473.7 3487.8 3557.8 3573.8 3653.8 1622.6 1632.3 1635.3 1672.6 1682.2 898.6 901.8 935.2 937.5 1006.0 16020.4 16342.2 16352.7 16676.3 16730.0 903.0 929.9 941.3 949.9 1002.0 9318.3 9340.8 9476.8 9672.3 9750.3 390319.0 402217.0 402948.0 405412.0 406244.0 68783.7 73215.0 73630.6 74162.6 75093.6 979.7 989.4 991.0 995.8 997.2 14492.4 14572.3 14574.2 14668.0 14854.6 32177.7 32918.8 33434.8 33566.2 34764.3 39283.2 41699.0 41993.0 42249.2 42611.6 7307.7 7457.3 7527.9 7617.4 7719.7 11313.5 12365.7 12374.8 12510.6 12603.7 10113.9 10901.6 10933.0 10996.8 11317.5 10644.6 11196.4 11231.3 11372.0 11454.1 10232.8 11037.9 11204.2 11461.6 11769.5 7587.6 7728.6 7753.8 7866.8 7952.8 10970.7 11047.3 11186.8 11268.5 11349.7 23:14:00 INFO - PROCESS | 18907 | 23:14:00 INFO - PROCESS | 18907 | [#3] mootools.html Cycles:180 Average:4845.00 Median:5938.02 stddev:2424.07 (40.8%) stddev-sans-first:2417.30 23:14:00 INFO - PROCESS | 18907 | Values: 1432.2 1434.3 1542.6 1669.3 1696.2 6121.9 6660.1 6670.6 6804.3 6814.6 6655.7 6674.4 6710.8 6722.7 6740.5 2104.8 2112.3 2130.4 2132.3 2139.4 2099.0 2117.8 2122.5 2124.4 2128.1 2086.2 2095.7 2109.5 2112.6 2114.9 2108.0 2112.8 2119.0 2122.7 2123.1 2097.1 2180.8 2183.0 2194.6 2196.0 6725.5 6758.1 6763.6 6773.0 6783.1 4263.9 4306.3 4308.4 4314.1 4335.3 2868.6 2935.6 2947.2 2954.4 2965.7 910.7 934.8 936.4 940.5 953.0 8780.3 8793.4 8802.3 8806.5 8810.6 3818.4 3850.7 3909.7 3922.3 3930.3 7845.6 7849.0 7858.9 7869.5 7872.1 4337.8 4374.8 4385.3 4408.1 4422.0 3437.6 3836.4 3931.0 3959.7 3962.3 3331.3 3357.5 3362.2 3396.5 3415.7 1060.9 1068.5 1072.3 1085.0 1098.6 1281.0 1294.0 1319.3 1319.4 1320.3 6424.6 6431.5 6539.3 6566.3 6599.7 425.3 434.5 436.5 439.1 441.0 5206.7 5254.1 5260.9 5296.1 5297.5 7904.8 8146.6 8213.1 8371.4 8423.3 8293.0 8304.6 8333.0 8333.5 8390.5 6177.0 6593.4 6711.4 6716.2 6759.5 6452.6 6490.1 6501.0 6504.7 6537.2 7376.1 7405.8 7406.1 7514.8 7594.9 7383.3 7475.7 7540.0 7609.4 7638.1 5630.9 5975.2 6066.5 6092.5 6255.4 6625.9 6654.1 6691.1 6694.7 6700.2 5719.0 5905.3 5947.0 6126.3 6293.7 5921.5 6024.8 6042.2 6103.1 6138.8 6040.6 6067.3 6086.7 6207.3 6208.0 5894.0 5897.0 5923.6 5930.6 5945.4 5772.8 5797.9 5810.0 5994.8 6010.1 23:14:00 INFO - PROCESS | 18907 | 23:14:00 INFO - PROCESS | 18907 | [#4] prototype.html Cycles:180 Average:5471.81 Median:6295.56 stddev:1739.32 (27.6%) stddev-sans-first:1700.12 23:14:00 INFO - PROCESS | 18907 | Values: 288.3 289.1 294.8 297.4 298.6 6114.3 6207.8 6237.6 6255.5 6288.0 6110.6 6112.3 6139.4 6154.7 6172.4 4469.7 4570.6 4591.0 4630.8 4634.9 4618.5 4621.1 4623.2 4623.4 4624.6 4583.8 4584.9 4585.5 4585.7 4587.3 4593.9 4595.7 4599.1 4603.1 4605.6 3935.5 3939.3 3940.7 3943.1 3944.4 5897.9 5901.9 5921.2 5940.2 5949.5 5134.5 5284.2 5286.8 5289.3 5319.3 6528.4 6549.8 6564.0 6565.6 6567.6 4283.3 4302.2 4312.6 4331.5 4339.4 6783.7 6854.4 6879.6 6884.6 6890.0 4344.2 4346.6 4353.0 4353.2 4365.6 4297.2 4384.3 4414.1 4421.1 4424.9 5231.3 5236.9 5248.5 5255.7 5257.9 6566.2 6585.0 6592.1 6618.9 6632.4 1554.2 1584.4 1585.0 1587.5 1591.8 1005.9 1007.1 1024.0 1030.1 1046.5 6326.3 6327.1 6329.0 6387.3 6410.7 6777.3 6784.9 6809.5 6813.1 6825.3 6238.7 6303.1 6307.3 6380.0 6488.6 3682.5 3693.2 3705.0 3710.1 3721.8 7278.4 7324.7 7345.1 7352.9 7353.0 6975.8 7017.9 7059.2 7068.0 7069.6 7127.7 7260.2 7271.4 7295.7 7345.4 6820.6 6846.8 6850.3 6863.5 6877.2 6747.4 6758.2 6764.9 6767.2 6781.2 7301.2 7305.4 7306.7 7323.6 7349.9 4206.2 4377.6 4453.7 4513.5 4520.8 6807.3 6812.8 6816.1 6823.7 6841.7 6570.1 6609.0 6616.3 6617.0 6621.4 6503.3 6570.1 6614.6 6616.5 6616.5 6329.8 6459.0 6486.9 6488.4 6542.3 6692.6 6701.6 6715.9 6727.2 6753.3 6522.2 6529.8 6533.3 6535.3 6548.1 23:14:00 INFO - PROCESS | 18907 | 23:14:00 INFO - PROCESS | 18907 | [#5] yui.html Cycles:180 Average:13448.56 Median:43678.95 stddev:15120.12 (34.6%) stddev-sans-first:15132.42 23:14:00 INFO - PROCESS | 18907 | Values: 742.3 778.1 786.5 792.2 819.5 13304.2 13519.7 13520.0 13548.9 13605.0 12024.9 12088.1 12162.9 12169.0 12263.9 659.6 789.0 794.9 809.6 809.6 804.8 809.8 813.9 814.3 815.7 840.4 843.1 843.2 845.5 846.0 839.9 840.3 840.3 840.6 841.0 626.6 628.8 629.9 631.9 632.8 13256.9 13357.0 13412.7 13465.9 13475.6 12865.6 12883.6 13095.7 13534.1 13658.7 10441.9 10534.2 10605.6 10630.7 10773.6 3623.1 3668.0 3701.1 3705.1 3829.5 48903.8 48908.3 48946.3 49122.0 49281.8 10384.6 10398.2 10441.8 10480.4 10624.8 19005.3 19095.4 19102.0 19234.0 19260.4 7265.9 7392.2 7425.0 7543.3 7544.1 3979.7 4019.5 4193.0 4201.7 4270.4 2963.5 2989.4 3019.4 3024.7 3027.9 518.9 533.7 535.9 540.7 548.3 510.2 582.3 595.4 620.4 646.2 8560.6 8876.2 8879.6 8962.8 8987.8 578.0 627.0 649.7 674.1 680.6 3780.7 3912.3 3959.9 3970.0 4035.2 49582.8 50206.7 50932.0 51249.0 52278.2 47828.8 47915.5 49235.0 49588.0 50038.5 43501.3 43856.6 44581.1 44586.8 44624.0 8048.8 8264.9 8454.0 8454.4 8872.6 32973.3 33258.3 33610.3 34104.5 34413.3 42057.6 43158.8 43178.0 43254.8 43338.6 10958.4 10995.3 11041.7 11133.2 11173.9 11912.4 12019.3 12130.4 12266.8 12284.4 11151.9 11556.2 11581.6 11703.2 12050.7 10945.6 11127.3 11147.2 11442.9 11477.4 11075.8 11287.0 11421.3 11625.9 12005.6 9252.3 9310.2 9357.1 9382.3 9557.1 8790.7 9044.6 9122.5 9332.1 9679.6 23:14:00 INFO - PROCESS | 18907 | -------- Summary: end -------- 23:14:00 INFO - PROCESS | 18907 | 23:14:00 INFO - PROCESS | 18907 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:00 INFO - PROCESS | 18907 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:00 INFO - PROCESS | 18907 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:00 INFO - PROCESS | 18907 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:00 INFO - PROCESS | 18907 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:00 INFO - PROCESS | 18907 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:00 INFO - PROCESS | 18907 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:00 INFO - PROCESS | 18907 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:00 INFO - PROCESS | 18907 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:00 INFO - PROCESS | 18907 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:00 INFO - PROCESS | 18907 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:01 INFO - TEST-INFO | 18907: exit 0 23:14:01 INFO - TEST-OK | dromaeo_css | took 1110277ms 23:14:01 INFO - TEST-START | kraken 23:14:01 INFO - operating with platform_type : linux_ 23:14:01 INFO - Initialising browser for kraken test... 23:14:01 INFO - TEST-INFO | started process 19140 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVE6Ihd/profile http://localhost:56840/getInfo.html) 23:14:05 INFO - PROCESS | 19140 | 23:14:05 INFO - PROCESS | 19140 | (process:19211): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:14:05 INFO - PROCESS | 19140 | __metrics Screen width/height:1600/1200 23:14:05 INFO - PROCESS | 19140 | colorDepth:24 23:14:05 INFO - PROCESS | 19140 | Browser inner width/height: 1024/697 23:14:05 INFO - PROCESS | 19140 | __metrics 23:14:06 ERROR - PROCESS | 19140 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 23:14:06 INFO - PROCESS | 19140 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:06 INFO - PROCESS | 19140 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:06 INFO - PROCESS | 19140 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:06 INFO - PROCESS | 19140 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:06 INFO - PROCESS | 19140 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:06 INFO - PROCESS | 19140 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:06 INFO - PROCESS | 19140 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:06 INFO - PROCESS | 19140 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:06 INFO - PROCESS | 19140 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:14:07 INFO - TEST-INFO | 19140: exit 0 23:14:07 INFO - Browser initialized. 23:14:07 INFO - Running cycle 1/1 for kraken test... 23:14:07 INFO - TEST-INFO | started process 19262 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVE6Ihd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:08 INFO - PROCESS | 19262 | 23:14:08 INFO - PROCESS | 19262 | (process:19321): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:14:19 INFO - PROCESS | 19262 | RSS: Main: 161157120 23:14:19 INFO - PROCESS | 19262 | 23:14:21 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56840/tests/kraken/driver.html?testName=audio-beat-detection) 23:14:22 INFO - PROCESS | 19262 | RSS: Main: 167714816 23:14:22 INFO - PROCESS | 19262 | 23:14:24 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56840/tests/kraken/driver.html?testName=audio-dft) 23:14:25 INFO - PROCESS | 19262 | RSS: Main: 170090496 23:14:25 INFO - PROCESS | 19262 | 23:14:28 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56840/tests/kraken/driver.html?testName=audio-fft) 23:14:28 INFO - PROCESS | 19262 | RSS: Main: 166563840 23:14:28 INFO - PROCESS | 19262 | 23:14:30 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56840/tests/kraken/driver.html?testName=audio-oscillator) 23:14:31 INFO - PROCESS | 19262 | RSS: Main: 166969344 23:14:31 INFO - PROCESS | 19262 | 23:14:33 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56840/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:14:34 INFO - PROCESS | 19262 | RSS: Main: 167362560 23:14:34 INFO - PROCESS | 19262 | 23:14:37 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56840/tests/kraken/driver.html?testName=imaging-darkroom) 23:14:37 INFO - PROCESS | 19262 | RSS: Main: 166969344 23:14:37 INFO - PROCESS | 19262 | 23:14:41 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56840/tests/kraken/driver.html?testName=imaging-desaturate) 23:14:41 INFO - PROCESS | 19262 | RSS: Main: 167481344 23:14:41 INFO - PROCESS | 19262 | 23:14:44 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56840/tests/kraken/driver.html?testName=json-parse-financial) 23:14:45 INFO - PROCESS | 19262 | RSS: Main: 167632896 23:14:45 INFO - PROCESS | 19262 | 23:14:46 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56840/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:14:47 INFO - PROCESS | 19262 | RSS: Main: 168194048 23:14:47 INFO - PROCESS | 19262 | 23:14:49 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56840/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:14:49 INFO - PROCESS | 19262 | RSS: Main: 166150144 23:14:49 INFO - PROCESS | 19262 | 23:14:51 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56840/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:14:52 INFO - PROCESS | 19262 | RSS: Main: 166330368 23:14:52 INFO - PROCESS | 19262 | 23:14:55 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56840/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:14:55 INFO - PROCESS | 19262 | RSS: Main: 166522880 23:14:55 INFO - PROCESS | 19262 | 23:14:58 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56840/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:14:58 INFO - PROCESS | 19262 | RSS: Main: 166260736 23:14:58 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | Cycle 1(1): loaded http://localhost:56840/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56840/tests/kraken/driver.html?testName=ai-astar) 23:15:00 INFO - PROCESS | 19262 | RSS: Main: 168976384 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | __start_tp_report 23:15:00 INFO - PROCESS | 19262 | _x_x_mozilla_page_load 23:15:00 INFO - PROCESS | 19262 | _x_x_mozilla_page_load_details 23:15:00 INFO - PROCESS | 19262 | |i|pagename|runs| 23:15:00 INFO - PROCESS | 19262 | |0;ai-astar;115;108;114;112;115;123;113;113;113;113 23:15:00 INFO - PROCESS | 19262 | |1;audio-beat-detection;160;131;155;163;129;150;151;127;175;126 23:15:00 INFO - PROCESS | 19262 | |2;audio-dft;161;165;163;165;163;161;168;177;166;165 23:15:00 INFO - PROCESS | 19262 | |3;audio-fft;74;74;73;73;76;142;72;72;72;73 23:15:00 INFO - PROCESS | 19262 | |4;audio-oscillator;96;97;138;95;95;95;141;96;96;142 23:15:00 INFO - PROCESS | 19262 | |5;imaging-gaussian-blur;119;115;115;115;116;115;115;116;117;115 23:15:00 INFO - PROCESS | 19262 | |6;imaging-darkroom;147;150;146;148;147;147;150;147;146;147 23:15:00 INFO - PROCESS | 19262 | |7;imaging-desaturate;96;96;97;96;96;96;97;97;97;96 23:15:00 INFO - PROCESS | 19262 | |8;json-parse-financial;57;60;57;56;61;58;58;66;56;57 23:15:00 INFO - PROCESS | 19262 | |9;json-stringify-tinderbox;68;68;67;69;68;68;68;67;69;72 23:15:00 INFO - PROCESS | 19262 | |10;stanford-crypto-aes;81;82;85;90;84;83;83;82;81;83 23:15:00 INFO - PROCESS | 19262 | |11;stanford-crypto-ccm;122;126;119;117;130;125;117;126;117;123 23:15:00 INFO - PROCESS | 19262 | |12;stanford-crypto-pbkdf2;152;160;154;158;166;141;159;146;155;145 23:15:00 INFO - PROCESS | 19262 | |13;stanford-crypto-sha256-iterative;72;71;72;75;72;68;69;72;70;70 23:15:00 INFO - PROCESS | 19262 | __end_tp_report 23:15:00 INFO - PROCESS | 19262 | __start_cc_report 23:15:00 INFO - PROCESS | 19262 | _x_x_mozilla_cycle_collect,780 23:15:00 INFO - PROCESS | 19262 | __end_cc_report 23:15:00 INFO - PROCESS | 19262 | __startTimestamp1456816500863__endTimestamp 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | ------- Summary: start ------- 23:15:00 INFO - PROCESS | 19262 | Number of tests: 14 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#0] ai-astar Cycles:10 Average:113.90 Median:113.50 stddev:3.75 (3.3%) stddev-sans-first:3.96 23:15:00 INFO - PROCESS | 19262 | Values: 115.0 108.0 114.0 112.0 115.0 123.0 113.0 113.0 113.0 113.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:153.00 stddev:17.38 (11.4%) stddev-sans-first:17.75 23:15:00 INFO - PROCESS | 19262 | Values: 160.0 131.0 155.0 163.0 129.0 150.0 151.0 127.0 175.0 126.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:4.62 (2.8%) stddev-sans-first:4.62 23:15:00 INFO - PROCESS | 19262 | Values: 161.0 165.0 163.0 165.0 163.0 161.0 168.0 177.0 166.0 165.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#3] audio-fft Cycles:10 Average:80.10 Median:73.00 stddev:21.78 (29.8%) stddev-sans-first:22.99 23:15:00 INFO - PROCESS | 19262 | Values: 74.0 74.0 73.0 73.0 76.0 142.0 72.0 72.0 72.0 73.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:95.50 stddev:21.58 (22.6%) stddev-sans-first:22.37 23:15:00 INFO - PROCESS | 19262 | Values: 96.0 97.0 138.0 95.0 95.0 95.0 141.0 96.0 96.0 142.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:115.50 stddev:1.32 (1.1%) stddev-sans-first:0.73 23:15:00 INFO - PROCESS | 19262 | Values: 119.0 115.0 115.0 115.0 116.0 115.0 115.0 116.0 117.0 115.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:1.43 (1.0%) stddev-sans-first:1.51 23:15:00 INFO - PROCESS | 19262 | Values: 147.0 150.0 146.0 148.0 147.0 147.0 150.0 147.0 146.0 147.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:15:00 INFO - PROCESS | 19262 | Values: 96.0 96.0 97.0 96.0 96.0 96.0 97.0 97.0 97.0 96.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:3.06 (5.3%) stddev-sans-first:3.19 23:15:00 INFO - PROCESS | 19262 | Values: 57.0 60.0 57.0 56.0 61.0 58.0 58.0 66.0 56.0 57.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 23:15:00 INFO - PROCESS | 19262 | Values: 68.0 68.0 67.0 69.0 68.0 68.0 68.0 67.0 69.0 72.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.63 (3.2%) stddev-sans-first:2.65 23:15:00 INFO - PROCESS | 19262 | Values: 81.0 82.0 85.0 90.0 84.0 83.0 83.0 82.0 81.0 83.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#11] stanford-crypto-ccm Cycles:10 Average:122.20 Median:124.00 stddev:4.59 (3.7%) stddev-sans-first:4.87 23:15:00 INFO - PROCESS | 19262 | Values: 122.0 126.0 119.0 117.0 130.0 125.0 117.0 126.0 117.0 123.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:156.50 stddev:7.73 (4.9%) stddev-sans-first:8.18 23:15:00 INFO - PROCESS | 19262 | Values: 152.0 160.0 154.0 158.0 166.0 141.0 159.0 146.0 155.0 145.0 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:72.00 stddev:1.97 (2.7%) stddev-sans-first:2.06 23:15:00 INFO - PROCESS | 19262 | Values: 72.0 71.0 72.0 75.0 72.0 68.0 69.0 72.0 70.0 70.0 23:15:00 INFO - PROCESS | 19262 | -------- Summary: end -------- 23:15:00 INFO - PROCESS | 19262 | 23:15:00 INFO - PROCESS | 19262 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:15:00 INFO - PROCESS | 19262 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:15:00 INFO - PROCESS | 19262 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:15:00 INFO - PROCESS | 19262 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:15:00 INFO - PROCESS | 19262 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:15:00 INFO - PROCESS | 19262 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:15:00 INFO - PROCESS | 19262 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 23:15:01 INFO - TEST-INFO | 19262: exit 0 23:15:01 INFO - TEST-OK | kraken | took 60319ms 23:15:01 INFO - SUITE-END | took 1170s 23:15:02 INFO - Completed test suite (00:19:30) 23:15:02 INFO - Working with test: dromaeo_css 23:15:02 INFO - Generating results file: dromaeo_css 23:15:02 INFO - Working with test: kraken 23:15:02 INFO - Generating results file: kraken 23:15:02 INFO - javascript benchmark 23:15:02 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:02 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:15:02 INFO - process_Request line: dromaeo_css 6612.89 graph.html#tests=[[72,64,43]] 23:15:02 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:02 INFO - process_Request line: kraken 1532.20 graph.html#tests=[[232,64,43]] 23:15:02 INFO - RETURN: dromaeo_css: 6612.89 23:15:02 INFO - RETURN: kraken: 1532.20 23:15:02 INFO - javascript benchmark 23:15:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3182.1726351148695, 3190.920226994325, 3219.5331676906835, 3233.49880768481, 3243.448613735665, 5047.873803154923, 5158.845234642962, 5183.637145399819, 5195.532402083812, 5293.073712100377, 5048.192289233723, 5064.164412871881, 5141.331626888508, 5214.504622060907, 5227.32044834171, 4709.670323077377, 4723.740194289313, 4753.833615823447, 4794.448638406576, 4837.9598386346925, 4653.0, 4760.571548560629, 4839.370881785363, 4839.78220980055, 4855.6115510759055, 4705.505921878188, 4740.0, 4766.618670506386, 4779.068081724083, 4819.204831202847, 4690.5778479936625, 4699.859004229878, 4707.176244157293, 4729.196036673774, 4754.572088512016, 4667.836625718118, 4691.695039822434, 4695.413073365829, 4702.576768090888, 4731.668783185179, 4968.950310496885, 4993.525615066563, 5004.374453193351, 5087.236914462823, 5114.156164232897, 5459.808906688287, 5471.562275018029, 5491.28613280271, 5514.724263786795, 5528.0, 5535.086710692771, 5544.279243698294, 5544.944550554484, 5547.223388725582, 5602.439756024365, 5108.055009823194, 5186.24799404088, 5241.895162096736, 5274.367075950872, 5287.365516138088, 5550.750216240279, 5561.388247292794, 5562.249096372019, 5564.666120032811, 5565.693886836182, 5297.973510132501, 5366.0, 5371.677699338053, 5375.0, 5410.783568657288, 5549.528290095387, 5555.444455554412, 5579.525740312038, 5591.916121258185, 5621.409751976065, 5366.543843773245, 5452.482014208644, 5523.7238138092935, 5534.08687566547, 5552.056150454432, 5403.756830942617, 5503.0, 5507.586930980193, 5517.1172612382625, 5539.833804985777, 4217.367394890791, 4241.97879010603, 4244.554321796229, 4251.234777740036, 4290.806913688892, 3819.770813751128, 3840.1743625120735, 3841.0973421245985, 3865.323568375523, 3865.4781604483037, 5169.53474187325, 5227.947720522822, 5248.107821670325, 5273.2617433559335, 5323.707196104174, 5526.640768350045, 5601.579881508903, 5608.579356548275, 5614.29821272341, 5654.9151762723595, 5300.9734951325, 5306.495882891119, 5316.9202461963105, 5322.148456246982, 5366.114591092426, 4695.460022097503, 4721.95278047222, 4732.195526760459, 4744.146053710365, 4783.545563171493, 5859.326177489558, 5869.911951320733, 5871.647701137946, 5886.499647529922, 5922.0, 5569.4709002645495, 5610.326760788732, 5616.326040875121, 5623.128415095667, 5635.042042852643, 5707.7716891325545, 5813.854653633693, 5857.326407463196, 5862.94137058624, 5887.793927212527, 5468.179773034077, 5487.451254874481, 5500.614956952975, 5501.477359650827, 5507.862303442285, 5585.944140558542, 5586.078297080936, 5587.832365029056, 5602.52378547828, 5621.971890140523, 5318.122509785997, 5338.386085600206, 5342.278792362981, 5363.383210930793, 5400.05499037659, 5311.044012077863, 5329.413764485981, 5352.759125839269, 5361.142217245378, 5409.134538473825, 5288.524032837063, 5315.813946511854, 5355.30381050461, 5365.195220716923, 5431.728413579384, 5329.760160792696, 5381.48875856793, 5416.945830541644, 5434.701091440009, 5460.3993560707495, 5289.814856480005, 5297.576193904555, 5300.469953004668, 5307.708076055699, 5326.866828329323], "unit": "score", "name": "dojo.html", "value": 5123.5077032694435}, {"lowerIsBetter": false, "replicates": [526.4235661950163, 531.9840404787856, 538.262580265037, 550.226931161718, 553.9944600553995, 32800.67199328006, 33892.15269618261, 34130.31739365214, 34251.82874085626, 34289.48565771512, 35629.2874142517, 35699.0, 36217.45673814895, 36226.0, 36233.45649815248, 8173.0, 8260.586970651473, 8275.213854683796, 8329.583520823964, 8410.411271211018, 8336.124706905779, 8575.399722019461, 8580.613872375758, 8596.785080372978, 8663.913360866405, 8604.612792424356, 8669.869951950726, 8685.131486851327, 8726.912730872706, 8730.607122679494, 8541.316694664443, 8641.870371944426, 8645.827083458358, 8646.178613031752, 8672.566371681454, 8439.535825529594, 8629.482231066157, 8649.913500864974, 8668.479891206547, 8674.392792504526, 35504.11239719028, 36194.0, 36285.63714362849, 36350.0, 36428.27143457116, 2754.449110177972, 3038.073387616776, 3268.7711860169798, 3349.8995030149135, 3359.0930448778695, 26137.869310653514, 26973.595396069075, 26978.865105674347, 27035.729642703518, 27135.592966105523, 3676.9448458273146, 3737.439384092381, 3773.716971227169, 3792.317382871082, 3835.232953409329, 255269.0, 256771.0, 258514.0, 258724.9999999981, 259108.0, 40044.39933401001, 40766.0, 40799.0, 57960.71019644959, 58077.70961145252, 37246.25507489835, 37616.24767504635, 37854.81072594619, 37870.81064594659, 38013.0, 13116.0818742689, 13173.868261317455, 13268.93365533166, 13324.666883327995, 13341.066125371324, 10940.890591094147, 11001.17491188148, 11075.944620276847, 11120.332780033063, 11134.777304454028, 13343.866561334262, 13361.398737056856, 13365.064445488722, 13384.464621415229, 13415.262160581067, 5474.534664553478, 5516.255305533782, 5519.806806761744, 5574.60977731563, 5636.323641163005, 945.9905400945902, 996.2528103921913, 997.0278977996395, 1023.8668973033607, 1026.9127124194526, 28271.858640706665, 28757.424851502852, 28955.13134605965, 29019.274518136794, 29057.85471072631, 1056.4612047855496, 1058.439027315524, 1082.9241953063367, 1086.788076325109, 1145.3242586873785, 14238.28808559568, 14554.636134096521, 14625.78061329081, 14669.706605868036, 14783.556493305217, 288939.0, 289350.0, 290349.0, 292367.07632923825, 292930.0, 51097.0, 51326.23010654843, 51484.74257628688, 51627.48372516227, 51695.741521292155, 1287.575100216926, 1331.5006872422841, 1332.5336132353598, 1342.852286248512, 1358.6942937839106, 26557.203283901516, 27978.44043119167, 28282.57576136401, 28584.142475725763, 28590.71409285964, 45247.32129018133, 45402.54597454115, 45503.31745023761, 45569.0, 45615.771921140185, 272384.0, 272782.0, 273070.0, 274837.0, 275260.0, 28307.858460707565, 28407.573886391307, 28490.287742806595, 41743.373849391675, 45166.32250516179, 42473.36289955715, 42997.785011074746, 43335.566644334416, 45505.77247113743, 45703.542964569926, 33346.4998025025, 33371.499427509094, 33469.0, 33713.32573348568, 33717.0, 34531.827340863136, 35329.47005794864, 35678.0, 35858.46212306766, 35858.46212306766, 34906.825465872505, 35283.82358088193, 35494.822525887204, 35668.82165589155, 35786.8210658945, 31248.21879452941, 32217.51673724849, 32913.83543082269, 32949.0, 32996.34007319888, 24468.388290292885, 24881.377965551004, 24977.625335619618, 25175.74824251807, 25219.747802522474], "unit": "score", "name": "ext.html", "value": 17173.721556764773}, {"lowerIsBetter": false, "replicates": [340.2090140423516, 344.1121905483852, 347.0892735491122, 351.3149358750437, 352.51001108459246, 16707.248173832177, 17100.74348884768, 17382.91308543457, 17621.207045682942, 18298.085095745228, 16315.0, 16410.753838692428, 16456.588585285375, 16473.423430179948, 16649.33402663892, 4456.643468522519, 4590.632749380042, 4619.0, 4626.953730462703, 4653.581177694007, 4392.0776636906285, 4586.7477288749105, 4600.6549508786975, 4618.330342100394, 4619.884502887421, 4570.611498022672, 4602.884927876813, 4612.953870461286, 4624.12141693079, 4631.305304204363, 4582.518835522255, 4595.977020114911, 4597.678162528624, 5180.559652429548, 5268.868278293035, 4625.098105869357, 4651.348811166439, 4655.790489427984, 4659.534046595347, 4672.976635116803, 9942.552585133686, 10224.0, 10241.84637230442, 15648.843511564966, 19531.902340488206, 1964.803519648038, 1999.2502811445709, 2059.8970051497513, 2093.413844123648, 2125.0543508138885, 8675.26260267878, 8921.15249051339, 9049.502277374742, 9051.185393314567, 9232.030636783174, 1799.4331785487661, 1835.7338185963094, 1845.5201647571594, 1875.8405535529496, 1891.8581106417073, 62878.371216287705, 64051.35948640547, 65950.67024664846, 66296.66851665711, 66507.66746166335, 9274.30442716799, 9277.58250878712, 9475.241980641533, 9529.332946693803, 9736.659216927515, 10454.63408780689, 11102.833457498144, 12227.327496987751, 12265.632031039084, 12333.876661233453, 6518.0, 6590.472762179014, 6635.270120286765, 6888.0, 6976.441884649216, 7076.646167691595, 7153.35619794221, 7216.96391518039, 7617.923820761722, 7658.463907526531, 3473.6526347365566, 3487.773294735834, 3557.8221088945447, 3573.8034408107806, 3653.8173091345325, 1622.6430185359202, 1632.3389027443905, 1635.3295148988857, 1672.6152984813561, 1682.1757338904094, 898.6315610599622, 901.8151278987792, 935.209747763139, 937.4984383354872, 1005.9647912323034, 16020.439284624983, 16342.182890855647, 16352.672946541003, 16676.33294668224, 16730.0, 902.9548522573845, 929.9256059515222, 941.3034354577563, 949.9050094990583, 1001.9649312274036, 9318.254539636813, 9340.813183736287, 9476.763080923032, 9672.274579406572, 9750.26872984529, 390319.0, 402217.0, 402948.0, 405412.0, 406244.0, 68783.65608172027, 73215.0, 73630.63184684042, 74162.62918685372, 75093.624531877, 979.6865003198908, 989.391524212604, 990.9554070066864, 995.7709726762885, 997.2420960070253, 14492.420303187755, 14572.344244509235, 14574.198419087052, 14668.0, 14854.554363369116, 32177.678223217466, 32918.835405822814, 33434.83282583669, 33566.160845979044, 34764.30471390609, 39283.21433571255, 41699.0, 41993.0, 42249.155016898876, 42611.57388426076, 7307.707691692272, 7457.291557302047, 7527.88708169367, 7617.352525035434, 7719.691212351443, 11313.490892910004, 12365.690857728629, 12374.75250494967, 12510.624681259576, 12603.74792504163, 10113.949430252802, 10901.618443354444, 10933.0, 10996.780064398827, 11317.490712918103, 10644.574217031231, 11196.440177991231, 11231.26996745209, 11372.0, 11454.083673306282, 10232.795344093225, 11037.889621104008, 11204.159688023594, 11461.598844040418, 11769.52921883115, 7587.620618968919, 7728.574928378993, 7753.844923101394, 7866.803329916569, 7952.761417157494, 10970.670879873616, 11047.337159770439, 11186.776264474827, 11268.492917818554, 11349.659510214708], "unit": "score", "name": "jquery.html", "value": 7867.626923096479}, {"lowerIsBetter": false, "replicates": [1432.2051261549839, 1434.2971943747561, 1542.5680809373373, 1669.2571805546536, 1696.151924037981, 6121.938780612192, 6660.100886380337, 6670.6331151786635, 6804.251532331446, 6814.557053791506, 6655.700493477793, 6674.43267322277, 6710.798676039714, 6722.663866806664, 6740.52816302859, 2104.8316134709225, 2112.2818241797786, 2130.3502431758307, 2132.296342207068, 2139.4330502416874, 2099.0, 2117.8199853012434, 2122.501212215136, 2124.4051665533675, 2128.053016407699, 2086.238522939124, 2095.6961240620103, 2109.48317662173, 2112.6408510553165, 2114.947126321839, 2107.968380474294, 2112.8309735221223, 2119.0146581839517, 2122.713433686448, 2123.1295168980646, 2097.0772859941576, 2180.8146307563875, 2183.039462636435, 2194.6049711052005, 2195.9780402196093, 6725.495587830883, 6758.121444212221, 6763.628000459973, 6772.966135169293, 6783.050372947791, 4263.872083837458, 4306.310990241546, 4308.439902812645, 4314.115606300701, 4335.263005289077, 2868.5983962245305, 2935.6330458692664, 2947.1747910585073, 2954.4091181763733, 2965.733084022448, 910.6903652758094, 934.8270569944514, 936.3603345423478, 940.5250348573995, 953.0326718380849, 8780.297576193889, 8793.428427152214, 8802.295816334678, 8806.515641639708, 8810.559472026373, 3818.3699689551468, 3850.730448868608, 3909.706771992112, 3922.3135951208424, 3930.292547341506, 7845.646945887334, 7849.01887264092, 7858.921410785933, 7869.527828330319, 7872.094709108412, 4337.8264869404875, 4374.759388233614, 4385.254506733863, 4408.074304396113, 4421.977890110529, 3437.570303712036, 3836.4245363195746, 3931.0368959604507, 3959.6832253419657, 3962.286788378062, 3331.3337332533106, 3357.462805951036, 3362.2098806780386, 3396.4735466002808, 3415.6755108264674, 1060.9469526523642, 1068.4924660786219, 1072.2815713471994, 1084.9783004340027, 1098.5880294889416, 1280.9551665691656, 1293.9611811645666, 1319.2678063674562, 1319.3864852843474, 1320.2540564580981, 6424.560089853987, 6431.485481161496, 6539.280679125292, 6566.277709451956, 6599.73601055962, 425.31736562816855, 434.548070007189, 436.4631503251019, 439.13928699748215, 440.970334269478, 5206.687598744012, 5254.106801843695, 5260.92108618371, 5296.1261391870685, 5297.54970827484, 7904.802379940433, 8146.5519396433765, 8213.055498617616, 8371.37214708887, 8423.326133909273, 8293.0, 8304.626291816883, 8332.958335208285, 8333.458325208841, 8390.538520381315, 6176.99999999991, 6593.3736295051895, 6711.429528490035, 6716.194056713226, 6759.459243260528, 6452.580582262138, 6490.123833282447, 6500.967495162683, 6504.707288171949, 6537.1501704778075, 7376.114866216089, 7405.7778266652085, 7406.07424071991, 7514.849703006019, 7594.924050759642, 7383.2985866342615, 7475.663595138123, 7539.962300188464, 7609.353204977639, 7638.083429988437, 5630.887382252414, 5975.223220981245, 6066.514678825772, 6092.512598991982, 6255.374462553708, 6625.933740662532, 6654.13496245485, 6691.063251144747, 6694.698738556679, 6700.195976482853, 5719.0, 5905.291365036223, 5947.0, 6126.264848218242, 6293.748250069946, 5921.526277897672, 6024.759009639741, 6042.214512113573, 6103.11504831788, 6138.846528836815, 6040.577159598786, 6067.302260239952, 6086.695665216633, 6207.255129384503, 6207.96896015517, 5893.970530147321, 5897.026990546512, 5923.644581325134, 5930.644161350333, 5945.40545945402, 5772.826815195551, 5797.9420205797405, 5810.041343178328, 5994.820155395345, 6010.1285313628405], "unit": "score", "name": "mootools.html", "value": 3978.9487744041485}, {"lowerIsBetter": false, "replicates": [288.29943237931815, 289.0547908339729, 294.7774430305121, 297.3918337000833, 298.5998761659376, 6114.296855861578, 6207.751689932403, 6237.563370564057, 6255.499560035198, 6288.0, 6110.572259941806, 6112.29708583513, 6139.447449729523, 6154.661493617849, 6172.351903050182, 4469.687121901468, 4570.588647021767, 4591.012932219573, 4630.8147674093, 4634.884127896796, 4618.5381461853885, 4621.052684199748, 4623.190941585209, 4623.352730617717, 4624.630029597624, 4583.793729282191, 4584.885377865547, 4585.518520555327, 4585.679002469828, 4587.334836448713, 4593.908121837561, 4595.701279416827, 4599.126166028477, 4603.079384123172, 4605.608523275526, 3935.488386509764, 3939.2909276330247, 3940.6847452203756, 3943.132510847609, 3944.3886197639126, 5897.908886855946, 5901.852453688693, 5921.171036054956, 5940.168376427304, 5949.494292985101, 5134.512221338967, 5284.233786100994, 5286.762095705702, 5289.338832645919, 5319.255304257407, 6528.37980391862, 6549.7882891665195, 6563.967180164069, 6565.606063636197, 6567.605943643397, 4283.336082907154, 4302.161078589676, 4312.5903039211225, 4331.480222373335, 4339.370791235285, 6783.694733736994, 6854.383105520477, 6879.552829066095, 6884.621345825977, 6889.965550172267, 4344.23975804233, 4346.587074227943, 4352.956470435319, 4353.194658988034, 4365.607095361433, 4297.226499230169, 4384.276594361958, 4414.09511050234, 4421.137878113737, 4424.911501769947, 5231.346081739783, 5236.895262094737, 5248.501392367719, 5255.710935898486, 5257.921131183035, 6566.179227596551, 6585.0, 6592.077109204715, 6618.933810661928, 6632.43624291931, 1554.2228885557222, 1584.3583348743778, 1584.9683006339808, 1587.484067677986, 1591.7504758764314, 1005.8742657167854, 1007.1187710753092, 1023.9641612543526, 1030.07808011829, 1046.4663021858755, 6326.304106548276, 6327.114204011442, 6328.968355158195, 6387.297397286295, 6410.711517981702, 6777.2545020047755, 6784.898226526606, 6809.455243580502, 6813.1142951415995, 6825.317468253135, 6238.719257633417, 6303.117563541108, 6307.306196318401, 6380.0, 6488.610683359014, 3682.4844521766972, 3693.1874987502706, 3704.9811301892196, 3710.109573702346, 3721.7580857244734, 7278.417726581861, 7324.743633972892, 7345.118585769742, 7352.926470735224, 7352.963235183897, 6975.755848545378, 7017.89473157903, 7059.2234854166, 7068.0, 7069.646517674096, 7127.7148914042855, 7260.2013778484325, 7271.418286537064, 7295.744648937261, 7345.375643070399, 6820.556663816836, 6846.828829279308, 6850.280720524473, 6863.519553631198, 6877.2091209509545, 6747.392734653905, 6758.155230596176, 6764.86470270582, 6767.187937447341, 6781.186257649114, 7301.160366557701, 7305.41556675454, 7306.707731690885, 7323.63381830917, 7349.889751653623, 4206.179794939957, 4377.627901628397, 4453.710508816916, 4513.480949690827, 4520.796564154687, 6807.285235050248, 6812.795616131524, 6816.113905192492, 6823.727050917908, 6841.692123854339, 6570.08018877348, 6609.0, 6616.272210056986, 6616.966915165393, 6621.404073633396, 6503.349665033459, 6570.11303474044, 6614.603123812587, 6616.470682345497, 6616.536842420985, 6329.810105696836, 6458.967705161632, 6486.870262594816, 6488.351164883663, 6542.313057128933, 6692.59455514328, 6701.597904125768, 6715.932840671726, 6727.159105111861, 6753.2909044549615, 6522.249941256627, 6529.771457998947, 6533.281339052795, 6535.313792051957, 6548.116004339544], "unit": "score", "name": "prototype.html", "value": 4881.263497759219}, {"lowerIsBetter": false, "replicates": [742.3059439424139, 778.0585491555217, 786.5320134519959, 792.2275781113414, 819.4632515702214, 13304.201747895133, 13519.662008449794, 13520.0, 13548.864511354883, 13605.0, 12024.939875300612, 12088.093392995517, 12162.878371216286, 12168.965637920764, 12263.938680306586, 659.6207180870995, 788.9881651775228, 794.8529522038413, 809.5709274084744, 809.5992483720566, 804.7666176808718, 809.8420807942454, 813.894193754811, 814.2915663372873, 815.6615004773012, 840.3907167303717, 843.1315744782884, 843.2326582809644, 845.471580262336, 846.0101681033175, 839.9286060684849, 840.2857571064577, 840.3319361107934, 840.6343240690319, 840.9579521023925, 626.627156841683, 628.7736414890636, 629.9181106456132, 631.9304876463585, 632.8481164520527, 13256.86743132566, 13357.0, 13412.731745365038, 13465.932670336684, 13475.595732127953, 12865.614031579067, 12883.613491595173, 13095.672608184776, 13534.052616316862, 13658.658533536642, 10441.947790261076, 10534.157267418588, 10605.575776968912, 10630.681079567625, 10773.5690572377, 3623.0942264433893, 3667.9816600917093, 3701.148735790783, 3705.110773414388, 3829.463875057494, 48903.75548122237, 48908.26637600439, 48946.26580601294, 49122.0, 49281.75359123218, 10384.636537721144, 10398.220133490018, 10441.791164176673, 10480.371177729361, 10624.787504250025, 19005.334813281468, 19095.427137185907, 19102.044897755055, 19234.0, 19260.422187334403, 7265.9273407265255, 7392.186859445456, 7425.0, 7543.283388078124, 7544.132424771222, 3979.7413168143976, 4019.457373254573, 4192.958070419318, 4201.747895126302, 4270.380794784739, 2963.525835866251, 2989.387175628991, 3019.426309001283, 3024.6975302469577, 3027.9250865942713, 518.8884389856199, 533.6904595334696, 535.9196120581865, 540.6755946432188, 548.2954403591445, 510.1760656539662, 582.3419535924463, 595.3894714796465, 620.4241227282741, 646.1696719715144, 8560.57197140153, 8876.245519130816, 8879.600417981206, 8962.82074358509, 8987.820243595092, 578.006027918782, 627.0093252660876, 649.6751624187906, 674.0664180110582, 680.6052489556046, 3780.7353485255767, 3912.3349030664854, 3959.9010024749614, 3969.960300397017, 4035.1727895781296, 49582.752086240056, 50206.748966254934, 50932.0, 51249.0, 52278.21582676263, 47828.7608561955, 47915.520844791805, 49235.0, 49588.0, 50038.49961500411, 43501.34747978783, 43856.56143438588, 44581.108377832265, 44586.770661467446, 44623.98384145443, 8048.83902321962, 8264.876026859481, 8454.0, 8454.36592255571, 8872.600732967161, 32973.34053318968, 33258.334833303685, 33610.327793444485, 34104.48843267303, 34413.31173376468, 42057.57942420537, 43158.784206080025, 43178.0, 43254.783726081165, 43338.56661433345, 10958.39728814891, 10995.34027958325, 11041.730201026985, 11133.220674552704, 11173.88826111761, 11912.40437978115, 12019.278843269432, 12130.393480326125, 12266.75466490683, 12284.447199875849, 11151.944240278746, 11556.248843825124, 11581.594644187413, 11703.23928944616, 12050.698732531757, 10945.562177512811, 11127.276727012719, 11147.163962702993, 11442.94278528602, 11477.36874471912, 11075.833862491907, 11287.0, 11421.31472111676, 11625.88374116282, 12005.579804706793, 9252.259819214582, 9310.162085412345, 9357.111074447917, 9382.343235973416, 9557.092076252746, 8790.736277911672, 9044.638214471348, 9122.498262595622, 9332.113449222314, 9679.564419600994], "unit": "score", "name": "yui.html", "value": 6219.161114005891}], "name": "dromaeo_css", "value": 6612.888312259218}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 114.0, 112.0, 115.0, 123.0, 113.0, 113.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.9}, {"lowerIsBetter": true, "replicates": [160.0, 131.0, 155.0, 163.0, 129.0, 150.0, 151.0, 127.0, 175.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [161.0, 165.0, 163.0, 165.0, 163.0, 161.0, 168.0, 177.0, 166.0, 165.0], "unit": "score", "name": "audio-dft", "value": 165.4}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 73.0, 73.0, 76.0, 142.0, 72.0, 72.0, 72.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 138.0, 95.0, 95.0, 95.0, 141.0, 96.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 116.0, 115.0, 115.0, 116.0, 117.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.8}, {"lowerIsBetter": true, "replicates": [147.0, 150.0, 146.0, 148.0, 147.0, 147.0, 150.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [57.0, 60.0, 57.0, 56.0, 61.0, 58.0, 58.0, 66.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 69.0, 68.0, 68.0, 68.0, 67.0, 69.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 85.0, 90.0, 84.0, 83.0, 83.0, 82.0, 81.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [122.0, 126.0, 119.0, 117.0, 130.0, 125.0, 117.0, 126.0, 117.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.2}, {"lowerIsBetter": true, "replicates": [152.0, 160.0, 154.0, 158.0, 166.0, 141.0, 159.0, 146.0, 155.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.6}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 75.0, 72.0, 68.0, 69.0, 72.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1532.2}]} 23:15:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1532.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6612.89"}}} 23:15:02 INFO - Return code: 0 23:15:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:15:02 ERROR - # TBPL SUCCESS # 23:15:02 INFO - Running post-action listener: _resource_record_post_action 23:15:02 INFO - Running post-run listener: _resource_record_post_run 23:15:03 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549769216; Read time: 16; Write time: 627968 23:15:03 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 251072512; Read time: 0; Write time: 444588 23:15:03 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298696704; Read time: 16; Write time: 183380 23:15:03 INFO - Running post-run listener: _upload_blobber_files 23:15:03 INFO - Blob upload gear active. 23:15:03 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:15:03 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 23:15:03 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'] 23:15:03 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 23:15:03 INFO - (blobuploader) - INFO - Open directory for files ... 23:15:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:15:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:15:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:04 INFO - (blobuploader) - INFO - Done attempting. 23:15:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:15:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:15:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:05 INFO - (blobuploader) - INFO - Done attempting. 23:15:05 INFO - (blobuploader) - INFO - Iteration through files over. 23:15:05 INFO - Return code: 0 23:15:05 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:15:05 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:15:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e0af4101e8c2134804057f6d3ae0ad843d7117d657e28ed9a514d7ed61babfa3a50155bb5d7843048f1f17f8ef70f28caa3f5003a01186bbbd54f5b16bf4fa9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c87244d34931cd375a786974ea1c0276125d1f520034c02841750855e1fd56a49935304733c83eb0d3fcc6d76373ec1dd5eccd3cd519573327727ccb435d9be"} 23:15:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:15:05 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:15:05 INFO - Contents: 23:15:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e0af4101e8c2134804057f6d3ae0ad843d7117d657e28ed9a514d7ed61babfa3a50155bb5d7843048f1f17f8ef70f28caa3f5003a01186bbbd54f5b16bf4fa9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c87244d34931cd375a786974ea1c0276125d1f520034c02841750855e1fd56a49935304733c83eb0d3fcc6d76373ec1dd5eccd3cd519573327727ccb435d9be"} 23:15:05 INFO - Running post-run listener: copy_logs_to_upload_dir 23:15:05 INFO - Copying logs to upload dir... 23:15:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:15:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.243090 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-02-29 23:15:05.003711) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 23:15:05.007727) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263 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/8e0af4101e8c2134804057f6d3ae0ad843d7117d657e28ed9a514d7ed61babfa3a50155bb5d7843048f1f17f8ef70f28caa3f5003a01186bbbd54f5b16bf4fa9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c87244d34931cd375a786974ea1c0276125d1f520034c02841750855e1fd56a49935304733c83eb0d3fcc6d76373ec1dd5eccd3cd519573327727ccb435d9be"} build_url:https://queue.taskcluster.net/v1/task/HogXBHcZR6WTWWVJm-cETg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/HogXBHcZR6WTWWVJm-cETg/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/8e0af4101e8c2134804057f6d3ae0ad843d7117d657e28ed9a514d7ed61babfa3a50155bb5d7843048f1f17f8ef70f28caa3f5003a01186bbbd54f5b16bf4fa9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c87244d34931cd375a786974ea1c0276125d1f520034c02841750855e1fd56a49935304733c83eb0d3fcc6d76373ec1dd5eccd3cd519573327727ccb435d9be"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 23:15:05.031818) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 23:15:05.032142) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1456795624.11234-857544263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 23:15:05.117921) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 23:15:05.119248) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 23:15:05.119549) ========= ========= Total master_lag: 0.27 =========