builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1453154558.37 results: success (0) buildid: 20160118113035 builduid: 637791949c0a467180ae42f805668bc5 revision: 9f9b83007c01f8e86cf65148c193d8aec7369d35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.373004) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.373365) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.373656) ========= 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=41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006378 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.412628) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.412900) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.432261) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.432568) ========= 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=41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.482918) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.483173) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.483526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.483797) ========= 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=41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 14:02:39-- 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% 35.3M=0s 2016-01-18 14:02:39 (35.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176207 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.674196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.674502) ========= 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=41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019084 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.724721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:38.725017) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9f9b83007c01f8e86cf65148c193d8aec7369d35 --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 9f9b83007c01f8e86cf65148c193d8aec7369d35 --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=41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 14:02:39,694 truncating revision to first 12 chars 2016-01-18 14:02:39,694 Setting DEBUG logging. 2016-01-18 14:02:39,694 attempt 1/10 2016-01-18 14:02:39,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9f9b83007c01?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 14:02:39,948 unpacking tar archive at: fx-team-9f9b83007c01/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555636 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:39.294065) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:39.294360) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003760 script_repo_revision: '%(revision)s' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:39.342674) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:39.342962) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:39.358871) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:39.359169) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 14:02:39.359794) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-18 14:02:39.360098) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:02:40 INFO - MultiFileLogger online at 20160118 14:02:40 in /builds/slave/test-pgo 14:02:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:02:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:02:40 INFO - {'append_to_log': False, 14:02:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:02:40 INFO - 'blob_upload_branch': 'Fx-Team', 14:02:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:02:40 INFO - 'branch': 'Fx-Team', 14:02:40 INFO - 'buildbot_json_path': 'buildprops.json', 14:02:40 INFO - 'config_files': ('talos/linux_config.py',), 14:02:40 INFO - 'default_actions': ('clobber', 14:02:40 INFO - 'read-buildbot-config', 14:02:40 INFO - 'download-and-extract', 14:02:40 INFO - 'populate-webroot', 14:02:40 INFO - 'create-virtualenv', 14:02:40 INFO - 'install', 14:02:40 INFO - 'run-tests'), 14:02:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:02:40 INFO - 'download_minidump_stackwalk': True, 14:02:40 INFO - 'download_symbols': 'ondemand', 14:02:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:02:40 INFO - 'tooltool.py': '/tools/tooltool.py', 14:02:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:02:40 INFO - '/tools/misc-python/virtualenv.py')}, 14:02:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:02:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:02:40 INFO - 'installer_path': 'installer.exe', 14:02:40 INFO - 'log_level': 'info', 14:02:40 INFO - 'log_name': 'talos', 14:02:40 INFO - 'log_to_console': True, 14:02:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:02:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:02:40 INFO - 'opt_config_files': (), 14:02:40 INFO - 'pip_index': False, 14:02:40 INFO - 'sps_profile': False, 14:02:40 INFO - 'sps_profile_interval': 0, 14:02:40 INFO - 'suite': 'dromaeojs', 14:02:40 INFO - 'system_bits': '32', 14:02:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:02:40 INFO - 'title': 'talos-linux64-ix-026', 14:02:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:02:40 INFO - 'use_talos_json': True, 14:02:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:02:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:02:40 INFO - 'work_dir': 'build'} 14:02:40 INFO - ##### 14:02:40 INFO - ##### Running clobber step. 14:02:40 INFO - ##### 14:02:40 INFO - Running pre-action listener: _resource_record_pre_action 14:02:40 INFO - Running main action method: clobber 14:02:40 INFO - rmtree: /builds/slave/test-pgo/build 14:02:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:02:40 INFO - Running post-action listener: _resource_record_post_action 14:02:40 INFO - ##### 14:02:40 INFO - ##### Running read-buildbot-config step. 14:02:40 INFO - ##### 14:02:40 INFO - Running pre-action listener: _resource_record_pre_action 14:02:40 INFO - Running main action method: read_buildbot_config 14:02:40 INFO - Using buildbot properties: 14:02:40 INFO - { 14:02:40 INFO - "project": "", 14:02:40 INFO - "product": "firefox", 14:02:40 INFO - "script_repo_revision": "production", 14:02:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:02:40 INFO - "repository": "", 14:02:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:02:40 INFO - "buildid": "20160118113035", 14:02:40 INFO - "pgo_build": "True", 14:02:40 INFO - "basedir": "/builds/slave/test-pgo", 14:02:40 INFO - "buildnumber": 900, 14:02:40 INFO - "slavename": "talos-linux64-ix-026", 14:02:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:02:40 INFO - "platform": "ubuntu64_hw", 14:02:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:02:40 INFO - "branch": "fx-team", 14:02:40 INFO - "repo_path": "integration/fx-team", 14:02:40 INFO - "revision": "9f9b83007c01f8e86cf65148c193d8aec7369d35", 14:02:40 INFO - "stage_platform": "linux64-pgo", 14:02:40 INFO - "builduid": "637791949c0a467180ae42f805668bc5", 14:02:40 INFO - "slavebuilddir": "test" 14:02:40 INFO - } 14:02:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:02:40 INFO - Running post-action listener: _resource_record_post_action 14:02:40 INFO - ##### 14:02:40 INFO - ##### Running download-and-extract step. 14:02:40 INFO - ##### 14:02:40 INFO - Running pre-action listener: _resource_record_pre_action 14:02:40 INFO - Running main action method: download_and_extract 14:02:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:40 INFO - https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:02:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/test_packages.json 14:02:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/test_packages.json 14:02:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:02:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:02:47 INFO - Downloaded 1448 bytes. 14:02:47 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:02:47 INFO - Using the following test package requirements: 14:02:47 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:47 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:02:47 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:02:47 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'jsshell-linux-x86_64.zip'], 14:02:47 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:02:47 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:47 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:02:47 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:02:47 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:02:47 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:47 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:02:47 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:47 INFO - https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:02:50 INFO - Downloaded 22484216 bytes. 14:02:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:02:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:02:51 INFO - Return code: 0 14:02:51 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:51 INFO - https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:02:55 INFO - Downloaded 22484216 bytes. 14:02:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:02:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:02:56 INFO - Return code: 0 14:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:56 INFO - https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:02:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:03:00 INFO - Downloaded 11132144 bytes. 14:03:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:03:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 14:03:00 INFO - Return code: 0 14:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:00 INFO - https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:03:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:03:03 INFO - Downloaded 55921399 bytes. 14:03:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:03 INFO - mkdir: /builds/slave/test-pgo/properties 14:03:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:03:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:03:03 INFO - Contents: 14:03:03 INFO - build_url:https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:03 INFO - Running post-action listener: _resource_record_post_action 14:03:03 INFO - Running post-action listener: set_extra_try_arguments 14:03:03 INFO - ##### 14:03:03 INFO - ##### Running populate-webroot step. 14:03:03 INFO - ##### 14:03:03 INFO - Running pre-action listener: _resource_record_pre_action 14:03:03 INFO - Running main action method: populate_webroot 14:03:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:03:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:03:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:03:03 INFO - '--tppagecycles', 14:03:03 INFO - '7'], 14:03:03 INFO - 'tests': ['tsvgm']}}, 14:03:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:03:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:03:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:03:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:03:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:03:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:03:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:03:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:03 INFO - 'talos_options': ['--e10s'], 14:03:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:03:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:03 INFO - 'tests': ['damp', 'tps']}, 14:03:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:03 INFO - 'talos_options': ['--e10s'], 14:03:03 INFO - 'tests': ['damp', 'tps']}, 14:03:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:03:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:03:03 INFO - 'other': {'tests': ['a11yr', 14:03:03 INFO - 'ts_paint', 14:03:03 INFO - 'tpaint', 14:03:03 INFO - 'sessionrestore', 14:03:03 INFO - 'sessionrestore_no_auto_restore']}, 14:03:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:03:03 INFO - 'tests': ['a11yr', 14:03:03 INFO - 'ts_paint', 14:03:03 INFO - 'tpaint', 14:03:03 INFO - 'sessionrestore', 14:03:03 INFO - 'sessionrestore_no_auto_restore']}, 14:03:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:03:03 INFO - 'tests': ['a11yr', 14:03:03 INFO - 'ts_paint', 14:03:03 INFO - 'tpaint', 14:03:03 INFO - 'sessionrestore', 14:03:03 INFO - 'sessionrestore_no_auto_restore']}, 14:03:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:03:03 INFO - 'tests': ['a11yr', 14:03:03 INFO - 'ts_paint', 14:03:03 INFO - 'tpaint', 14:03:03 INFO - 'sessionrestore', 14:03:03 INFO - 'sessionrestore_no_auto_restore']}, 14:03:03 INFO - 'other_l64': {'tests': ['a11yr', 14:03:03 INFO - 'ts_paint', 14:03:03 INFO - 'tpaint', 14:03:03 INFO - 'sessionrestore', 14:03:03 INFO - 'sessionrestore_no_auto_restore']}, 14:03:03 INFO - 'other_nol64': {'tests': ['a11yr', 14:03:03 INFO - 'ts_paint', 14:03:03 INFO - 'tpaint', 14:03:03 INFO - 'sessionrestore', 14:03:03 INFO - 'sessionrestore_no_auto_restore']}, 14:03:03 INFO - 'svgr': {'tests': ['tsvgx', 14:03:03 INFO - 'tsvgr_opacity', 14:03:03 INFO - 'tart', 14:03:03 INFO - 'tscrollx', 14:03:03 INFO - 'cart']}, 14:03:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:03:03 INFO - 'tests': ['tsvgx', 14:03:03 INFO - 'tsvgr_opacity', 14:03:03 INFO - 'tart', 14:03:03 INFO - 'tscrollx', 14:03:03 INFO - 'cart']}, 14:03:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:03 INFO - 'tests': ['tp5o']}, 14:03:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:03 INFO - 'talos_options': ['--e10s'], 14:03:03 INFO - 'tests': ['tp5o']}, 14:03:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:03 INFO - 'talos_options': ['--xperf_path', 14:03:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:03:03 INFO - 'tests': ['tp5n']}, 14:03:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:03 INFO - 'talos_options': ['--e10s', 14:03:03 INFO - '--xperf_path', 14:03:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:03:03 INFO - 'tests': ['tp5n']}}, 14:03:03 INFO - 'talos.zip': {'path': '', 14:03:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:03:03 INFO - Running post-action listener: _resource_record_post_action 14:03:03 INFO - ##### 14:03:03 INFO - ##### Running create-virtualenv step. 14:03:03 INFO - ##### 14:03:03 INFO - Running pre-action listener: _resource_record_pre_action 14:03:03 INFO - Running main action method: create_virtualenv 14:03:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:03:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:03:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:03:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:03:03 INFO - Using real prefix '/usr' 14:03:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:03:04 INFO - Installing distribute.............................................................................................................................................................................................done. 14:03:06 INFO - Installing pip.................done. 14:03:06 INFO - Return code: 0 14:03:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f51128cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e840>, '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 0x279b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279bb60>, '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': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:03:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:03:06 INFO - Using env: {'DISPLAY': ':0', 14:03:06 INFO - 'HOME': '/home/cltbld', 14:03:06 INFO - 'LANG': 'en_US.UTF-8', 14:03:06 INFO - 'LANGUAGE': 'en_US:en', 14:03:06 INFO - 'LOGNAME': 'cltbld', 14:03:06 INFO - 'MAIL': '/var/mail/cltbld', 14:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:06 INFO - 'MOZ_NO_REMOTE': '1', 14:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:06 INFO - 'NO_EM_RESTART': '1', 14:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:06 INFO - 'SHELL': '/bin/bash', 14:03:06 INFO - 'SHLVL': '1', 14:03:06 INFO - 'TERM': 'linux', 14:03:06 INFO - 'TMOUT': '86400', 14:03:06 INFO - 'USER': 'cltbld', 14:03:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 14:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:06 INFO - '_': '/tools/buildbot/bin/python'} 14:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:03:06 INFO - Cleaning up... 14:03:06 INFO - Return code: 0 14:03:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f51128cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e840>, '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 0x279b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279bb60>, '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': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:03:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:03:06 INFO - Using env: {'DISPLAY': ':0', 14:03:06 INFO - 'HOME': '/home/cltbld', 14:03:06 INFO - 'LANG': 'en_US.UTF-8', 14:03:06 INFO - 'LANGUAGE': 'en_US:en', 14:03:06 INFO - 'LOGNAME': 'cltbld', 14:03:06 INFO - 'MAIL': '/var/mail/cltbld', 14:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:06 INFO - 'MOZ_NO_REMOTE': '1', 14:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:06 INFO - 'NO_EM_RESTART': '1', 14:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:06 INFO - 'SHELL': '/bin/bash', 14:03:06 INFO - 'SHLVL': '1', 14:03:06 INFO - 'TERM': 'linux', 14:03:06 INFO - 'TMOUT': '86400', 14:03:06 INFO - 'USER': 'cltbld', 14:03:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 14:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:06 INFO - '_': '/tools/buildbot/bin/python'} 14:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:06 INFO - Downloading/unpacking psutil>=0.7.1 14:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:03:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:03:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:03:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:08 INFO - Installing collected packages: psutil 14:03:08 INFO - Running setup.py install for psutil 14:03:08 INFO - building 'psutil._psutil_linux' extension 14:03:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:03:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:03:09 INFO - building 'psutil._psutil_posix' extension 14:03:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:03:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:03:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:09 INFO - Successfully installed psutil 14:03:09 INFO - Cleaning up... 14:03:09 INFO - Return code: 0 14:03:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f51128cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e840>, '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 0x279b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279bb60>, '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': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:03:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:03:09 INFO - Using env: {'DISPLAY': ':0', 14:03:09 INFO - 'HOME': '/home/cltbld', 14:03:09 INFO - 'LANG': 'en_US.UTF-8', 14:03:09 INFO - 'LANGUAGE': 'en_US:en', 14:03:09 INFO - 'LOGNAME': 'cltbld', 14:03:09 INFO - 'MAIL': '/var/mail/cltbld', 14:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:09 INFO - 'MOZ_NO_REMOTE': '1', 14:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:09 INFO - 'NO_EM_RESTART': '1', 14:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:09 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:09 INFO - 'SHELL': '/bin/bash', 14:03:09 INFO - 'SHLVL': '1', 14:03:09 INFO - 'TERM': 'linux', 14:03:09 INFO - 'TMOUT': '86400', 14:03:09 INFO - 'USER': 'cltbld', 14:03:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 14:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:09 INFO - '_': '/tools/buildbot/bin/python'} 14:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:03:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:03:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:03:11 INFO - Installing collected packages: mozsystemmonitor 14:03:11 INFO - Running setup.py install for mozsystemmonitor 14:03:11 INFO - Successfully installed mozsystemmonitor 14:03:11 INFO - Cleaning up... 14:03:11 INFO - Return code: 0 14:03:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f51128cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e840>, '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 0x279b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279bb60>, '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': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:03:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:03:11 INFO - Using env: {'DISPLAY': ':0', 14:03:11 INFO - 'HOME': '/home/cltbld', 14:03:11 INFO - 'LANG': 'en_US.UTF-8', 14:03:11 INFO - 'LANGUAGE': 'en_US:en', 14:03:11 INFO - 'LOGNAME': 'cltbld', 14:03:11 INFO - 'MAIL': '/var/mail/cltbld', 14:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:11 INFO - 'MOZ_NO_REMOTE': '1', 14:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:11 INFO - 'NO_EM_RESTART': '1', 14:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:11 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:11 INFO - 'SHELL': '/bin/bash', 14:03:11 INFO - 'SHLVL': '1', 14:03:11 INFO - 'TERM': 'linux', 14:03:11 INFO - 'TMOUT': '86400', 14:03:11 INFO - 'USER': 'cltbld', 14:03:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 14:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:11 INFO - '_': '/tools/buildbot/bin/python'} 14:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:11 INFO - Downloading/unpacking blobuploader==1.2.4 14:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:13 INFO - Downloading blobuploader-1.2.4.tar.gz 14:03:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:03:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:03:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:03:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:03:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:14 INFO - Downloading docopt-0.6.1.tar.gz 14:03:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:03:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:03:14 INFO - Installing collected packages: blobuploader, requests, docopt 14:03:14 INFO - Running setup.py install for blobuploader 14:03:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:03:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:03:14 INFO - Running setup.py install for requests 14:03:14 INFO - Running setup.py install for docopt 14:03:14 INFO - Successfully installed blobuploader requests docopt 14:03:14 INFO - Cleaning up... 14:03:14 INFO - Return code: 0 14:03:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f51128cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e840>, '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 0x279b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279bb60>, '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': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:03:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:03:14 INFO - Using env: {'DISPLAY': ':0', 14:03:14 INFO - 'HOME': '/home/cltbld', 14:03:14 INFO - 'LANG': 'en_US.UTF-8', 14:03:14 INFO - 'LANGUAGE': 'en_US:en', 14:03:14 INFO - 'LOGNAME': 'cltbld', 14:03:14 INFO - 'MAIL': '/var/mail/cltbld', 14:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:14 INFO - 'MOZ_NO_REMOTE': '1', 14:03:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:14 INFO - 'NO_EM_RESTART': '1', 14:03:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:14 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:14 INFO - 'SHELL': '/bin/bash', 14:03:14 INFO - 'SHLVL': '1', 14:03:14 INFO - 'TERM': 'linux', 14:03:14 INFO - 'TMOUT': '86400', 14:03:14 INFO - 'USER': 'cltbld', 14:03:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 14:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:14 INFO - '_': '/tools/buildbot/bin/python'} 14:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:14 INFO - Running setup.py (path:/tmp/pip-xPc5ZI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:14 INFO - Running setup.py (path:/tmp/pip-CPdjoY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:15 INFO - Running setup.py (path:/tmp/pip-LBuPZV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:15 INFO - Running setup.py (path:/tmp/pip-hErd5h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:15 INFO - Running setup.py (path:/tmp/pip-jYAYbu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:15 INFO - Running setup.py (path:/tmp/pip-E7RTKr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:15 INFO - Running setup.py (path:/tmp/pip-3tJUwh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:15 INFO - Running setup.py (path:/tmp/pip-CG9wNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:15 INFO - Running setup.py (path:/tmp/pip-5owj5Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:15 INFO - Running setup.py (path:/tmp/pip-VDpoTr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:15 INFO - Running setup.py (path:/tmp/pip-IpfxdR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:15 INFO - Running setup.py (path:/tmp/pip-MPpn3H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:15 INFO - Running setup.py (path:/tmp/pip-qZE5Cd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:15 INFO - Running setup.py (path:/tmp/pip-TeSgUW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:15 INFO - Running setup.py (path:/tmp/pip-PU0mGP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:16 INFO - Running setup.py (path:/tmp/pip-ISVYd6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:16 INFO - Running setup.py (path:/tmp/pip-UJyvmz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:03:16 INFO - Running setup.py install for manifestparser 14:03:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:03:16 INFO - Running setup.py install for mozcrash 14:03:16 INFO - Running setup.py install for mozdebug 14:03:16 INFO - Running setup.py install for mozdevice 14:03:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:03:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:03:16 INFO - Running setup.py install for mozfile 14:03:16 INFO - Running setup.py install for mozhttpd 14:03:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:03:16 INFO - Running setup.py install for mozinfo 14:03:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:03:16 INFO - Running setup.py install for mozInstall 14:03:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:03:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:03:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:03:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:03:16 INFO - Running setup.py install for mozleak 14:03:17 INFO - Running setup.py install for mozlog 14:03:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:03:17 INFO - Running setup.py install for moznetwork 14:03:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:03:17 INFO - Running setup.py install for mozprocess 14:03:17 INFO - Running setup.py install for mozprofile 14:03:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:03:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:03:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:03:17 INFO - Running setup.py install for mozrunner 14:03:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:03:17 INFO - Running setup.py install for mozscreenshot 14:03:17 INFO - Running setup.py install for moztest 14:03:17 INFO - Running setup.py install for mozversion 14:03:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:03:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:03:17 INFO - Cleaning up... 14:03:17 INFO - Return code: 0 14:03:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f51128cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e840>, '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 0x279b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279bb60>, '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': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:03:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:03:17 INFO - Using env: {'DISPLAY': ':0', 14:03:17 INFO - 'HOME': '/home/cltbld', 14:03:17 INFO - 'LANG': 'en_US.UTF-8', 14:03:17 INFO - 'LANGUAGE': 'en_US:en', 14:03:17 INFO - 'LOGNAME': 'cltbld', 14:03:17 INFO - 'MAIL': '/var/mail/cltbld', 14:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:17 INFO - 'MOZ_NO_REMOTE': '1', 14:03:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:17 INFO - 'NO_EM_RESTART': '1', 14:03:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:17 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:17 INFO - 'SHELL': '/bin/bash', 14:03:17 INFO - 'SHLVL': '1', 14:03:17 INFO - 'TERM': 'linux', 14:03:17 INFO - 'TMOUT': '86400', 14:03:17 INFO - 'USER': 'cltbld', 14:03:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 14:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:17 INFO - '_': '/tools/buildbot/bin/python'} 14:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:18 INFO - Running setup.py (path:/tmp/pip-1bJ5bk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:18 INFO - Running setup.py (path:/tmp/pip-QkkOSQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:18 INFO - Running setup.py (path:/tmp/pip-y0IWww-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:18 INFO - Running setup.py (path:/tmp/pip-4NkZc4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:18 INFO - Running setup.py (path:/tmp/pip-m2tZqR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:18 INFO - Running setup.py (path:/tmp/pip-te6w8E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:18 INFO - Running setup.py (path:/tmp/pip-f2glYr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:18 INFO - Running setup.py (path:/tmp/pip-islKrY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:18 INFO - Running setup.py (path:/tmp/pip-OOTIB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:18 INFO - Running setup.py (path:/tmp/pip-nHOuQ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:18 INFO - Running setup.py (path:/tmp/pip-x8Bl3m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:18 INFO - Running setup.py (path:/tmp/pip-nNyj9B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:19 INFO - Running setup.py (path:/tmp/pip-JudNbG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:19 INFO - Running setup.py (path:/tmp/pip-NVMw40-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:19 INFO - Running setup.py (path:/tmp/pip-tUgTuu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:19 INFO - Running setup.py (path:/tmp/pip-uLGrI9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:19 INFO - Running setup.py (path:/tmp/pip-vz7aoM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:03:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:21 INFO - Downloading blessings-1.5.1.tar.gz 14:03:21 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:03:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:03:21 INFO - Installing collected packages: blessings 14:03:21 INFO - Running setup.py install for blessings 14:03:21 INFO - Successfully installed blessings 14:03:21 INFO - Cleaning up... 14:03:21 INFO - Return code: 0 14:03:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:03:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:03:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:03:21 INFO - Reading from file tmpfile_stdout 14:03:21 INFO - Current package versions: 14:03:21 INFO - argparse == 1.2.1 14:03:21 INFO - blessings == 1.5.1 14:03:21 INFO - blobuploader == 1.2.4 14:03:21 INFO - docopt == 0.6.1 14:03:21 INFO - manifestparser == 1.1 14:03:21 INFO - mozInstall == 1.12 14:03:21 INFO - mozcrash == 0.16 14:03:21 INFO - mozdebug == 0.1 14:03:21 INFO - mozdevice == 0.48 14:03:21 INFO - mozfile == 1.2 14:03:21 INFO - mozhttpd == 0.7 14:03:21 INFO - mozinfo == 0.9 14:03:21 INFO - mozleak == 0.1 14:03:21 INFO - mozlog == 3.1 14:03:21 INFO - moznetwork == 0.27 14:03:21 INFO - mozprocess == 0.22 14:03:21 INFO - mozprofile == 0.28 14:03:21 INFO - mozrunner == 6.11 14:03:21 INFO - mozscreenshot == 0.1 14:03:21 INFO - mozsystemmonitor == 0.0 14:03:21 INFO - moztest == 0.7 14:03:21 INFO - mozversion == 1.4 14:03:21 INFO - psutil == 3.1.1 14:03:21 INFO - requests == 1.2.3 14:03:21 INFO - wsgiref == 0.1.2 14:03:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f51128cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e840>, '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 0x279b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279bb60>, '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': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:03:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:03:21 INFO - Using env: {'DISPLAY': ':0', 14:03:21 INFO - 'HOME': '/home/cltbld', 14:03:21 INFO - 'LANG': 'en_US.UTF-8', 14:03:21 INFO - 'LANGUAGE': 'en_US:en', 14:03:21 INFO - 'LOGNAME': 'cltbld', 14:03:21 INFO - 'MAIL': '/var/mail/cltbld', 14:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:21 INFO - 'MOZ_NO_REMOTE': '1', 14:03:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:21 INFO - 'NO_EM_RESTART': '1', 14:03:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:21 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:21 INFO - 'SHELL': '/bin/bash', 14:03:21 INFO - 'SHLVL': '1', 14:03:21 INFO - 'TERM': 'linux', 14:03:21 INFO - 'TMOUT': '86400', 14:03:21 INFO - 'USER': 'cltbld', 14:03:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 14:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:21 INFO - '_': '/tools/buildbot/bin/python'} 14:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 14:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:03:21 INFO - Cleaning up... 14:03:21 INFO - Return code: 0 14:03:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f51128cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e840>, '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 0x279b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279bb60>, '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': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:03:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:03:21 INFO - Using env: {'DISPLAY': ':0', 14:03:21 INFO - 'HOME': '/home/cltbld', 14:03:21 INFO - 'LANG': 'en_US.UTF-8', 14:03:21 INFO - 'LANGUAGE': 'en_US:en', 14:03:21 INFO - 'LOGNAME': 'cltbld', 14:03:21 INFO - 'MAIL': '/var/mail/cltbld', 14:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:21 INFO - 'MOZ_NO_REMOTE': '1', 14:03:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:21 INFO - 'NO_EM_RESTART': '1', 14:03:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:21 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:21 INFO - 'SHELL': '/bin/bash', 14:03:21 INFO - 'SHLVL': '1', 14:03:21 INFO - 'TERM': 'linux', 14:03:21 INFO - 'TMOUT': '86400', 14:03:21 INFO - 'USER': 'cltbld', 14:03:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 14:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:21 INFO - '_': '/tools/buildbot/bin/python'} 14:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:22 INFO - Downloading/unpacking jsonschema 14:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:03:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:03:23 INFO - Downloading/unpacking functools32 (from jsonschema) 14:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:23 INFO - Downloading functools32-3.2.3-2.tar.gz 14:03:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:03:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:03:24 INFO - warning: no files found matching '*.txt' 14:03:24 INFO - no previously-included directories found matching 'build' 14:03:24 INFO - no previously-included directories found matching 'dist' 14:03:24 INFO - no previously-included directories found matching '.git*' 14:03:24 INFO - Installing collected packages: jsonschema, functools32 14:03:24 INFO - Running setup.py install for functools32 14:03:24 INFO - warning: no files found matching '*.txt' 14:03:24 INFO - no previously-included directories found matching 'build' 14:03:24 INFO - no previously-included directories found matching 'dist' 14:03:24 INFO - no previously-included directories found matching '.git*' 14:03:24 INFO - Successfully installed jsonschema functools32 14:03:24 INFO - Cleaning up... 14:03:24 INFO - Return code: 0 14:03:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f51128cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e840>, '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 0x279b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279bb60>, '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': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:03:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:03:24 INFO - Using env: {'DISPLAY': ':0', 14:03:24 INFO - 'HOME': '/home/cltbld', 14:03:24 INFO - 'LANG': 'en_US.UTF-8', 14:03:24 INFO - 'LANGUAGE': 'en_US:en', 14:03:24 INFO - 'LOGNAME': 'cltbld', 14:03:24 INFO - 'MAIL': '/var/mail/cltbld', 14:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:24 INFO - 'MOZ_NO_REMOTE': '1', 14:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:24 INFO - 'NO_EM_RESTART': '1', 14:03:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:24 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:24 INFO - 'SHELL': '/bin/bash', 14:03:24 INFO - 'SHLVL': '1', 14:03:24 INFO - 'TERM': 'linux', 14:03:24 INFO - 'TMOUT': '86400', 14:03:24 INFO - 'USER': 'cltbld', 14:03:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 14:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:24 INFO - '_': '/tools/buildbot/bin/python'} 14:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:24 INFO - Downloading/unpacking flake8 14:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:03:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:03:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:03:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:03:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:03:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:03:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:03:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:26 INFO - no previously-included directories found matching 'docs/_build' 14:03:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:03:26 INFO - Running setup.py install for pep8 14:03:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:26 INFO - no previously-included directories found matching 'docs/_build' 14:03:26 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:03:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:03:27 INFO - Cleaning up... 14:03:27 INFO - Return code: 0 14:03:27 INFO - Running post-action listener: _resource_record_post_action 14:03:27 INFO - Running post-action listener: _start_resource_monitoring 14:03:27 INFO - Starting resource monitoring. 14:03:27 INFO - ##### 14:03:27 INFO - ##### Running install step. 14:03:27 INFO - ##### 14:03:27 INFO - Running pre-action listener: _resource_record_pre_action 14:03:27 INFO - Running main action method: install 14:03:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:03:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:03:27 INFO - Reading from file tmpfile_stdout 14:03:27 INFO - Detecting whether we're running mozinstall >=1.0... 14:03:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:03:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:03:27 INFO - Reading from file tmpfile_stdout 14:03:27 INFO - Output received: 14:03:27 INFO - Usage: mozinstall [options] installer 14:03:27 INFO - Options: 14:03:27 INFO - -h, --help show this help message and exit 14:03:27 INFO - -d DEST, --destination=DEST 14:03:27 INFO - Directory to install application into. [default: 14:03:27 INFO - "/builds/slave/test-pgo"] 14:03:27 INFO - --app=APP Application being installed. [default: firefox] 14:03:27 INFO - mkdir: /builds/slave/test-pgo/build/application 14:03:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:03:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:03:43 INFO - Reading from file tmpfile_stdout 14:03:43 INFO - Output received: 14:03:43 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:03:43 INFO - Running post-action listener: _resource_record_post_action 14:03:43 INFO - ##### 14:03:43 INFO - ##### Running run-tests step. 14:03:43 INFO - ##### 14:03:43 INFO - Running pre-action listener: _resource_record_pre_action 14:03:43 INFO - Running main action method: run_tests 14:03:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:03:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:03:43 INFO - Python 2.7.3 14:03:43 INFO - Return code: 0 14:03:43 INFO - grabbing minidump binary from tooltool 14:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:43 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 0x282e840>, '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 0x279b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:03:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:03:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:03:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:43 INFO - Return code: 0 14:03:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:03:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:03:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:03:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:03:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:03:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:03:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:03:44 INFO - Return code: 0 14:03:44 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:03:44 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:03:44 INFO - Using env: {'DISPLAY': ':0', 14:03:44 INFO - 'HOME': '/home/cltbld', 14:03:44 INFO - 'LANG': 'en_US.UTF-8', 14:03:44 INFO - 'LANGUAGE': 'en_US:en', 14:03:44 INFO - 'LOGNAME': 'cltbld', 14:03:44 INFO - 'MAIL': '/var/mail/cltbld', 14:03:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:03:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:44 INFO - 'MOZ_NO_REMOTE': '1', 14:03:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:44 INFO - 'NO_EM_RESTART': '1', 14:03:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:44 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:03:44 INFO - 'SHELL': '/bin/bash', 14:03:44 INFO - 'SHLVL': '1', 14:03:44 INFO - 'TERM': 'linux', 14:03:44 INFO - 'TMOUT': '86400', 14:03:44 INFO - 'USER': 'cltbld', 14:03:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499', 14:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:44 INFO - '_': '/tools/buildbot/bin/python'} 14:03:44 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:03:44 INFO - mozversion application_buildid: 20160118113035 14:03:44 INFO - mozversion application_changeset: 9f9b83007c01f8e86cf65148c193d8aec7369d35 14:03:44 INFO - mozversion application_display_name: Nightly 14:03:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:44 INFO - mozversion application_name: Firefox 14:03:44 INFO - mozversion application_remotingname: firefox 14:03:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:03:44 INFO - mozversion application_vendor: Mozilla 14:03:44 INFO - mozversion application_version: 46.0a1 14:03:44 INFO - mozversion platform_buildid: 20160118113035 14:03:44 INFO - mozversion platform_changeset: 9f9b83007c01f8e86cf65148c193d8aec7369d35 14:03:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:03:44 INFO - mozversion platform_version: 46.0a1 14:03:44 INFO - using testdate: 1453154624 14:03:44 INFO - actual date: 1453154624 14:03:44 INFO - starting webserver on 'localhost:55834' 14:03:44 INFO - SUITE-START | Running 3 tests 14:03:44 INFO - TEST-START | dromaeo_css 14:03:44 INFO - operating with platform_type : linux_ 14:03:44 INFO - Initialising browser for dromaeo_css test... 14:03:44 INFO - TEST-INFO | started process 31928 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpj4JHOu/profile http://localhost:55834/getInfo.html) 14:03:48 INFO - PROCESS | 31928 | __metrics Screen width/height:1600/1200 14:03:48 INFO - PROCESS | 31928 | colorDepth:24 14:03:48 INFO - PROCESS | 31928 | Browser inner width/height: 1024/697 14:03:48 INFO - PROCESS | 31928 | __metrics 14:03:48 INFO - PROCESS | 31928 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:03:48 INFO - PROCESS | 31928 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:03:49 INFO - TEST-INFO | 31928: exit 0 14:03:49 INFO - Browser initialized. 14:03:49 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:49 INFO - TEST-INFO | started process 32022 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpj4JHOu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:04:01 INFO - PROCESS | 32022 | RSS: Main: 148787200 14:04:01 INFO - PROCESS | 32022 | 14:04:52 INFO - PROCESS | 32022 | 1453154692960 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:07:00 INFO - PROCESS | 32022 | Cycle 1(1): loaded http://localhost:55834/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55834/tests/dromaeo/cssquery-ext.html) 14:07:02 INFO - PROCESS | 32022 | RSS: Main: 268070912 14:07:02 INFO - PROCESS | 32022 | 14:10:04 INFO - PROCESS | 32022 | Cycle 1(1): loaded http://localhost:55834/tests/dromaeo/cssquery-ext.html (next: http://localhost:55834/tests/dromaeo/cssquery-jquery.html) 14:10:05 INFO - PROCESS | 32022 | RSS: Main: 231866368 14:10:05 INFO - PROCESS | 32022 | 14:13:07 INFO - PROCESS | 32022 | Cycle 1(1): loaded http://localhost:55834/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55834/tests/dromaeo/cssquery-mootools.html) 14:13:07 INFO - PROCESS | 32022 | RSS: Main: 218198016 14:13:07 INFO - PROCESS | 32022 | 14:16:09 INFO - PROCESS | 32022 | Cycle 1(1): loaded http://localhost:55834/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55834/tests/dromaeo/cssquery-prototype.html) 14:16:10 INFO - PROCESS | 32022 | RSS: Main: 202522624 14:16:10 INFO - PROCESS | 32022 | 14:19:12 INFO - PROCESS | 32022 | Cycle 1(1): loaded http://localhost:55834/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55834/tests/dromaeo/cssquery-yui.html) 14:19:13 INFO - PROCESS | 32022 | RSS: Main: 209432576 14:19:13 INFO - PROCESS | 32022 | 14:22:16 INFO - PROCESS | 32022 | Cycle 1(1): loaded http://localhost:55834/tests/dromaeo/cssquery-yui.html (next: http://localhost:55834/tests/dromaeo/cssquery-dojo.html) 14:22:16 INFO - PROCESS | 32022 | RSS: Main: 269905920 14:22:16 INFO - PROCESS | 32022 | 14:22:16 INFO - PROCESS | 32022 | __start_tp_report 14:22:16 INFO - PROCESS | 32022 | _x_x_mozilla_page_load 14:22:16 INFO - PROCESS | 32022 | _x_x_mozilla_page_load_details 14:22:16 INFO - PROCESS | 32022 | |i|pagename|runs| 14:22:16 INFO - PROCESS | 32022 | |0;dojo.html;3083.4449799036174;3115.890943816964;3152.7320177784886;3162.067190178897;3186.3786561620477;4970.726610036447;5044.798208071677;5050.494950504953;5072.087024335628;5103.540681338679;5065.822696205633;5098.617603679721;5104.64267501275;5118.9488105118935;5121.052605268028;4609.953900460994;4619.399478067863;4648.209804333254;4698.248280275139;4698.530146985308;4673.929891051637;4692.202325604639;4730.597899178574;4732.952670473285;4740.881477963044;4551.112533056039;4613.6539759518;4642.373279607244;4712.976435117836;4727.550882666142;4658.55743704351;4680.906381872377;4687.320338550925;4692.835750748707;4704.200285951397;4646.4424269087585;4650.813967441299;4660.766961651904;4663.417072865892;4705.694129881581;4721.716696998157;4804.6876952997945;4864.1974074277705;4924.581410580105;4925.630577706651;5375.22059301403;5379.435159308256;5394;5401.972990135024;5412.9458705412835;5302.257683924254;5414.214938833887;5416.926647864811;5430.5927055471;5477.835664930059;5079.517445842639;5113.156329205676;5129.974350128263;5161.354830646169;5169.6639718418555;5597.720113994284;5601.691906945076;5605.747741351649;5607.691576963224;5617.438256174431;5214.869628259248;5371.6239863209985;5388.838334849961;5389.649672771257;5390.568754499631;5367.168088946141;5386.946130538723;5431.891362172734;5440.129579267377;5485;5378.435264297193;5397.163439666858;5398.2982212312145;5407.783688652488;5410.026195284808;5236.397814251333;5374.462553744673;5410.648307859977;5417.3770016447825;5456.727163641802;4193.811278492414;4224.619784219373;4251.447311849502;4252.723572967747;4265.168292182994;3776.4146557283666;3791.5071040764524;3806.467094606757;3821.9617803821607;3826.846926122924;4952.70283782967;5022.497750225021;5037.395512538519;5044.086106918689;5078.415982162099;5402.486763757437;5408.215808707715;5446.509814116748;5500.614956953055;5511.3937466878615;5030.0694371541385;5039.26930595069;5041.823536176216;5046;5086.669366491166;4597.126545956257;4670.206064968964;4677.111348843709;4678.204705200124;4715.976420117946;5535.391106978229;5584.720763961785;5643.830685079454;5654.40628733977;5692.943070569241;5400.405955344988;5420.4037555868035;5426;5430.076886929311;5433.266509021231;5503.7798488061635;5570.387257401763;5592.273004509388;5624.437556244343;5670.404607516151;5272.604554658493;5308.177232528964;5314.4951229633125;5318.122509785842;5337.412884582615;5386.245925570502;5451.727413629382;5453.072977593739;5454.481824226851;5501.257330260363;5251.05481013406;5275.472452754847;5279.973600131974;5330.626856120034;5385.1922211667;5245.9475405246985;5252.474752524717;5253.080710875505;5260.44765299638;5296.311479507794;5166.8966620668125;5181.041507321158;5188.273641690242;5196.220566914993;5238.345206849144;5220.3213582235585;5257.342832145981;5269.341332333458;5285.180796976475;5304.124819404909;5208.869778255574;5228.58171346299;5232.581393488435;5233.345831771028;5237.371515418175 14:22:16 INFO - PROCESS | 32022 | |1;ext.html;535.4484880573011;563.9774409023639;581.5522048023022;592.4431034827262;597.6832278892188;28122.85938570307;28627.713722862765;28640;36337.81831090847;36578.902632921054;39156.60843391565;39538.406923896095;39557;39604.20791584167;39636.40545391821;8415.579221038939;8614.224719775219;8618.095100014501;8619.913800862005;8625.353098517606;8362.58187090643;8452.61963211657;8492.193241642035;8499.150084991514;8505.362097842655;8662.220400163984;8727.38908276421;8730.912690873074;8742.213200811926;8745.08176641453;8591.871121933176;8636.352273579507;8671.349648776304;8682.956585217033;8683.826323473559;8392.118827523083;8448.662053517914;8455.239028487465;8498.872516912252;8499.150084991514;39036.60963390358;39458.60541394578;39480;39506.20987580232;39534.209315813525;3162.478191098466;3279.3277378137664;3279.9016029519153;3470.1845066409373;3843.3658446356317;31074.378512429852;31633.52549711756;31645.683543164734;31712.841435792674;32474.67525324764;3782.205736795276;3784;3841.3661745811905;3878;4024.5170579530645;216539;220627;220649;221489;221777;54131.45868541343;54542;58273;61213;62088.68955655193;60874.08688869671;61796.69101654553;61855.381446185864;61889.690551546955;62239.37760622336;14358;14453.349599268058;14544.345504452325;14549.78175327371;14566.34451449666;9832.852507212398;10057.899421005697;10248.38509689421;10439.164866810637;10446.216533759847;20344.59310813805;20597.176112955614;20641.48396290105;20681;20695.482612934797;7833.921660783433;8553;8577.185167409087;8619.448499270191;8662.6101825418;932.6735642525198;934.5280633280286;987.3878195518681;987.5654711926729;1028.4189432970347;25175;27214.45571088567;27762;27881.72118278832;27913.44173116526;1019.6278358399279;1040.5317607076845;1043.3896170740202;1108.6009036746764;1182.438341787661;14764.335604897806;14875.33061012257;14934.402623894923;14960;14992.850071499364;365940;377706;381303;381924;382548;52875.20687189695;52965;53277.46722532725;53352.466475335525;53425.73287133617;1183.426053318972;1279.8720127987126;1322.0877594459791;1381.647679841654;1439.6113049476583;27738.167854964384;28690.713092868806;29066.854665727384;29169;29324;42525.149497010505;46630.53369466262;47721.28418073662;47761.28358074562;47924.7603761979;268011;304387;310809;311949;312154;40931.795341023106;41424.58575414207;42311.576884230766;42427.575724243594;42481.36277955771;44532.10935781201;44793.552064478936;44861.551384485734;45113.0977380444;45758.54241457543;38257;38376;38852;38906.221875561765;39387.80306098451;35897.28205435929;35955;36691.63308366989;36943.07642308964;37209.813950930074;35739;35800;35811.10472238215;35872.10319742027;36096.63903361038;32361.19097022499;33091;34011.82994085014;35586.28827423489;35587;22728.318150455514;22988.540229194987;22988.655170172126;23224.88387558119;23260.65109023332 14:22:16 INFO - PROCESS | 32022 | |2;jquery.html;364.64811456944045;366.74511214705774;366.9467927150562;368.3406702003414;369.9445083237514;13636.863631363683;13719.65700857479;15579.45471908482;16888.155592220402;17857.732134018;10890.564377424893;11356.659300221007;16222.83777162228;16737.246823892925;16757.83242167578;4918.778654960526;5091.592672586203;5092.490750924915;5094.872628184288;5095.719735414551;3829.636184562462;3970.2258059678375;5001.774920128585;5070.645054846163;5300.761465734032;5445.074337362658;5474.370447398541;5495.203195536645;5497.367802702701;5498.257735205736;5644.266245388094;6088.908666370008;6103.26760788706;6107.725152368154;6119.143319935212;5192.6105542084115;5364.91952620711;5412.4587541245955;5414.431484694129;5418.566514678816;19200;19540.413787586396;19897.502562436053;19905.303314383927;20265.392038238875;2110.2403134871433;2127.8829664368454;2133.6479480885637;2181.640029395148;2188.7592364839857;9130.497822619753;9511.286653500945;9583.712488625353;11514;12385.823346782041;1772.858171346302;1858.358866191162;1866.1602278974515;1867.6451474219855;1873.297513432463;55262;55779.442205577834;57223;57294;57404.13893791597;9969.80060398788;10273.691789246184;10282.383057016603;10294.382337059651;10302.433366164933;13139.277339746215;13559.932200339132;13602.523911663044;13606.251656159006;13625.454981800814;7147.53541019832;7153.6780844862105;7200.459965502609;7257.092863392076;7342.4493163012985;6823.761168359084;6826.317368263233;6853.314668533107;6906.930930690729;6910;4408.470983482002;4501.257292546758;4503.301988191835;4535.115652447741;4541.364209010675;1697.6434948660672;1711.8801683882257;1757.5254681235995;1773.6254402837903;1797.7213531902576;863.8185980943947;877.6840337478502;884.3897710579679;900.4912224593215;976.1458723616835;13190;15362.923185384001;15477.613059673598;16209.513714588582;16368.427105051504;828.5939889454124;882.6116508736136;913.584319134792;931.9440833550009;934.9532523373804;8475.74572762818;8768.027193881453;8880.067592902782;8980.101989801098;9001.234895033864;414135.7571764438;456453;462199;477756;481573;65614;66219.66890165614;67142.66428667922;70813;71268;1109.5284504085732;1157.6353448663644;1158.652404278713;1164.7088227943013;1165.8600967883738;13551.186928784304;14139.575812725634;14602.707945840812;14925.477608283658;15316.540503784905;30040.84979575088;30143.246418839706;30203;30941;31220.843895780377;36716.26567468582;38060.2387952245;38140.618593813706;39405.605943940194;40335.39496907607;4037.4953130858644;5046.9747651261505;7158.964205178941;7171.784846454615;7401.0748656417945;8725;10521.316114452537;10634.8936510637;10864.45677716127;11234.045106166068;2732.221316924667;2760.5169095408623;6330.733853229281;9105.408148470327;9494.430334179971;9069.776722469453;9699.369540979813;9700.660476883557;9847.950760246153;9855.45794981283;9838.75403114928;10001.599936002478;10100.393976361442;10106.19150467946;10127.189824814144;7238.855222895618;7660.310572048319;7703.152653208031;7724.343430808444;7744.4578879477895;6968.045738355537;8702.738917832476;9732.70801875945;10012.849807253042;10068 14:22:16 INFO - PROCESS | 32022 | |3;mootools.html;1347.5822495026548;1453.6801903581209;1459.2193176650492;1591.9442819501312;1762.5769815244346;6455.160829092218;7140.607266600335;7246.96376518118;7252.492325537214;7256.2743725627415;7154.678039488223;7265.963670181642;7282.563046217218;7307.817304567375;7322.9267707322915;1948.9707654385195;1989.333573252962;1991.163711241275;2248.999999999996;2277.6241920083166;1986.0566231040214;2262.4457008033055;2327.2320134355623;2327.9883600581975;2332.3935776698095;2131;2166.631672615659;2200.9119635214574;2202.603531364354;2202.8237740980762;2256.277991042867;2263.660450932357;2265.6261716816707;2267.331137314496;2268.6256767633404;2224.065892325227;2275.6472746724116;2275.7496675365696;2276.681264622954;2284.3603790938564;7061.788146355618;7116.5018448708615;7120.6439678015895;7131.714731410737;7131.750388736421;4450.621697155713;4525.773711314454;4527.796249168795;4529.660275479352;4556.840510582114;3001.384716133209;3125.1874512626655;3142.1359126240236;3149.653538110806;3161.8893338733264;1024.1755386913533;1053.0943388685723;1053.7312985188728;1054.72577129946;1106.6403418888813;9683.854742178873;9831.901680983241;9835.360701554377;9838.90161098387;9845.704628861145;4074.4703188585295;4106.281400754856;4166.437530933345;4167.416561681367;4173.040200753843;8541.273991710774;8595.44129631572;8599.742007739778;8617.138286171332;8626.870596941051;4535.274356103007;4542.046170304207;4574.199515084847;4576.748278844629;4579.404677391918;4172.457580514514;4206.957930420718;4215.072684009513;4215.87352379423;4219.177260434186;3360.647132051148;3550.6449355064806;3569.8572057117426;3581.086822860154;3598.604153543108;1123.1127409346689;1199.9220050696852;1204.3015051270243;1221.1390969366576;1224.7856625090574;923.072312326108;937.0254934867661;939.3330735177964;1116.7208197950513;1202.9518819247307;6606.339366063356;6660.800175994728;6671.032700258435;6681.732730690718;6693.765718199839;1093.147345070846;1093.2511229807608;1095.9178061645248;1104.2215238257008;1135.5855112883737;5257.053730328577;5300.840974770763;5334.413214546396;5418.45815418455;5421.403645598981;8490.957545212234;8601.526916019679;8790.472571645721;8864.911350886538;8869.113088691209;8641.740747777576;8662.826743465095;8746.212840844228;8748.956255218684;8755.168259015383;6813.897791533131;6916.20463646677;6944.826379340557;6976.790696279119;6983.82540436483;6670.833229169116;6676.866462670817;6687;6724.596524208563;6745.25802161752;7586.886196707164;7816.687332506864;8081.272685458337;8119.5534245617055;8122.431429800094;8026.1572534883;8187.877181842397;8202.05676347204;8348.749537513884;8353.95823020881;6308.653024083719;6645;6696.698648560924;6711.429528490133;6730.158730158731;6356.078368636614;6505.967470162619;6636.9004464932095;6739.865202696017;6755.189377274562;6414.069959855888;6466.06242094903;6476.740930362733;6534.509911756542;6592.835179120369;6359.332270111571;6375.6174629522375;6399.93600064012;6527.543071985106;6557.278699342973;6514.54398192141;6547.70535325902;6602.636854973022;6609.537332386687;6611.933880661324;5958.433948774859;5965.612235204698;6004.39956004396;6042.667653279112;6047.274327080779;5986.850328741816;6089.51283897296;6095.603785753912;6119.265688117454;6127.264728232641 14:22:16 INFO - PROCESS | 32022 | |4;prototype.html;333.7680312183033;336.6397954189017;346.70703255748884;351.2781234562972;351.3447420560655;5713.285839270091;5755.913661295084;5792.507636850863;5801.999999999989;5862.530997520199;5727.942720572793;5732.111522713975;5741.138829175626;5742.339630942442;5743.483086522212;4531.954680453195;4532.728036317815;4533.116042371739;4537.069900670354;4543.3639290499195;4446.1107778444275;4515.503294637587;4527.253003254459;4533.977330113345;4541.636669066466;4489.034857505636;4493.820247190109;4495.056038231975;4501.167284052461;4506.031203291292;4271.252530807096;4384.167008268419;4486.327050942352;4489.528599497038;4503.392042074311;3903.160820423594;3968.464257325253;3977.7414468059483;3981.880543583668;4002.639762421367;5480.698561579112;5497.306319903259;5497.862553436156;5500.724963751836;5510.8071217507195;4906.852794416173;4920.6801557898625;5113.309703190059;5206.453322401131;5210.609204309692;6074.240719910012;6076.635401875901;6077.848053798646;6086.087086936951;6096.4817990470865;4426.933595996063;4428.070105277896;4433.13553856998;4434.334849772527;4436.55634436557;6209.5032397408095;6378.712957916905;6386.3613638636225;6387.073874288249;6392;4545.568171023748;4546.840860569864;4547.272436410159;4548.067646132601;4553.225951588238;4593.770311484413;4603.493615702337;4605.631549476034;4605.953940460552;4606.792694328763;5219.6607220531305;5220.1647736362;5225.059489291964;5226.529612334832;5232.136697444955;5997.160397544348;6103.298120716086;6130.080487926846;6138.907916381258;6142.355052719489;1599.5201439568084;1622.0429946331722;1622.6349071459063;1622.9431969881234;1623.5129461161605;1102.3165637304921;1104.635470294817;1110.7167672243688;1112.7718817642365;1129.8022846001916;5808.651480911159;5813;5816.651000939957;5823.679697616587;5829.067349224189;6289.77985770505;6295.5907865988565;6296.307406185316;6298.401651843067;6306.842328941813;5800.1299805029585;5804.477597016289;5806.82579522615;5808.941910580925;5813.215215945793;3260.7065364117343;3385.5260263563123;3385.644507326695;3390.4744764561533;3392;6526.184226971629;6529.347065293433;6541.149650545493;6542.051402546699;6542.967285163544;6215.192025036807;6425.357464253537;6425.775097871552;6426.742930282736;6434.7104380303;6177.289611694623;6418.646974416359;6527;6625.072489851328;6636.469082473487;6224.128621993015;6329.208848893888;6344.30212676596;6353.618782873043;6356.841078973062;6089.451949324582;6301.747930082745;6303.401176888188;6304.842378940563;6305.558610897193;6417.197850268716;6516.837079073061;6524.119243902012;6541.901871471837;6617.974213996838;4413.691041627056;4466.8609504576125;4489.483709373464;4519.389882365838;4525.162844873709;6273.121762953099;6274.435300822948;6280.685965701788;6282.4974002080635;6289.308176100717;6012.128241405059;6212.565120441525;6218.19163508741;6221.346758590283;6228.56400051992;6197.194364732556;6201.069839524108;6206.751729930752;6208.72060757258;6209.59637623553;6076.726547305293;6093.9085913712215;6100.267967843887;6121.755129794937;6144.754209831557;6047.183630210041;6227.408396202353;6233.625982441068;6239.407256310643;6239.407256310643;6089.786857459968;6091.451769340781;6094.299155597163;6096.542759293159;6096.664683442454 14:22:16 INFO - PROCESS | 32022 | |5;yui.html;757.924207579242;784.4587234807982;812.9349652027838;817.1501638296172;847.6948298612502;11743.823842642356;12021.27872327661;12030.977366923822;12039.51841926324;12091.214071085373;11651.883481165185;11690.824637630443;11707.180497365187;11727.354995475245;11742.589009384674;646.0567571345829;656.4977791989132;656.7143292667705;657.0604036228216;772.818387678895;770.9653065612061;777.5762209595783;777.793884620576;778.1945686214768;781.6287263549797;814.9633266503022;816.885636010956;823.283743143466;833.9499630022187;834.4909605140859;822.576373167819;832.6669332267111;832.7293629570414;833.5623797506297;834.6077343648476;505.7016360347413;511.7211119939642;605.4883623338272;616.8427051101985;617.4257940115691;12037.699057523545;12038.4582693779;12045.63863084109;12073.517059317617;12107.878921210764;12067.275963442222;12628.242305461701;12881.484740610364;12943.352832358438;13015.023873209548;9588.328816982814;9605.615775368977;9621.567029483691;9687.128158465772;9769.609215631366;3489.7382696297627;3544.7164226861787;3571.8035508047046;3587.7488575799703;3637.399829028207;47985.28022079637;48332.75833620809;50858.491415085744;50989.49010509885;51312.99999999963;9528.380655257386;9559.330846840654;9658.468784216935;9845.704628861145;9920.950395247977;16043.679126417406;16126;16163.838361616468;16201.270942807601;16408.425705100264;7369.668364923591;7450.18048014718;7538.434617403607;7551;7566.827141793031;4097.815598298024;4165.854195103157;4225.070484493406;4226.725262857904;4239.554846741109;2996.340805022935;3050;3058.740007099377;3061.969380306168;3066.264096616796;561.612487383704;573.3091624592356;578.3840210176149;587.2336600735995;593.2999061107848;493.7457209537091;569.7977218087602;602.8583282928508;647.6567419267795;666.1827727123513;8187.222213889671;8456.534890580953;8459.407841451039;8476.53379064145;8704.738857834274;567.8921005009036;585.7949717598806;610.2493932463095;637.1939496536885;655.5804285257439;3626.927461450809;3888.319544079775;3963.3460479020637;4009.077912080238;4058.411530328145;50837;51223;51258.23112653313;51409;51634.74182629063;49120.50879491231;49505.31678223394;50336.49663503392;52042.73978630159;52148.47851521512;44577.331340029275;44749.32876006862;45511.317330240076;45562.316565251545;46767.76616116898;7958.442908996315;8197.631106600098;8413.200745929127;8819;8888.688895888612;33965.15087122842;34245.82877085599;34499.82750086234;35857.28285434329;35873.64126358703;44440.55559444364;44901.32648010217;45127;45351.31973020342;46030.309545357515;10034.69895903124;10245.538950747085;10358.796585363561;10513.897220556073;10639.680809575726;11998.820017699567;12223.327716975651;12338.198017128858;12389.380530973596;12391.876081239432;10412.947935260578;10739.463026848782;10968.23222374426;11026.393548354918;11165.49755260999;11188.272762270426;11445.370504622326;11569.305841649528;11761.705957350792;11777.646670599896;11504.769904602028;11697.707557311136;11750.529978801094;11775.175737698279;11850.644480665595;9152.222061124612;9173.02110493427;9239.0791701211;9554.62201604707;9820.263480238867;8878.378513503993;8884.378093533649;8909.198172164537;9136.451812891248;9429.481378524248 14:22:16 INFO - PROCESS | 32022 | __end_tp_report 14:22:16 INFO - PROCESS | 32022 | __start_cc_report 14:22:16 INFO - PROCESS | 32022 | _x_x_mozilla_cycle_collect,975 14:22:16 INFO - PROCESS | 32022 | __end_cc_report 14:22:16 INFO - PROCESS | 32022 | __startTimestamp1453155736342__endTimestamp 14:22:16 INFO - PROCESS | 32022 | 14:22:16 INFO - PROCESS | 32022 | ------- Summary: start ------- 14:22:16 INFO - PROCESS | 32022 | Number of tests: 6 14:22:16 INFO - PROCESS | 32022 | 14:22:16 INFO - PROCESS | 32022 | [#0] dojo.html Cycles:165 Average:5045.06 Median:5228.58 stddev:529.35 (10.1%) stddev-sans-first:508.12 14:22:16 INFO - PROCESS | 32022 | Values: 3083.4 3115.9 3152.7 3162.1 3186.4 4970.7 5044.8 5050.5 5072.1 5103.5 5065.8 5098.6 5104.6 5118.9 5121.1 4610.0 4619.4 4648.2 4698.2 4698.5 4673.9 4692.2 4730.6 4733.0 4740.9 4551.1 4613.7 4642.4 4713.0 4727.6 4658.6 4680.9 4687.3 4692.8 4704.2 4646.4 4650.8 4660.8 4663.4 4705.7 4721.7 4804.7 4864.2 4924.6 4925.6 5375.2 5379.4 5394.0 5402.0 5412.9 5302.3 5414.2 5416.9 5430.6 5477.8 5079.5 5113.2 5130.0 5161.4 5169.7 5597.7 5601.7 5605.7 5607.7 5617.4 5214.9 5371.6 5388.8 5389.6 5390.6 5367.2 5386.9 5431.9 5440.1 5485.0 5378.4 5397.2 5398.3 5407.8 5410.0 5236.4 5374.5 5410.6 5417.4 5456.7 4193.8 4224.6 4251.4 4252.7 4265.2 3776.4 3791.5 3806.5 3822.0 3826.8 4952.7 5022.5 5037.4 5044.1 5078.4 5402.5 5408.2 5446.5 5500.6 5511.4 5030.1 5039.3 5041.8 5046.0 5086.7 4597.1 4670.2 4677.1 4678.2 4716.0 5535.4 5584.7 5643.8 5654.4 5692.9 5400.4 5420.4 5426.0 5430.1 5433.3 5503.8 5570.4 5592.3 5624.4 5670.4 5272.6 5308.2 5314.5 5318.1 5337.4 5386.2 5451.7 5453.1 5454.5 5501.3 5251.1 5275.5 5280.0 5330.6 5385.2 5245.9 5252.5 5253.1 5260.4 5296.3 5166.9 5181.0 5188.3 5196.2 5238.3 5220.3 5257.3 5269.3 5285.2 5304.1 5208.9 5228.6 5232.6 5233.3 5237.4 14:22:16 INFO - PROCESS | 32022 | 14:22:16 INFO - PROCESS | 32022 | [#1] ext.html Cycles:180 Average:47091.20 Median:210402.50 stddev:80604.62 (38.3%) stddev-sans-first:80754.95 14:22:16 INFO - PROCESS | 32022 | Values: 535.4 564.0 581.6 592.4 597.7 28122.9 28627.7 28640.0 36337.8 36578.9 39156.6 39538.4 39557.0 39604.2 39636.4 8415.6 8614.2 8618.1 8619.9 8625.4 8362.6 8452.6 8492.2 8499.2 8505.4 8662.2 8727.4 8730.9 8742.2 8745.1 8591.9 8636.4 8671.3 8683.0 8683.8 8392.1 8448.7 8455.2 8498.9 8499.2 39036.6 39458.6 39480.0 39506.2 39534.2 3162.5 3279.3 3279.9 3470.2 3843.4 31074.4 31633.5 31645.7 31712.8 32474.7 3782.2 3784.0 3841.4 3878.0 4024.5 216539.0 220627.0 220649.0 221489.0 221777.0 54131.5 54542.0 58273.0 61213.0 62088.7 60874.1 61796.7 61855.4 61889.7 62239.4 14358.0 14453.3 14544.3 14549.8 14566.3 9832.9 10057.9 10248.4 10439.2 10446.2 20344.6 20597.2 20641.5 20681.0 20695.5 7833.9 8553.0 8577.2 8619.4 8662.6 932.7 934.5 987.4 987.6 1028.4 25175.0 27214.5 27762.0 27881.7 27913.4 1019.6 1040.5 1043.4 1108.6 1182.4 14764.3 14875.3 14934.4 14960.0 14992.9 365940.0 377706.0 381303.0 381924.0 382548.0 52875.2 52965.0 53277.5 53352.5 53425.7 1183.4 1279.9 1322.1 1381.6 1439.6 27738.2 28690.7 29066.9 29169.0 29324.0 42525.1 46630.5 47721.3 47761.3 47924.8 268011.0 304387.0 310809.0 311949.0 312154.0 40931.8 41424.6 42311.6 42427.6 42481.4 44532.1 44793.6 44861.6 45113.1 45758.5 38257.0 38376.0 38852.0 38906.2 39387.8 35897.3 35955.0 36691.6 36943.1 37209.8 35739.0 35800.0 35811.1 35872.1 36096.6 32361.2 33091.0 34011.8 35586.3 35587.0 22728.3 22988.5 22988.7 23224.9 23260.7 14:22:16 INFO - PROCESS | 32022 | 14:22:16 INFO - PROCESS | 32022 | [#2] jquery.html Cycles:180 Average:24666.18 Median:4538.24 stddev:75057.40 (1653.9%) stddev-sans-first:75245.77 14:22:16 INFO - PROCESS | 32022 | Values: 364.6 366.7 366.9 368.3 369.9 13636.9 13719.7 15579.5 16888.2 17857.7 10890.6 11356.7 16222.8 16737.2 16757.8 4918.8 5091.6 5092.5 5094.9 5095.7 3829.6 3970.2 5001.8 5070.6 5300.8 5445.1 5474.4 5495.2 5497.4 5498.3 5644.3 6088.9 6103.3 6107.7 6119.1 5192.6 5364.9 5412.5 5414.4 5418.6 19200.0 19540.4 19897.5 19905.3 20265.4 2110.2 2127.9 2133.6 2181.6 2188.8 9130.5 9511.3 9583.7 11514.0 12385.8 1772.9 1858.4 1866.2 1867.6 1873.3 55262.0 55779.4 57223.0 57294.0 57404.1 9969.8 10273.7 10282.4 10294.4 10302.4 13139.3 13559.9 13602.5 13606.3 13625.5 7147.5 7153.7 7200.5 7257.1 7342.4 6823.8 6826.3 6853.3 6906.9 6910.0 4408.5 4501.3 4503.3 4535.1 4541.4 1697.6 1711.9 1757.5 1773.6 1797.7 863.8 877.7 884.4 900.5 976.1 13190.0 15362.9 15477.6 16209.5 16368.4 828.6 882.6 913.6 931.9 935.0 8475.7 8768.0 8880.1 8980.1 9001.2 414135.8 456453.0 462199.0 477756.0 481573.0 65614.0 66219.7 67142.7 70813.0 71268.0 1109.5 1157.6 1158.7 1164.7 1165.9 13551.2 14139.6 14602.7 14925.5 15316.5 30040.8 30143.2 30203.0 30941.0 31220.8 36716.3 38060.2 38140.6 39405.6 40335.4 4037.5 5047.0 7159.0 7171.8 7401.1 8725.0 10521.3 10634.9 10864.5 11234.0 2732.2 2760.5 6330.7 9105.4 9494.4 9069.8 9699.4 9700.7 9848.0 9855.5 9838.8 10001.6 10100.4 10106.2 10127.2 7238.9 7660.3 7703.2 7724.3 7744.5 6968.0 8702.7 9732.7 10012.8 10068.0 14:22:16 INFO - PROCESS | 32022 | 14:22:16 INFO - PROCESS | 32022 | [#3] mootools.html Cycles:180 Average:5137.30 Median:6123.27 stddev:2586.49 (42.2%) stddev-sans-first:2578.06 14:22:16 INFO - PROCESS | 32022 | Values: 1347.6 1453.7 1459.2 1591.9 1762.6 6455.2 7140.6 7247.0 7252.5 7256.3 7154.7 7266.0 7282.6 7307.8 7322.9 1949.0 1989.3 1991.2 2249.0 2277.6 1986.1 2262.4 2327.2 2328.0 2332.4 2131.0 2166.6 2200.9 2202.6 2202.8 2256.3 2263.7 2265.6 2267.3 2268.6 2224.1 2275.6 2275.7 2276.7 2284.4 7061.8 7116.5 7120.6 7131.7 7131.8 4450.6 4525.8 4527.8 4529.7 4556.8 3001.4 3125.2 3142.1 3149.7 3161.9 1024.2 1053.1 1053.7 1054.7 1106.6 9683.9 9831.9 9835.4 9838.9 9845.7 4074.5 4106.3 4166.4 4167.4 4173.0 8541.3 8595.4 8599.7 8617.1 8626.9 4535.3 4542.0 4574.2 4576.7 4579.4 4172.5 4207.0 4215.1 4215.9 4219.2 3360.6 3550.6 3569.9 3581.1 3598.6 1123.1 1199.9 1204.3 1221.1 1224.8 923.1 937.0 939.3 1116.7 1203.0 6606.3 6660.8 6671.0 6681.7 6693.8 1093.1 1093.3 1095.9 1104.2 1135.6 5257.1 5300.8 5334.4 5418.5 5421.4 8491.0 8601.5 8790.5 8864.9 8869.1 8641.7 8662.8 8746.2 8749.0 8755.2 6813.9 6916.2 6944.8 6976.8 6983.8 6670.8 6676.9 6687.0 6724.6 6745.3 7586.9 7816.7 8081.3 8119.6 8122.4 8026.2 8187.9 8202.1 8348.7 8354.0 6308.7 6645.0 6696.7 6711.4 6730.2 6356.1 6506.0 6636.9 6739.9 6755.2 6414.1 6466.1 6476.7 6534.5 6592.8 6359.3 6375.6 6399.9 6527.5 6557.3 6514.5 6547.7 6602.6 6609.5 6611.9 5958.4 5965.6 6004.4 6042.7 6047.3 5986.9 6089.5 6095.6 6119.3 6127.3 14:22:16 INFO - PROCESS | 32022 | 14:22:16 INFO - PROCESS | 32022 | [#4] prototype.html Cycles:180 Average:5160.65 Median:5805.65 stddev:1515.99 (26.1%) stddev-sans-first:1476.31 14:22:16 INFO - PROCESS | 32022 | Values: 333.8 336.6 346.7 351.3 351.3 5713.3 5755.9 5792.5 5802.0 5862.5 5727.9 5732.1 5741.1 5742.3 5743.5 4532.0 4532.7 4533.1 4537.1 4543.4 4446.1 4515.5 4527.3 4534.0 4541.6 4489.0 4493.8 4495.1 4501.2 4506.0 4271.3 4384.2 4486.3 4489.5 4503.4 3903.2 3968.5 3977.7 3981.9 4002.6 5480.7 5497.3 5497.9 5500.7 5510.8 4906.9 4920.7 5113.3 5206.5 5210.6 6074.2 6076.6 6077.8 6086.1 6096.5 4426.9 4428.1 4433.1 4434.3 4436.6 6209.5 6378.7 6386.4 6387.1 6392.0 4545.6 4546.8 4547.3 4548.1 4553.2 4593.8 4603.5 4605.6 4606.0 4606.8 5219.7 5220.2 5225.1 5226.5 5232.1 5997.2 6103.3 6130.1 6138.9 6142.4 1599.5 1622.0 1622.6 1622.9 1623.5 1102.3 1104.6 1110.7 1112.8 1129.8 5808.7 5813.0 5816.7 5823.7 5829.1 6289.8 6295.6 6296.3 6298.4 6306.8 5800.1 5804.5 5806.8 5808.9 5813.2 3260.7 3385.5 3385.6 3390.5 3392.0 6526.2 6529.3 6541.1 6542.1 6543.0 6215.2 6425.4 6425.8 6426.7 6434.7 6177.3 6418.6 6527.0 6625.1 6636.5 6224.1 6329.2 6344.3 6353.6 6356.8 6089.5 6301.7 6303.4 6304.8 6305.6 6417.2 6516.8 6524.1 6541.9 6618.0 4413.7 4466.9 4489.5 4519.4 4525.2 6273.1 6274.4 6280.7 6282.5 6289.3 6012.1 6212.6 6218.2 6221.3 6228.6 6197.2 6201.1 6206.8 6208.7 6209.6 6076.7 6093.9 6100.3 6121.8 6144.8 6047.2 6227.4 6233.6 6239.4 6239.4 6089.8 6091.5 6094.3 6096.5 6096.7 14:22:16 INFO - PROCESS | 32022 | 14:22:16 INFO - PROCESS | 32022 | [#5] yui.html Cycles:180 Average:13385.44 Median:25421.10 stddev:15563.34 (61.2%) stddev-sans-first:15578.11 14:22:16 INFO - PROCESS | 32022 | Values: 757.9 784.5 812.9 817.2 847.7 11743.8 12021.3 12031.0 12039.5 12091.2 11651.9 11690.8 11707.2 11727.4 11742.6 646.1 656.5 656.7 657.1 772.8 771.0 777.6 777.8 778.2 781.6 815.0 816.9 823.3 833.9 834.5 822.6 832.7 832.7 833.6 834.6 505.7 511.7 605.5 616.8 617.4 12037.7 12038.5 12045.6 12073.5 12107.9 12067.3 12628.2 12881.5 12943.4 13015.0 9588.3 9605.6 9621.6 9687.1 9769.6 3489.7 3544.7 3571.8 3587.7 3637.4 47985.3 48332.8 50858.5 50989.5 51313.0 9528.4 9559.3 9658.5 9845.7 9921.0 16043.7 16126.0 16163.8 16201.3 16408.4 7369.7 7450.2 7538.4 7551.0 7566.8 4097.8 4165.9 4225.1 4226.7 4239.6 2996.3 3050.0 3058.7 3062.0 3066.3 561.6 573.3 578.4 587.2 593.3 493.7 569.8 602.9 647.7 666.2 8187.2 8456.5 8459.4 8476.5 8704.7 567.9 585.8 610.2 637.2 655.6 3626.9 3888.3 3963.3 4009.1 4058.4 50837.0 51223.0 51258.2 51409.0 51634.7 49120.5 49505.3 50336.5 52042.7 52148.5 44577.3 44749.3 45511.3 45562.3 46767.8 7958.4 8197.6 8413.2 8819.0 8888.7 33965.2 34245.8 34499.8 35857.3 35873.6 44440.6 44901.3 45127.0 45351.3 46030.3 10034.7 10245.5 10358.8 10513.9 10639.7 11998.8 12223.3 12338.2 12389.4 12391.9 10412.9 10739.5 10968.2 11026.4 11165.5 11188.3 11445.4 11569.3 11761.7 11777.6 11504.8 11697.7 11750.5 11775.2 11850.6 9152.2 9173.0 9239.1 9554.6 9820.3 8878.4 8884.4 8909.2 9136.5 9429.5 14:22:16 INFO - PROCESS | 32022 | -------- Summary: end -------- 14:22:16 INFO - PROCESS | 32022 | 14:22:17 INFO - TEST-INFO | 32022: exit 0 14:22:17 INFO - TEST-OK | dromaeo_css | took 1112376ms 14:22:17 INFO - TEST-START | kraken 14:22:17 INFO - operating with platform_type : linux_ 14:22:17 INFO - Initialising browser for kraken test... 14:22:17 INFO - TEST-INFO | started process 32227 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTfZCCW/profile http://localhost:55834/getInfo.html) 14:22:20 INFO - PROCESS | 32227 | __metrics Screen width/height:1600/1200 14:22:20 INFO - PROCESS | 32227 | colorDepth:24 14:22:20 INFO - PROCESS | 32227 | Browser inner width/height: 1024/697 14:22:20 INFO - PROCESS | 32227 | __metrics 14:22:20 INFO - PROCESS | 32227 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:22:20 INFO - PROCESS | 32227 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:22:21 INFO - TEST-INFO | 32227: exit 0 14:22:21 INFO - Browser initialized. 14:22:21 INFO - Running cycle 1/1 for kraken test... 14:22:21 INFO - TEST-INFO | started process 32308 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTfZCCW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:33 INFO - PROCESS | 32308 | RSS: Main: 150212608 14:22:33 INFO - PROCESS | 32308 | 14:22:36 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55834/tests/kraken/driver.html?testName=audio-beat-detection) 14:22:36 INFO - PROCESS | 32308 | RSS: Main: 186294272 14:22:36 INFO - PROCESS | 32308 | 14:22:39 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55834/tests/kraken/driver.html?testName=audio-dft) 14:22:39 INFO - PROCESS | 32308 | RSS: Main: 175779840 14:22:39 INFO - PROCESS | 32308 | 14:22:42 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55834/tests/kraken/driver.html?testName=audio-fft) 14:22:43 INFO - PROCESS | 32308 | RSS: Main: 161402880 14:22:43 INFO - PROCESS | 32308 | 14:22:45 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55834/tests/kraken/driver.html?testName=audio-oscillator) 14:22:45 INFO - PROCESS | 32308 | RSS: Main: 161542144 14:22:45 INFO - PROCESS | 32308 | 14:22:48 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55834/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:48 INFO - PROCESS | 32308 | RSS: Main: 166252544 14:22:48 INFO - PROCESS | 32308 | 14:22:51 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55834/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:52 INFO - PROCESS | 32308 | RSS: Main: 165781504 14:22:52 INFO - PROCESS | 32308 | 14:22:55 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55834/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:55 INFO - PROCESS | 32308 | RSS: Main: 164823040 14:22:55 INFO - PROCESS | 32308 | 14:22:58 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55834/tests/kraken/driver.html?testName=json-parse-financial) 14:22:59 INFO - PROCESS | 32308 | RSS: Main: 166608896 14:22:59 INFO - PROCESS | 32308 | 14:23:00 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55834/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:23:01 INFO - PROCESS | 32308 | RSS: Main: 178388992 14:23:01 INFO - PROCESS | 32308 | 14:23:03 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55834/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:23:03 INFO - PROCESS | 32308 | RSS: Main: 175513600 14:23:03 INFO - PROCESS | 32308 | 14:23:05 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55834/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:23:06 INFO - PROCESS | 32308 | RSS: Main: 187510784 14:23:06 INFO - PROCESS | 32308 | 14:23:08 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55834/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:23:09 INFO - PROCESS | 32308 | RSS: Main: 193867776 14:23:09 INFO - PROCESS | 32308 | 14:23:11 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55834/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:23:12 INFO - PROCESS | 32308 | RSS: Main: 192643072 14:23:12 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | Cycle 1(1): loaded http://localhost:55834/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55834/tests/kraken/driver.html?testName=ai-astar) 14:23:14 INFO - PROCESS | 32308 | RSS: Main: 249032704 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | __start_tp_report 14:23:14 INFO - PROCESS | 32308 | _x_x_mozilla_page_load 14:23:14 INFO - PROCESS | 32308 | _x_x_mozilla_page_load_details 14:23:14 INFO - PROCESS | 32308 | |i|pagename|runs| 14:23:14 INFO - PROCESS | 32308 | |0;ai-astar;112;111;104;110;111;111;111;110;103;110 14:23:14 INFO - PROCESS | 32308 | |1;audio-beat-detection;151;125;153;167;134;153;146;123;164;135 14:23:14 INFO - PROCESS | 32308 | |2;audio-dft;161;160;161;164;163;161;161;162;161;162 14:23:14 INFO - PROCESS | 32308 | |3;audio-fft;72;72;112;93;70;73;72;112;88;75 14:23:14 INFO - PROCESS | 32308 | |4;audio-oscillator;96;96;139;95;95;96;143;95;96;141 14:23:14 INFO - PROCESS | 32308 | |5;imaging-gaussian-blur;109;110;109;109;109;108;109;109;110;110 14:23:14 INFO - PROCESS | 32308 | |6;imaging-darkroom;145;145;145;144;144;145;145;145;145;146 14:23:14 INFO - PROCESS | 32308 | |7;imaging-desaturate;96;96;96;96;96;95;96;96;95;96 14:23:14 INFO - PROCESS | 32308 | |8;json-parse-financial;57;56;56;56;55;57;57;56;58;53 14:23:14 INFO - PROCESS | 32308 | |9;json-stringify-tinderbox;67;68;67;67;68;68;68;72;68;68 14:23:14 INFO - PROCESS | 32308 | |10;stanford-crypto-aes;82;83;82;82;82;81;83;90;81;82 14:23:14 INFO - PROCESS | 32308 | |11;stanford-crypto-ccm;122;130;117;112;113;120;129;128;115;115 14:23:14 INFO - PROCESS | 32308 | |12;stanford-crypto-pbkdf2;144;132;141;142;141;135;141;140;154;140 14:23:14 INFO - PROCESS | 32308 | |13;stanford-crypto-sha256-iterative;66;67;68;67;67;66;66;67;67;66 14:23:14 INFO - PROCESS | 32308 | __end_tp_report 14:23:14 INFO - PROCESS | 32308 | __start_cc_report 14:23:14 INFO - PROCESS | 32308 | _x_x_mozilla_cycle_collect,934 14:23:14 INFO - PROCESS | 32308 | __end_cc_report 14:23:14 INFO - PROCESS | 32308 | __startTimestamp1453155794401__endTimestamp 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | ------- Summary: start ------- 14:23:14 INFO - PROCESS | 32308 | Number of tests: 14 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.13 (2.8%) stddev-sans-first:3.16 14:23:14 INFO - PROCESS | 32308 | Values: 112.0 111.0 104.0 110.0 111.0 111.0 111.0 110.0 103.0 110.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:152.00 stddev:15.33 (10.1%) stddev-sans-first:16.11 14:23:14 INFO - PROCESS | 32308 | Values: 151.0 125.0 153.0 167.0 134.0 153.0 146.0 123.0 164.0 135.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 14:23:14 INFO - PROCESS | 32308 | Values: 161.0 160.0 161.0 164.0 163.0 161.0 161.0 162.0 161.0 162.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#3] audio-fft Cycles:10 Average:83.90 Median:72.50 stddev:16.65 (23.0%) stddev-sans-first:17.09 14:23:14 INFO - PROCESS | 32308 | Values: 72.0 72.0 112.0 93.0 70.0 73.0 72.0 112.0 88.0 75.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:95.50 stddev:21.97 (23.0%) stddev-sans-first:22.78 14:23:14 INFO - PROCESS | 32308 | Values: 96.0 96.0 139.0 95.0 95.0 96.0 143.0 95.0 96.0 141.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 14:23:14 INFO - PROCESS | 32308 | Values: 109.0 110.0 109.0 109.0 109.0 108.0 109.0 109.0 110.0 110.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 14:23:14 INFO - PROCESS | 32308 | Values: 145.0 145.0 145.0 144.0 144.0 145.0 145.0 145.0 145.0 146.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:23:14 INFO - PROCESS | 32308 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:1.37 (2.4%) stddev-sans-first:1.41 14:23:14 INFO - PROCESS | 32308 | Values: 57.0 56.0 56.0 56.0 55.0 57.0 57.0 56.0 58.0 53.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:1.45 (2.1%) stddev-sans-first:1.48 14:23:14 INFO - PROCESS | 32308 | Values: 67.0 68.0 67.0 67.0 68.0 68.0 68.0 72.0 68.0 68.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.00 stddev:2.62 (3.2%) stddev-sans-first:2.76 14:23:14 INFO - PROCESS | 32308 | Values: 82.0 83.0 82.0 82.0 82.0 81.0 83.0 90.0 81.0 82.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:121.00 stddev:6.84 (5.7%) stddev-sans-first:7.22 14:23:14 INFO - PROCESS | 32308 | Values: 122.0 130.0 117.0 112.0 113.0 120.0 129.0 128.0 115.0 115.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.00 Median:141.00 stddev:5.75 (4.1%) stddev-sans-first:6.00 14:23:14 INFO - PROCESS | 32308 | Values: 144.0 132.0 141.0 142.0 141.0 135.0 141.0 140.0 154.0 140.0 14:23:14 INFO - PROCESS | 32308 | 14:23:14 INFO - PROCESS | 32308 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 14:23:14 INFO - PROCESS | 32308 | Values: 66.0 67.0 68.0 67.0 67.0 66.0 66.0 67.0 67.0 66.0 14:23:14 INFO - PROCESS | 32308 | -------- Summary: end -------- 14:23:14 INFO - PROCESS | 32308 | 14:23:15 INFO - TEST-INFO | 32308: exit 0 14:23:15 INFO - TEST-OK | kraken | took 58259ms 14:23:15 INFO - TEST-START | v8_7 14:23:15 INFO - operating with platform_type : linux_ 14:23:15 INFO - Initialising browser for v8_7 test... 14:23:15 INFO - TEST-INFO | started process 32556 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4O0QE_/profile http://localhost:55834/getInfo.html) 14:23:18 INFO - PROCESS | 32556 | __metrics Screen width/height:1600/1200 14:23:18 INFO - PROCESS | 32556 | colorDepth:24 14:23:18 INFO - PROCESS | 32556 | Browser inner width/height: 1024/697 14:23:18 INFO - PROCESS | 32556 | __metrics 14:23:19 INFO - PROCESS | 32556 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:23:19 INFO - PROCESS | 32556 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:23:20 INFO - TEST-INFO | 32556: exit 0 14:23:20 INFO - Browser initialized. 14:23:20 INFO - Running cycle 1/1 for v8_7 test... 14:23:20 INFO - TEST-INFO | started process 32637 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4O0QE_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:32 INFO - PROCESS | 32637 | RSS: Main: 149827584 14:23:32 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:55834/tests/v8_7/run.html (next: http://localhost:55834/tests/v8_7/run.html) 14:23:54 INFO - PROCESS | 32637 | RSS: Main: 598241280 14:23:54 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | __start_tp_report 14:23:54 INFO - PROCESS | 32637 | _x_x_mozilla_page_load 14:23:54 INFO - PROCESS | 32637 | _x_x_mozilla_page_load_details 14:23:54 INFO - PROCESS | 32637 | |i|pagename|runs| 14:23:54 INFO - PROCESS | 32637 | |0;Richards;167.53224995811695 14:23:54 INFO - PROCESS | 32637 | |1;DeltaBlue;188.96447467876038 14:23:54 INFO - PROCESS | 32637 | |2;Encrypt;279.4076557697681 14:23:54 INFO - PROCESS | 32637 | |3;Decrypt;5148.717948717948 14:23:54 INFO - PROCESS | 32637 | |4;RayTrace;1947.4708171206225 14:23:54 INFO - PROCESS | 32637 | |5;Earley;793.1854199683042 14:23:54 INFO - PROCESS | 32637 | |6;Boyer;12231.707317073171 14:23:54 INFO - PROCESS | 32637 | |7;RegExp;43702.12765957447 14:23:54 INFO - PROCESS | 32637 | |8;Splay;600.6006006006006 14:23:54 INFO - PROCESS | 32637 | |9;NavierStokes;4868.9320388349515 14:23:54 INFO - PROCESS | 32637 | __end_tp_report 14:23:54 INFO - PROCESS | 32637 | __startTimestamp1453155834730__endTimestamp 14:23:54 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | ------- Summary: start ------- 14:23:54 INFO - PROCESS | 32637 | Number of tests: 10 14:23:54 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | [#0] Richards Cycles:1 Average:167.53 Median:167.53 stddev:0.00 (0.0%) 14:23:54 INFO - PROCESS | 32637 | Values: 167.5 14:23:54 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | [#1] DeltaBlue Cycles:1 Average:188.96 Median:188.96 stddev:0.00 (0.0%) 14:23:54 INFO - PROCESS | 32637 | Values: 189.0 14:23:54 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 14:23:54 INFO - PROCESS | 32637 | Values: 279.4 14:23:54 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 14:23:54 INFO - PROCESS | 32637 | Values: 5148.7 14:23:54 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | [#4] RayTrace Cycles:1 Average:1947.47 Median:1947.47 stddev:0.00 (0.0%) 14:23:54 INFO - PROCESS | 32637 | Values: 1947.5 14:23:54 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | [#5] Earley Cycles:1 Average:793.19 Median:793.19 stddev:0.00 (0.0%) 14:23:54 INFO - PROCESS | 32637 | Values: 793.2 14:23:54 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 14:23:54 INFO - PROCESS | 32637 | Values: 12231.7 14:23:54 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | [#7] RegExp Cycles:1 Average:43702.13 Median:43702.13 stddev:0.00 (0.0%) 14:23:54 INFO - PROCESS | 32637 | Values: 43702.1 14:23:54 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | [#8] Splay Cycles:1 Average:600.60 Median:600.60 stddev:0.00 (0.0%) 14:23:54 INFO - PROCESS | 32637 | Values: 600.6 14:23:54 INFO - PROCESS | 32637 | 14:23:54 INFO - PROCESS | 32637 | [#9] NavierStokes Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 14:23:54 INFO - PROCESS | 32637 | Values: 4868.9 14:23:54 INFO - PROCESS | 32637 | -------- Summary: end -------- 14:23:54 INFO - PROCESS | 32637 | 14:23:55 INFO - TEST-INFO | 32637: exit 0 14:23:55 INFO - TEST-OK | v8_7 | took 40172ms 14:23:55 INFO - SUITE-END | took 1210s 14:23:55 INFO - Completed test suite (00:20:11) 14:23:55 INFO - Working with test: dromaeo_css 14:23:55 INFO - Generating results file: dromaeo_css 14:23:55 INFO - Working with test: kraken 14:23:55 INFO - Generating results file: kraken 14:23:55 INFO - javascript benchmark 14:23:55 INFO - Working with test: v8_7 14:23:55 INFO - Generating results file: v8_7 14:23:55 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:55 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:23:55 INFO - process_Request line: dromaeo_css 6668.83 graph.html#tests=[[72,64,35]] 14:23:55 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:55 INFO - process_Request line: kraken 1493.80 graph.html#tests=[[232,64,35]] 14:23:55 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:55 INFO - process_Request line: v8_7 18878.52 graph.html#tests=[[230,64,35]] 14:23:55 INFO - RETURN: dromaeo_css: 6668.83 14:23:55 INFO - RETURN: kraken: 1493.80 14:23:55 INFO - RETURN: v8_7: 18878.52 14:23:55 INFO - javascript benchmark 14:23:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3083.4449799036174, 3115.890943816964, 3152.7320177784886, 3162.067190178897, 3186.3786561620477, 4970.726610036447, 5044.798208071677, 5050.494950504953, 5072.087024335628, 5103.540681338679, 5065.822696205633, 5098.617603679721, 5104.64267501275, 5118.9488105118935, 5121.052605268028, 4609.953900460994, 4619.399478067863, 4648.209804333254, 4698.248280275139, 4698.530146985308, 4673.929891051637, 4692.202325604639, 4730.597899178574, 4732.952670473285, 4740.881477963044, 4551.112533056039, 4613.6539759518, 4642.373279607244, 4712.976435117836, 4727.550882666142, 4658.55743704351, 4680.906381872377, 4687.320338550925, 4692.835750748707, 4704.200285951397, 4646.4424269087585, 4650.813967441299, 4660.766961651904, 4663.417072865892, 4705.694129881581, 4721.716696998157, 4804.6876952997945, 4864.1974074277705, 4924.581410580105, 4925.630577706651, 5375.22059301403, 5379.435159308256, 5394.0, 5401.972990135024, 5412.9458705412835, 5302.257683924254, 5414.214938833887, 5416.926647864811, 5430.5927055471, 5477.835664930059, 5079.517445842639, 5113.156329205676, 5129.974350128263, 5161.354830646169, 5169.6639718418555, 5597.720113994284, 5601.691906945076, 5605.747741351649, 5607.691576963224, 5617.438256174431, 5214.869628259248, 5371.6239863209985, 5388.838334849961, 5389.649672771257, 5390.568754499631, 5367.168088946141, 5386.946130538723, 5431.891362172734, 5440.129579267377, 5485.0, 5378.435264297193, 5397.163439666858, 5398.2982212312145, 5407.783688652488, 5410.026195284808, 5236.397814251333, 5374.462553744673, 5410.648307859977, 5417.3770016447825, 5456.727163641802, 4193.811278492414, 4224.619784219373, 4251.447311849502, 4252.723572967747, 4265.168292182994, 3776.4146557283666, 3791.5071040764524, 3806.467094606757, 3821.9617803821607, 3826.846926122924, 4952.70283782967, 5022.497750225021, 5037.395512538519, 5044.086106918689, 5078.415982162099, 5402.486763757437, 5408.215808707715, 5446.509814116748, 5500.614956953055, 5511.3937466878615, 5030.0694371541385, 5039.26930595069, 5041.823536176216, 5046.0, 5086.669366491166, 4597.126545956257, 4670.206064968964, 4677.111348843709, 4678.204705200124, 4715.976420117946, 5535.391106978229, 5584.720763961785, 5643.830685079454, 5654.40628733977, 5692.943070569241, 5400.405955344988, 5420.4037555868035, 5426.0, 5430.076886929311, 5433.266509021231, 5503.7798488061635, 5570.387257401763, 5592.273004509388, 5624.437556244343, 5670.404607516151, 5272.604554658493, 5308.177232528964, 5314.4951229633125, 5318.122509785842, 5337.412884582615, 5386.245925570502, 5451.727413629382, 5453.072977593739, 5454.481824226851, 5501.257330260363, 5251.05481013406, 5275.472452754847, 5279.973600131974, 5330.626856120034, 5385.1922211667, 5245.9475405246985, 5252.474752524717, 5253.080710875505, 5260.44765299638, 5296.311479507794, 5166.8966620668125, 5181.041507321158, 5188.273641690242, 5196.220566914993, 5238.345206849144, 5220.3213582235585, 5257.342832145981, 5269.341332333458, 5285.180796976475, 5304.124819404909, 5208.869778255574, 5228.58171346299, 5232.581393488435, 5233.345831771028, 5237.371515418175], "unit": "score", "name": "dojo.html", "value": 5012.946863830103}, {"lowerIsBetter": false, "replicates": [535.4484880573011, 563.9774409023639, 581.5522048023022, 592.4431034827262, 597.6832278892188, 28122.85938570307, 28627.713722862765, 28640.0, 36337.81831090847, 36578.902632921054, 39156.60843391565, 39538.406923896095, 39557.0, 39604.20791584167, 39636.40545391821, 8415.579221038939, 8614.224719775219, 8618.095100014501, 8619.913800862005, 8625.353098517606, 8362.58187090643, 8452.61963211657, 8492.193241642035, 8499.150084991514, 8505.362097842655, 8662.220400163984, 8727.38908276421, 8730.912690873074, 8742.213200811926, 8745.08176641453, 8591.871121933176, 8636.352273579507, 8671.349648776304, 8682.956585217033, 8683.826323473559, 8392.118827523083, 8448.662053517914, 8455.239028487465, 8498.872516912252, 8499.150084991514, 39036.60963390358, 39458.60541394578, 39480.0, 39506.20987580232, 39534.209315813525, 3162.478191098466, 3279.3277378137664, 3279.9016029519153, 3470.1845066409373, 3843.3658446356317, 31074.378512429852, 31633.52549711756, 31645.683543164734, 31712.841435792674, 32474.67525324764, 3782.205736795276, 3784.0, 3841.3661745811905, 3878.0, 4024.5170579530645, 216539.0, 220627.0, 220649.0, 221489.0, 221777.0, 54131.45868541343, 54542.0, 58273.0, 61213.0, 62088.68955655193, 60874.08688869671, 61796.69101654553, 61855.381446185864, 61889.690551546955, 62239.37760622336, 14358.0, 14453.349599268058, 14544.345504452325, 14549.78175327371, 14566.34451449666, 9832.852507212398, 10057.899421005697, 10248.38509689421, 10439.164866810637, 10446.216533759847, 20344.59310813805, 20597.176112955614, 20641.48396290105, 20681.0, 20695.482612934797, 7833.921660783433, 8553.0, 8577.185167409087, 8619.448499270191, 8662.6101825418, 932.6735642525198, 934.5280633280286, 987.3878195518681, 987.5654711926729, 1028.4189432970347, 25175.0, 27214.45571088567, 27762.0, 27881.72118278832, 27913.44173116526, 1019.6278358399279, 1040.5317607076845, 1043.3896170740202, 1108.6009036746764, 1182.438341787661, 14764.335604897806, 14875.33061012257, 14934.402623894923, 14960.0, 14992.850071499364, 365940.0, 377706.0, 381303.0, 381924.0, 382548.0, 52875.20687189695, 52965.0, 53277.46722532725, 53352.466475335525, 53425.73287133617, 1183.426053318972, 1279.8720127987126, 1322.0877594459791, 1381.647679841654, 1439.6113049476583, 27738.167854964384, 28690.713092868806, 29066.854665727384, 29169.0, 29324.0, 42525.149497010505, 46630.53369466262, 47721.28418073662, 47761.28358074562, 47924.7603761979, 268011.0, 304387.0, 310809.0, 311949.0, 312154.0, 40931.795341023106, 41424.58575414207, 42311.576884230766, 42427.575724243594, 42481.36277955771, 44532.10935781201, 44793.552064478936, 44861.551384485734, 45113.0977380444, 45758.54241457543, 38257.0, 38376.0, 38852.0, 38906.221875561765, 39387.80306098451, 35897.28205435929, 35955.0, 36691.63308366989, 36943.07642308964, 37209.813950930074, 35739.0, 35800.0, 35811.10472238215, 35872.10319742027, 36096.63903361038, 32361.19097022499, 33091.0, 34011.82994085014, 35586.28827423489, 35587.0, 22728.318150455514, 22988.540229194987, 22988.655170172126, 23224.88387558119, 23260.65109023332], "unit": "score", "name": "ext.html", "value": 18459.988429001703}, {"lowerIsBetter": false, "replicates": [364.64811456944045, 366.74511214705774, 366.9467927150562, 368.3406702003414, 369.9445083237514, 13636.863631363683, 13719.65700857479, 15579.45471908482, 16888.155592220402, 17857.732134018, 10890.564377424893, 11356.659300221007, 16222.83777162228, 16737.246823892925, 16757.83242167578, 4918.778654960526, 5091.592672586203, 5092.490750924915, 5094.872628184288, 5095.719735414551, 3829.636184562462, 3970.2258059678375, 5001.774920128585, 5070.645054846163, 5300.761465734032, 5445.074337362658, 5474.370447398541, 5495.203195536645, 5497.367802702701, 5498.257735205736, 5644.266245388094, 6088.908666370008, 6103.26760788706, 6107.725152368154, 6119.143319935212, 5192.6105542084115, 5364.91952620711, 5412.4587541245955, 5414.431484694129, 5418.566514678816, 19200.0, 19540.413787586396, 19897.502562436053, 19905.303314383927, 20265.392038238875, 2110.2403134871433, 2127.8829664368454, 2133.6479480885637, 2181.640029395148, 2188.7592364839857, 9130.497822619753, 9511.286653500945, 9583.712488625353, 11514.0, 12385.823346782041, 1772.858171346302, 1858.358866191162, 1866.1602278974515, 1867.6451474219855, 1873.297513432463, 55262.0, 55779.442205577834, 57223.0, 57294.0, 57404.13893791597, 9969.80060398788, 10273.691789246184, 10282.383057016603, 10294.382337059651, 10302.433366164933, 13139.277339746215, 13559.932200339132, 13602.523911663044, 13606.251656159006, 13625.454981800814, 7147.53541019832, 7153.6780844862105, 7200.459965502609, 7257.092863392076, 7342.4493163012985, 6823.761168359084, 6826.317368263233, 6853.314668533107, 6906.930930690729, 6910.0, 4408.470983482002, 4501.257292546758, 4503.301988191835, 4535.115652447741, 4541.364209010675, 1697.6434948660672, 1711.8801683882257, 1757.5254681235995, 1773.6254402837903, 1797.7213531902576, 863.8185980943947, 877.6840337478502, 884.3897710579679, 900.4912224593215, 976.1458723616835, 13190.0, 15362.923185384001, 15477.613059673598, 16209.513714588582, 16368.427105051504, 828.5939889454124, 882.6116508736136, 913.584319134792, 931.9440833550009, 934.9532523373804, 8475.74572762818, 8768.027193881453, 8880.067592902782, 8980.101989801098, 9001.234895033864, 414135.7571764438, 456453.0, 462199.0, 477756.0, 481573.0, 65614.0, 66219.66890165614, 67142.66428667922, 70813.0, 71268.0, 1109.5284504085732, 1157.6353448663644, 1158.652404278713, 1164.7088227943013, 1165.8600967883738, 13551.186928784304, 14139.575812725634, 14602.707945840812, 14925.477608283658, 15316.540503784905, 30040.84979575088, 30143.246418839706, 30203.0, 30941.0, 31220.843895780377, 36716.26567468582, 38060.2387952245, 38140.618593813706, 39405.605943940194, 40335.39496907607, 4037.4953130858644, 5046.9747651261505, 7158.964205178941, 7171.784846454615, 7401.0748656417945, 8725.0, 10521.316114452537, 10634.8936510637, 10864.45677716127, 11234.045106166068, 2732.221316924667, 2760.5169095408623, 6330.733853229281, 9105.408148470327, 9494.430334179971, 9069.776722469453, 9699.369540979813, 9700.660476883557, 9847.950760246153, 9855.45794981283, 9838.75403114928, 10001.599936002478, 10100.393976361442, 10106.19150467946, 10127.189824814144, 7238.855222895618, 7660.310572048319, 7703.152653208031, 7724.343430808444, 7744.4578879477895, 6968.045738355537, 8702.738917832476, 9732.70801875945, 10012.849807253042, 10068.0], "unit": "score", "name": "jquery.html", "value": 7829.419329061233}, {"lowerIsBetter": false, "replicates": [1347.5822495026548, 1453.6801903581209, 1459.2193176650492, 1591.9442819501312, 1762.5769815244346, 6455.160829092218, 7140.607266600335, 7246.96376518118, 7252.492325537214, 7256.2743725627415, 7154.678039488223, 7265.963670181642, 7282.563046217218, 7307.817304567375, 7322.9267707322915, 1948.9707654385195, 1989.333573252962, 1991.163711241275, 2248.999999999996, 2277.6241920083166, 1986.0566231040214, 2262.4457008033055, 2327.2320134355623, 2327.9883600581975, 2332.3935776698095, 2131.0, 2166.631672615659, 2200.9119635214574, 2202.603531364354, 2202.8237740980762, 2256.277991042867, 2263.660450932357, 2265.6261716816707, 2267.331137314496, 2268.6256767633404, 2224.065892325227, 2275.6472746724116, 2275.7496675365696, 2276.681264622954, 2284.3603790938564, 7061.788146355618, 7116.5018448708615, 7120.6439678015895, 7131.714731410737, 7131.750388736421, 4450.621697155713, 4525.773711314454, 4527.796249168795, 4529.660275479352, 4556.840510582114, 3001.384716133209, 3125.1874512626655, 3142.1359126240236, 3149.653538110806, 3161.8893338733264, 1024.1755386913533, 1053.0943388685723, 1053.7312985188728, 1054.72577129946, 1106.6403418888813, 9683.854742178873, 9831.901680983241, 9835.360701554377, 9838.90161098387, 9845.704628861145, 4074.4703188585295, 4106.281400754856, 4166.437530933345, 4167.416561681367, 4173.040200753843, 8541.273991710774, 8595.44129631572, 8599.742007739778, 8617.138286171332, 8626.870596941051, 4535.274356103007, 4542.046170304207, 4574.199515084847, 4576.748278844629, 4579.404677391918, 4172.457580514514, 4206.957930420718, 4215.072684009513, 4215.87352379423, 4219.177260434186, 3360.647132051148, 3550.6449355064806, 3569.8572057117426, 3581.086822860154, 3598.604153543108, 1123.1127409346689, 1199.9220050696852, 1204.3015051270243, 1221.1390969366576, 1224.7856625090574, 923.072312326108, 937.0254934867661, 939.3330735177964, 1116.7208197950513, 1202.9518819247307, 6606.339366063356, 6660.800175994728, 6671.032700258435, 6681.732730690718, 6693.765718199839, 1093.147345070846, 1093.2511229807608, 1095.9178061645248, 1104.2215238257008, 1135.5855112883737, 5257.053730328577, 5300.840974770763, 5334.413214546396, 5418.45815418455, 5421.403645598981, 8490.957545212234, 8601.526916019679, 8790.472571645721, 8864.911350886538, 8869.113088691209, 8641.740747777576, 8662.826743465095, 8746.212840844228, 8748.956255218684, 8755.168259015383, 6813.897791533131, 6916.20463646677, 6944.826379340557, 6976.790696279119, 6983.82540436483, 6670.833229169116, 6676.866462670817, 6687.0, 6724.596524208563, 6745.25802161752, 7586.886196707164, 7816.687332506864, 8081.272685458337, 8119.5534245617055, 8122.431429800094, 8026.1572534883, 8187.877181842397, 8202.05676347204, 8348.749537513884, 8353.95823020881, 6308.653024083719, 6645.0, 6696.698648560924, 6711.429528490133, 6730.158730158731, 6356.078368636614, 6505.967470162619, 6636.9004464932095, 6739.865202696017, 6755.189377274562, 6414.069959855888, 6466.06242094903, 6476.740930362733, 6534.509911756542, 6592.835179120369, 6359.332270111571, 6375.6174629522375, 6399.93600064012, 6527.543071985106, 6557.278699342973, 6514.54398192141, 6547.70535325902, 6602.636854973022, 6609.537332386687, 6611.933880661324, 5958.433948774859, 5965.612235204698, 6004.39956004396, 6042.667653279112, 6047.274327080779, 5986.850328741816, 6089.51283897296, 6095.603785753912, 6119.265688117454, 6127.264728232641], "unit": "score", "name": "mootools.html", "value": 4271.852311106805}, {"lowerIsBetter": false, "replicates": [333.7680312183033, 336.6397954189017, 346.70703255748884, 351.2781234562972, 351.3447420560655, 5713.285839270091, 5755.913661295084, 5792.507636850863, 5801.999999999989, 5862.530997520199, 5727.942720572793, 5732.111522713975, 5741.138829175626, 5742.339630942442, 5743.483086522212, 4531.954680453195, 4532.728036317815, 4533.116042371739, 4537.069900670354, 4543.3639290499195, 4446.1107778444275, 4515.503294637587, 4527.253003254459, 4533.977330113345, 4541.636669066466, 4489.034857505636, 4493.820247190109, 4495.056038231975, 4501.167284052461, 4506.031203291292, 4271.252530807096, 4384.167008268419, 4486.327050942352, 4489.528599497038, 4503.392042074311, 3903.160820423594, 3968.464257325253, 3977.7414468059483, 3981.880543583668, 4002.639762421367, 5480.698561579112, 5497.306319903259, 5497.862553436156, 5500.724963751836, 5510.8071217507195, 4906.852794416173, 4920.6801557898625, 5113.309703190059, 5206.453322401131, 5210.609204309692, 6074.240719910012, 6076.635401875901, 6077.848053798646, 6086.087086936951, 6096.4817990470865, 4426.933595996063, 4428.070105277896, 4433.13553856998, 4434.334849772527, 4436.55634436557, 6209.5032397408095, 6378.712957916905, 6386.3613638636225, 6387.073874288249, 6392.0, 4545.568171023748, 4546.840860569864, 4547.272436410159, 4548.067646132601, 4553.225951588238, 4593.770311484413, 4603.493615702337, 4605.631549476034, 4605.953940460552, 4606.792694328763, 5219.6607220531305, 5220.1647736362, 5225.059489291964, 5226.529612334832, 5232.136697444955, 5997.160397544348, 6103.298120716086, 6130.080487926846, 6138.907916381258, 6142.355052719489, 1599.5201439568084, 1622.0429946331722, 1622.6349071459063, 1622.9431969881234, 1623.5129461161605, 1102.3165637304921, 1104.635470294817, 1110.7167672243688, 1112.7718817642365, 1129.8022846001916, 5808.651480911159, 5813.0, 5816.651000939957, 5823.679697616587, 5829.067349224189, 6289.77985770505, 6295.5907865988565, 6296.307406185316, 6298.401651843067, 6306.842328941813, 5800.1299805029585, 5804.477597016289, 5806.82579522615, 5808.941910580925, 5813.215215945793, 3260.7065364117343, 3385.5260263563123, 3385.644507326695, 3390.4744764561533, 3392.0, 6526.184226971629, 6529.347065293433, 6541.149650545493, 6542.051402546699, 6542.967285163544, 6215.192025036807, 6425.357464253537, 6425.775097871552, 6426.742930282736, 6434.7104380303, 6177.289611694623, 6418.646974416359, 6527.0, 6625.072489851328, 6636.469082473487, 6224.128621993015, 6329.208848893888, 6344.30212676596, 6353.618782873043, 6356.841078973062, 6089.451949324582, 6301.747930082745, 6303.401176888188, 6304.842378940563, 6305.558610897193, 6417.197850268716, 6516.837079073061, 6524.119243902012, 6541.901871471837, 6617.974213996838, 4413.691041627056, 4466.8609504576125, 4489.483709373464, 4519.389882365838, 4525.162844873709, 6273.121762953099, 6274.435300822948, 6280.685965701788, 6282.4974002080635, 6289.308176100717, 6012.128241405059, 6212.565120441525, 6218.19163508741, 6221.346758590283, 6228.56400051992, 6197.194364732556, 6201.069839524108, 6206.751729930752, 6208.72060757258, 6209.59637623553, 6076.726547305293, 6093.9085913712215, 6100.267967843887, 6121.755129794937, 6144.754209831557, 6047.183630210041, 6227.408396202353, 6233.625982441068, 6239.407256310643, 6239.407256310643, 6089.786857459968, 6091.451769340781, 6094.299155597163, 6096.542759293159, 6096.664683442454], "unit": "score", "name": "prototype.html", "value": 4677.421072658084}, {"lowerIsBetter": false, "replicates": [757.924207579242, 784.4587234807982, 812.9349652027838, 817.1501638296172, 847.6948298612502, 11743.823842642356, 12021.27872327661, 12030.977366923822, 12039.51841926324, 12091.214071085373, 11651.883481165185, 11690.824637630443, 11707.180497365187, 11727.354995475245, 11742.589009384674, 646.0567571345829, 656.4977791989132, 656.7143292667705, 657.0604036228216, 772.818387678895, 770.9653065612061, 777.5762209595783, 777.793884620576, 778.1945686214768, 781.6287263549797, 814.9633266503022, 816.885636010956, 823.283743143466, 833.9499630022187, 834.4909605140859, 822.576373167819, 832.6669332267111, 832.7293629570414, 833.5623797506297, 834.6077343648476, 505.7016360347413, 511.7211119939642, 605.4883623338272, 616.8427051101985, 617.4257940115691, 12037.699057523545, 12038.4582693779, 12045.63863084109, 12073.517059317617, 12107.878921210764, 12067.275963442222, 12628.242305461701, 12881.484740610364, 12943.352832358438, 13015.023873209548, 9588.328816982814, 9605.615775368977, 9621.567029483691, 9687.128158465772, 9769.609215631366, 3489.7382696297627, 3544.7164226861787, 3571.8035508047046, 3587.7488575799703, 3637.399829028207, 47985.28022079637, 48332.75833620809, 50858.491415085744, 50989.49010509885, 51312.99999999963, 9528.380655257386, 9559.330846840654, 9658.468784216935, 9845.704628861145, 9920.950395247977, 16043.679126417406, 16126.0, 16163.838361616468, 16201.270942807601, 16408.425705100264, 7369.668364923591, 7450.18048014718, 7538.434617403607, 7551.0, 7566.827141793031, 4097.815598298024, 4165.854195103157, 4225.070484493406, 4226.725262857904, 4239.554846741109, 2996.340805022935, 3050.0, 3058.740007099377, 3061.969380306168, 3066.264096616796, 561.612487383704, 573.3091624592356, 578.3840210176149, 587.2336600735995, 593.2999061107848, 493.7457209537091, 569.7977218087602, 602.8583282928508, 647.6567419267795, 666.1827727123513, 8187.222213889671, 8456.534890580953, 8459.407841451039, 8476.53379064145, 8704.738857834274, 567.8921005009036, 585.7949717598806, 610.2493932463095, 637.1939496536885, 655.5804285257439, 3626.927461450809, 3888.319544079775, 3963.3460479020637, 4009.077912080238, 4058.411530328145, 50837.0, 51223.0, 51258.23112653313, 51409.0, 51634.74182629063, 49120.50879491231, 49505.31678223394, 50336.49663503392, 52042.73978630159, 52148.47851521512, 44577.331340029275, 44749.32876006862, 45511.317330240076, 45562.316565251545, 46767.76616116898, 7958.442908996315, 8197.631106600098, 8413.200745929127, 8819.0, 8888.688895888612, 33965.15087122842, 34245.82877085599, 34499.82750086234, 35857.28285434329, 35873.64126358703, 44440.55559444364, 44901.32648010217, 45127.0, 45351.31973020342, 46030.309545357515, 10034.69895903124, 10245.538950747085, 10358.796585363561, 10513.897220556073, 10639.680809575726, 11998.820017699567, 12223.327716975651, 12338.198017128858, 12389.380530973596, 12391.876081239432, 10412.947935260578, 10739.463026848782, 10968.23222374426, 11026.393548354918, 11165.49755260999, 11188.272762270426, 11445.370504622326, 11569.305841649528, 11761.705957350792, 11777.646670599896, 11504.769904602028, 11697.707557311136, 11750.529978801094, 11775.175737698279, 11850.644480665595, 9152.222061124612, 9173.02110493427, 9239.0791701211, 9554.62201604707, 9820.263480238867, 8878.378513503993, 8884.378093533649, 8909.198172164537, 9136.451812891248, 9429.481378524248], "unit": "score", "name": "yui.html", "value": 6075.474827201098}], "name": "dromaeo_css", "value": 6668.830000668187}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 104.0, 110.0, 111.0, 111.0, 111.0, 110.0, 103.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [151.0, 125.0, 153.0, 167.0, 134.0, 153.0, 146.0, 123.0, 164.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 164.0, 163.0, 161.0, 161.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 112.0, 93.0, 70.0, 73.0, 72.0, 112.0, 88.0, 75.0], "unit": "score", "name": "audio-fft", "value": 83.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 95.0, 95.0, 96.0, 143.0, 95.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 144.0, 144.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 144.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 56.0, 55.0, 57.0, 57.0, 56.0, 58.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 72.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 82.0, 82.0, 82.0, 81.0, 83.0, 90.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [122.0, 130.0, 117.0, 112.0, 113.0, 120.0, 129.0, 128.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.1}, {"lowerIsBetter": true, "replicates": [144.0, 132.0, 141.0, 142.0, 141.0, 135.0, 141.0, 140.0, 154.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1493.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.53224995811695], "unit": "score", "name": "Richards", "value": 210.71763800000005}, {"lowerIsBetter": false, "replicates": [188.96447467876038], "unit": "score", "name": "DeltaBlue", "value": 349.896456}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1947.4708171206225], "unit": "score", "name": "RayTrace", "value": 379.9743716283718}, {"lowerIsBetter": false, "replicates": [793.1854199683042], "unit": "score", "name": "Earley", "value": 840.23606993007}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [43702.12765957447], "unit": "score", "name": "RegExp", "value": 20.845323758519957}, {"lowerIsBetter": false, "replicates": [600.6006006006006], "unit": "score", "name": "Splay", "value": 135.68251500000005}, {"lowerIsBetter": false, "replicates": [4868.9320388349515], "unit": "score", "name": "NavierStokes", "value": 304.7896311066801}], "name": "v8_7", "value": 18878.522109139765}]} 14:23:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18878.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1493.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6668.83"}}} 14:23:55 INFO - Return code: 0 14:23:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:23:56 INFO - # TBPL SUCCESS # 14:23:56 INFO - Running post-action listener: _resource_record_post_action 14:23:56 INFO - Running post-run listener: _resource_record_post_run 14:23:57 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 541487104; Read time: 196; Write time: 436516 14:23:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 237305856; Read time: 60; Write time: 208804 14:23:57 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 304181248; Read time: 136; Write time: 227712 14:23:57 INFO - Running post-run listener: _upload_blobber_files 14:23:57 INFO - Blob upload gear active. 14:23:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:23:57 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:23:57 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'] 14:23:57 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 14:23:57 INFO - (blobuploader) - INFO - Open directory for files ... 14:23:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:23:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:23:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:58 INFO - (blobuploader) - INFO - Done attempting. 14:23:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:23:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:23:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:59 INFO - (blobuploader) - INFO - Done attempting. 14:23:59 INFO - (blobuploader) - INFO - Iteration through files over. 14:23:59 INFO - Return code: 0 14:23:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:23:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:23:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31c1119537282c86a0aa17fda37f0f7a15900846d7228432af25775360534a4a11859cd94e5220c6db459981a55631fad616c4697ae64a6e162361c3ecde05a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a77e202f3d698a8050eebddd7e5d7fd5894b1658f0243ee8c70540cc4d0bf99093d0f9f3ba3c2e36387551e8e14b8e67841502255cfa4684ba6c36e8772911a"} 14:23:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:23:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:23:59 INFO - Contents: 14:23:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31c1119537282c86a0aa17fda37f0f7a15900846d7228432af25775360534a4a11859cd94e5220c6db459981a55631fad616c4697ae64a6e162361c3ecde05a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a77e202f3d698a8050eebddd7e5d7fd5894b1658f0243ee8c70540cc4d0bf99093d0f9f3ba3c2e36387551e8e14b8e67841502255cfa4684ba6c36e8772911a"} 14:23:59 INFO - Running post-run listener: copy_logs_to_upload_dir 14:23:59 INFO - Copying logs to upload dir... 14:23:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:23:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.036371 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-18 14:23:58.600474) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 14:23:58.607797) ========= 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=41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31c1119537282c86a0aa17fda37f0f7a15900846d7228432af25775360534a4a11859cd94e5220c6db459981a55631fad616c4697ae64a6e162361c3ecde05a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a77e202f3d698a8050eebddd7e5d7fd5894b1658f0243ee8c70540cc4d0bf99093d0f9f3ba3c2e36387551e8e14b8e67841502255cfa4684ba6c36e8772911a"} build_url:https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/OLPHoaPdQMqdIPeFOXRCrA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31c1119537282c86a0aa17fda37f0f7a15900846d7228432af25775360534a4a11859cd94e5220c6db459981a55631fad616c4697ae64a6e162361c3ecde05a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a77e202f3d698a8050eebddd7e5d7fd5894b1658f0243ee8c70540cc4d0bf99093d0f9f3ba3c2e36387551e8e14b8e67841502255cfa4684ba6c36e8772911a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 14:23:58.635447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:23:58.635813) ========= 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=41bf3e9aed84707956354da8000001c5-1453146035.742600-569341499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:23:58.688587) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 14:23:58.689000) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 14:23:58.689379) ========= ========= Total master_lag: 0.45 =========