builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1453294866.71 results: success (0) buildid: 20160120005957 builduid: 9afdfb02d39f4e6fa8f3ed023931205b revision: c6c9487c4236 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.707230) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.707929) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.708304) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006030 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.731518) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.731860) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.745628) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.746098) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.796607) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.797062) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.797513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.797884) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 05:01:06-- 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% 37.5M=0s 2016-01-20 05:01:06 (37.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092665 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.903527) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.903856) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020553 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.953974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:06.954343) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c6c9487c4236 --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 c6c9487c4236 --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=a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 05:01:07,112 Setting DEBUG logging. 2016-01-20 05:01:07,112 attempt 1/10 2016-01-20 05:01:07,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c6c9487c4236?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 05:01:07,376 unpacking tar archive at: fx-team-c6c9487c4236/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:07.497017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:07.497344) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004736 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:07.548025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:07.548335) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:07.559151) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:07.559527) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 05:01:07.560006) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-20 05:01:07.560313) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:01:07 INFO - MultiFileLogger online at 20160120 05:01:07 in /builds/slave/test-pgo 05:01:07 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 05:01:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:01:07 INFO - {'append_to_log': False, 05:01:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:01:07 INFO - 'blob_upload_branch': 'Fx-Team', 05:01:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:01:07 INFO - 'branch': 'Fx-Team', 05:01:07 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:07 INFO - 'config_files': ('talos/linux_config.py',), 05:01:07 INFO - 'default_actions': ('clobber', 05:01:07 INFO - 'read-buildbot-config', 05:01:07 INFO - 'download-and-extract', 05:01:07 INFO - 'populate-webroot', 05:01:07 INFO - 'create-virtualenv', 05:01:07 INFO - 'install', 05:01:07 INFO - 'run-tests'), 05:01:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:07 INFO - 'download_minidump_stackwalk': True, 05:01:07 INFO - 'download_symbols': 'ondemand', 05:01:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:07 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:07 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:07 INFO - 'installer_path': 'installer.exe', 05:01:07 INFO - 'log_level': 'info', 05:01:07 INFO - 'log_name': 'talos', 05:01:07 INFO - 'log_to_console': True, 05:01:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:01:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:01:07 INFO - 'opt_config_files': (), 05:01:07 INFO - 'pip_index': False, 05:01:07 INFO - 'sps_profile': False, 05:01:07 INFO - 'sps_profile_interval': 0, 05:01:07 INFO - 'suite': 'dromaeojs', 05:01:07 INFO - 'system_bits': '32', 05:01:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:07 INFO - 'title': 'talos-linux64-ix-062', 05:01:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:07 INFO - 'use_talos_json': True, 05:01:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:01:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:07 INFO - 'work_dir': 'build'} 05:01:07 INFO - ##### 05:01:07 INFO - ##### Running clobber step. 05:01:07 INFO - ##### 05:01:07 INFO - Running pre-action listener: _resource_record_pre_action 05:01:07 INFO - Running main action method: clobber 05:01:07 INFO - rmtree: /builds/slave/test-pgo/build 05:01:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:01:08 INFO - Running post-action listener: _resource_record_post_action 05:01:08 INFO - ##### 05:01:08 INFO - ##### Running read-buildbot-config step. 05:01:08 INFO - ##### 05:01:08 INFO - Running pre-action listener: _resource_record_pre_action 05:01:08 INFO - Running main action method: read_buildbot_config 05:01:08 INFO - Using buildbot properties: 05:01:08 INFO - { 05:01:08 INFO - "project": "", 05:01:08 INFO - "product": "firefox", 05:01:08 INFO - "script_repo_revision": "production", 05:01:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:01:08 INFO - "repository": "", 05:01:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:01:08 INFO - "buildid": "20160120005957", 05:01:08 INFO - "pgo_build": "True", 05:01:08 INFO - "basedir": "/builds/slave/test-pgo", 05:01:08 INFO - "buildnumber": 433, 05:01:08 INFO - "slavename": "talos-linux64-ix-062", 05:01:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:01:08 INFO - "platform": "ubuntu64_hw", 05:01:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:01:08 INFO - "branch": "fx-team", 05:01:08 INFO - "repo_path": "integration/fx-team", 05:01:08 INFO - "revision": "c6c9487c4236", 05:01:08 INFO - "stage_platform": "linux64-pgo", 05:01:08 INFO - "builduid": "9afdfb02d39f4e6fa8f3ed023931205b", 05:01:08 INFO - "slavebuilddir": "test" 05:01:08 INFO - } 05:01:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:01:08 INFO - Running post-action listener: _resource_record_post_action 05:01:08 INFO - ##### 05:01:08 INFO - ##### Running download-and-extract step. 05:01:08 INFO - ##### 05:01:08 INFO - Running pre-action listener: _resource_record_pre_action 05:01:08 INFO - Running main action method: download_and_extract 05:01:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:08 INFO - https://queue.taskcluster.net/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:01:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/test_packages.json 05:01:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/test_packages.json 05:01:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:01:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:01:09 INFO - Downloaded 1448 bytes. 05:01:09 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:01:09 INFO - Using the following test package requirements: 05:01:09 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:09 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:01:09 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:01:09 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:09 INFO - u'jsshell-linux-x86_64.zip'], 05:01:09 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:01:09 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:09 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:01:09 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:01:09 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:01:09 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:09 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:01:09 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:01: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')]} 05:01:09 INFO - https://queue.taskcluster.net/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:01:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/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 05:01:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/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 05:01:10 INFO - Downloaded 22485738 bytes. 05:01:10 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'] 05:01:10 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 05:01:11 INFO - Return code: 0 05:01:11 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 05:01: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')]} 05:01:11 INFO - https://queue.taskcluster.net/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:01:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/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 05:01:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/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 05:01:13 INFO - Downloaded 22485738 bytes. 05:01:13 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'] 05:01:13 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 05:01:15 INFO - Return code: 0 05:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:15 INFO - https://queue.taskcluster.net/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:01:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/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 05:01:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/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 05:01:15 INFO - Downloaded 11132144 bytes. 05:01:15 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'] 05:01:15 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 05:01:16 INFO - Return code: 0 05:01:16 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')]} 05:01:16 INFO - https://queue.taskcluster.net/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:01:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:01:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:01:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/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 05:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRpxVfGhR5G8uEuubq3isg/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 05:01:17 INFO - Downloaded 55952496 bytes. 05:01:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:01:17 INFO - mkdir: /builds/slave/test-pgo/properties 05:01:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:01:17 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:01:17 INFO - Contents: 05:01:17 INFO - build_url:https://queue.taskcluster.net/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:01:17 INFO - Running post-action listener: _resource_record_post_action 05:01:17 INFO - Running post-action listener: set_extra_try_arguments 05:01:17 INFO - ##### 05:01:17 INFO - ##### Running populate-webroot step. 05:01:17 INFO - ##### 05:01:17 INFO - Running pre-action listener: _resource_record_pre_action 05:01:17 INFO - Running main action method: populate_webroot 05:01:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:01:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:01:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:01:17 INFO - '--tppagecycles', 05:01:17 INFO - '7'], 05:01:17 INFO - 'tests': ['tsvgm']}}, 05:01:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:01:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:01:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:01:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:01:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:01:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:01:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:17 INFO - 'talos_options': ['--e10s'], 05:01:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:17 INFO - 'tests': ['damp', 'tps']}, 05:01:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:17 INFO - 'talos_options': ['--e10s'], 05:01:17 INFO - 'tests': ['damp', 'tps']}, 05:01:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:01:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:01:17 INFO - 'other': {'tests': ['a11yr', 05:01:17 INFO - 'ts_paint', 05:01:17 INFO - 'tpaint', 05:01:17 INFO - 'sessionrestore', 05:01:17 INFO - 'sessionrestore_no_auto_restore']}, 05:01:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:01:17 INFO - 'tests': ['a11yr', 05:01:17 INFO - 'ts_paint', 05:01:17 INFO - 'tpaint', 05:01:17 INFO - 'sessionrestore', 05:01:17 INFO - 'sessionrestore_no_auto_restore']}, 05:01:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:01:17 INFO - 'tests': ['a11yr', 05:01:17 INFO - 'ts_paint', 05:01:17 INFO - 'tpaint', 05:01:17 INFO - 'sessionrestore', 05:01:17 INFO - 'sessionrestore_no_auto_restore']}, 05:01:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:01:17 INFO - 'tests': ['a11yr', 05:01:17 INFO - 'ts_paint', 05:01:17 INFO - 'tpaint', 05:01:17 INFO - 'sessionrestore', 05:01:17 INFO - 'sessionrestore_no_auto_restore']}, 05:01:17 INFO - 'other_l64': {'tests': ['a11yr', 05:01:17 INFO - 'ts_paint', 05:01:17 INFO - 'tpaint', 05:01:17 INFO - 'sessionrestore', 05:01:17 INFO - 'sessionrestore_no_auto_restore']}, 05:01:17 INFO - 'other_nol64': {'tests': ['a11yr', 05:01:17 INFO - 'ts_paint', 05:01:17 INFO - 'tpaint', 05:01:17 INFO - 'sessionrestore', 05:01:17 INFO - 'sessionrestore_no_auto_restore']}, 05:01:17 INFO - 'svgr': {'tests': ['tsvgx', 05:01:17 INFO - 'tsvgr_opacity', 05:01:17 INFO - 'tart', 05:01:17 INFO - 'tscrollx', 05:01:17 INFO - 'cart']}, 05:01:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:01:17 INFO - 'tests': ['tsvgx', 05:01:17 INFO - 'tsvgr_opacity', 05:01:17 INFO - 'tart', 05:01:17 INFO - 'tscrollx', 05:01:17 INFO - 'cart']}, 05:01:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:17 INFO - 'tests': ['tp5o']}, 05:01:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:17 INFO - 'talos_options': ['--e10s'], 05:01:17 INFO - 'tests': ['tp5o']}, 05:01:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:17 INFO - 'talos_options': ['--xperf_path', 05:01:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:17 INFO - 'tests': ['tp5n']}, 05:01:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:17 INFO - 'talos_options': ['--e10s', 05:01:17 INFO - '--xperf_path', 05:01:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:17 INFO - 'tests': ['tp5n']}}, 05:01:17 INFO - 'talos.zip': {'path': '', 05:01:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:01:17 INFO - Running post-action listener: _resource_record_post_action 05:01:17 INFO - ##### 05:01:17 INFO - ##### Running create-virtualenv step. 05:01:17 INFO - ##### 05:01:17 INFO - Running pre-action listener: _resource_record_pre_action 05:01:17 INFO - Running main action method: create_virtualenv 05:01:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:01:17 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 05:01:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:01:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:01:17 INFO - Using real prefix '/usr' 05:01:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:01:18 INFO - Installing distribute.............................................................................................................................................................................................done. 05:01:20 INFO - Installing pip.................done. 05:01:20 INFO - Return code: 0 05:01:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b2cb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2203630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294840>, '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 0x22016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', '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 05:01:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:01:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:01:20 INFO - Using env: {'DISPLAY': ':0', 05:01:20 INFO - 'HOME': '/home/cltbld', 05:01:20 INFO - 'LANG': 'en_US.UTF-8', 05:01:20 INFO - 'LANGUAGE': 'en_US:en', 05:01:20 INFO - 'LOGNAME': 'cltbld', 05:01:20 INFO - 'MAIL': '/var/mail/cltbld', 05:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:20 INFO - 'MOZ_NO_REMOTE': '1', 05:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:20 INFO - 'NO_EM_RESTART': '1', 05:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:20 INFO - 'SHELL': '/bin/bash', 05:01:20 INFO - 'SHLVL': '1', 05:01:20 INFO - 'TERM': 'linux', 05:01:20 INFO - 'TMOUT': '86400', 05:01:20 INFO - 'USER': 'cltbld', 05:01:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', 05:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:20 INFO - '_': '/tools/buildbot/bin/python'} 05:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:20 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 05:01:20 INFO - Cleaning up... 05:01:20 INFO - Return code: 0 05:01:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0b2cb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2203630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294840>, '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 0x22016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', '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 05:01:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:01:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:01:20 INFO - Using env: {'DISPLAY': ':0', 05:01:20 INFO - 'HOME': '/home/cltbld', 05:01:20 INFO - 'LANG': 'en_US.UTF-8', 05:01:20 INFO - 'LANGUAGE': 'en_US:en', 05:01:20 INFO - 'LOGNAME': 'cltbld', 05:01:20 INFO - 'MAIL': '/var/mail/cltbld', 05:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:20 INFO - 'MOZ_NO_REMOTE': '1', 05:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:20 INFO - 'NO_EM_RESTART': '1', 05:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:20 INFO - 'SHELL': '/bin/bash', 05:01:20 INFO - 'SHLVL': '1', 05:01:20 INFO - 'TERM': 'linux', 05:01:20 INFO - 'TMOUT': '86400', 05:01:20 INFO - 'USER': 'cltbld', 05:01:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', 05:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:20 INFO - '_': '/tools/buildbot/bin/python'} 05:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:20 INFO - Downloading/unpacking psutil>=0.7.1 05:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:01:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:22 INFO - Installing collected packages: psutil 05:01:22 INFO - Running setup.py install for psutil 05:01:22 INFO - building 'psutil._psutil_linux' extension 05:01:22 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 05:01:22 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 05:01:22 INFO - building 'psutil._psutil_posix' extension 05:01:22 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 05:01:23 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 05:01:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:23 INFO - Successfully installed psutil 05:01:23 INFO - Cleaning up... 05:01:23 INFO - Return code: 0 05:01:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b2cb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2203630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294840>, '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 0x22016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', '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 05:01:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:01:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:01:23 INFO - Using env: {'DISPLAY': ':0', 05:01:23 INFO - 'HOME': '/home/cltbld', 05:01:23 INFO - 'LANG': 'en_US.UTF-8', 05:01:23 INFO - 'LANGUAGE': 'en_US:en', 05:01:23 INFO - 'LOGNAME': 'cltbld', 05:01:23 INFO - 'MAIL': '/var/mail/cltbld', 05:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:23 INFO - 'MOZ_NO_REMOTE': '1', 05:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:23 INFO - 'NO_EM_RESTART': '1', 05:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:23 INFO - 'SHELL': '/bin/bash', 05:01:23 INFO - 'SHLVL': '1', 05:01:23 INFO - 'TERM': 'linux', 05:01:23 INFO - 'TMOUT': '86400', 05:01:23 INFO - 'USER': 'cltbld', 05:01:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', 05:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:23 INFO - '_': '/tools/buildbot/bin/python'} 05:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:01:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:01:25 INFO - Installing collected packages: mozsystemmonitor 05:01:25 INFO - Running setup.py install for mozsystemmonitor 05:01:25 INFO - Successfully installed mozsystemmonitor 05:01:25 INFO - Cleaning up... 05:01:25 INFO - Return code: 0 05:01:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:01:25 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')]} 05:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:25 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')]} 05:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b2cb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2203630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294840>, '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 0x22016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', '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 05:01:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:01:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:01:25 INFO - Using env: {'DISPLAY': ':0', 05:01:25 INFO - 'HOME': '/home/cltbld', 05:01:25 INFO - 'LANG': 'en_US.UTF-8', 05:01:25 INFO - 'LANGUAGE': 'en_US:en', 05:01:25 INFO - 'LOGNAME': 'cltbld', 05:01:25 INFO - 'MAIL': '/var/mail/cltbld', 05:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:25 INFO - 'MOZ_NO_REMOTE': '1', 05:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:25 INFO - 'NO_EM_RESTART': '1', 05:01:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:25 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:25 INFO - 'SHELL': '/bin/bash', 05:01:25 INFO - 'SHLVL': '1', 05:01:25 INFO - 'TERM': 'linux', 05:01:25 INFO - 'TMOUT': '86400', 05:01:25 INFO - 'USER': 'cltbld', 05:01:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', 05:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:25 INFO - '_': '/tools/buildbot/bin/python'} 05:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:01:25 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 05:01:25 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 05:01:25 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 05:01:25 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 05:01:25 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 05:01:25 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 05:01:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:01:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:01:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:01:27 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 05:01:27 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 05:01:27 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 05:01:27 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 05:01:27 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 05:01:27 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 05:01:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:01:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:01:27 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 05:01:27 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 05:01:27 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 05:01:27 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 05:01:27 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 05:01:27 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 05:01:27 INFO - Downloading docopt-0.6.1.tar.gz 05:01:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:01:28 INFO - Installing collected packages: blobuploader, requests, docopt 05:01:28 INFO - Running setup.py install for blobuploader 05:01:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:01:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:01:28 INFO - Running setup.py install for requests 05:01:28 INFO - Running setup.py install for docopt 05:01:28 INFO - Successfully installed blobuploader requests docopt 05:01:28 INFO - Cleaning up... 05:01:28 INFO - Return code: 0 05:01:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b2cb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2203630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294840>, '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 0x22016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', '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 05:01:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:01:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:01:28 INFO - Using env: {'DISPLAY': ':0', 05:01:28 INFO - 'HOME': '/home/cltbld', 05:01:28 INFO - 'LANG': 'en_US.UTF-8', 05:01:28 INFO - 'LANGUAGE': 'en_US:en', 05:01:28 INFO - 'LOGNAME': 'cltbld', 05:01:28 INFO - 'MAIL': '/var/mail/cltbld', 05:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:28 INFO - 'MOZ_NO_REMOTE': '1', 05:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:28 INFO - 'NO_EM_RESTART': '1', 05:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:28 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:28 INFO - 'SHELL': '/bin/bash', 05:01:28 INFO - 'SHLVL': '1', 05:01:28 INFO - 'TERM': 'linux', 05:01:28 INFO - 'TMOUT': '86400', 05:01:28 INFO - 'USER': 'cltbld', 05:01:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', 05:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:28 INFO - '_': '/tools/buildbot/bin/python'} 05:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:01:28 INFO - Running setup.py (path:/tmp/pip-ojKilC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:01:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:01:28 INFO - Running setup.py (path:/tmp/pip-bjoggs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:01:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:01:28 INFO - Running setup.py (path:/tmp/pip-Crjwbc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:01:29 INFO - Running setup.py (path:/tmp/pip-MwwUts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:01:29 INFO - Running setup.py (path:/tmp/pip-KTcvGO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:01:29 INFO - Running setup.py (path:/tmp/pip-YONspp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:01:29 INFO - Running setup.py (path:/tmp/pip-i8q1EH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:01:29 INFO - Running setup.py (path:/tmp/pip-T72TYr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:01:29 INFO - Running setup.py (path:/tmp/pip-cQOM8F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:01:29 INFO - Running setup.py (path:/tmp/pip-cOicqH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:01:29 INFO - Running setup.py (path:/tmp/pip-rF7P8x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:01:29 INFO - Running setup.py (path:/tmp/pip-KdVWul-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:01:29 INFO - Running setup.py (path:/tmp/pip-ySAQ6b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:01:29 INFO - Running setup.py (path:/tmp/pip-Etx_sB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:01:29 INFO - Running setup.py (path:/tmp/pip-ZBE2F0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:01:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:01:29 INFO - Running setup.py (path:/tmp/pip-UXDsF8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:01:30 INFO - Running setup.py (path:/tmp/pip-KJEejT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:01:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:01:30 INFO - Running setup.py install for manifestparser 05:01:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:01:30 INFO - Running setup.py install for mozcrash 05:01:30 INFO - Running setup.py install for mozdebug 05:01:30 INFO - Running setup.py install for mozdevice 05:01:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:01:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:01:30 INFO - Running setup.py install for mozfile 05:01:30 INFO - Running setup.py install for mozhttpd 05:01:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:01:30 INFO - Running setup.py install for mozinfo 05:01:30 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:01:30 INFO - Running setup.py install for mozInstall 05:01:30 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:01:30 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:01:30 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:01:30 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:01:30 INFO - Running setup.py install for mozleak 05:01:30 INFO - Running setup.py install for mozlog 05:01:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:01:31 INFO - Running setup.py install for moznetwork 05:01:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:01:31 INFO - Running setup.py install for mozprocess 05:01:31 INFO - Running setup.py install for mozprofile 05:01:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:01:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:01:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:01:31 INFO - Running setup.py install for mozrunner 05:01:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:01:31 INFO - Running setup.py install for mozscreenshot 05:01:31 INFO - Running setup.py install for moztest 05:01:31 INFO - Running setup.py install for mozversion 05:01:31 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:01:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:01:31 INFO - Cleaning up... 05:01:31 INFO - Return code: 0 05:01:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:01:31 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')]} 05:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:31 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')]} 05:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b2cb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2203630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294840>, '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 0x22016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', '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 05:01:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:01:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:01:31 INFO - Using env: {'DISPLAY': ':0', 05:01:31 INFO - 'HOME': '/home/cltbld', 05:01:31 INFO - 'LANG': 'en_US.UTF-8', 05:01:31 INFO - 'LANGUAGE': 'en_US:en', 05:01:31 INFO - 'LOGNAME': 'cltbld', 05:01:31 INFO - 'MAIL': '/var/mail/cltbld', 05:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:31 INFO - 'MOZ_NO_REMOTE': '1', 05:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:31 INFO - 'NO_EM_RESTART': '1', 05:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:31 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:31 INFO - 'SHELL': '/bin/bash', 05:01:31 INFO - 'SHLVL': '1', 05:01:31 INFO - 'TERM': 'linux', 05:01:31 INFO - 'TMOUT': '86400', 05:01:31 INFO - 'USER': 'cltbld', 05:01:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', 05:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:31 INFO - '_': '/tools/buildbot/bin/python'} 05:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:01:32 INFO - Running setup.py (path:/tmp/pip-soN76w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:01:32 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)) 05:01:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:01:32 INFO - Running setup.py (path:/tmp/pip-GIp9pY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:01:32 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)) 05:01:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:01:32 INFO - Running setup.py (path:/tmp/pip-hAWECs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:01:32 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)) 05:01:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:01:32 INFO - Running setup.py (path:/tmp/pip-8LHTWc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:01:32 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)) 05:01:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:01:32 INFO - Running setup.py (path:/tmp/pip-NSFrOC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:01:32 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)) 05:01:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:01:32 INFO - Running setup.py (path:/tmp/pip-FdrNw9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:01:32 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)) 05:01:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:01:32 INFO - Running setup.py (path:/tmp/pip-IPTh1A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:01:32 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)) 05:01:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:01:32 INFO - Running setup.py (path:/tmp/pip-GcIl9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:01:32 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)) 05:01:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:01:32 INFO - Running setup.py (path:/tmp/pip-nimbqF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:01:32 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)) 05:01:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:01:32 INFO - Running setup.py (path:/tmp/pip-IVHXnF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:01:32 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)) 05:01:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:01:32 INFO - Running setup.py (path:/tmp/pip-4PQfY0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:01:32 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)) 05:01:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:01:32 INFO - Running setup.py (path:/tmp/pip-7mESsL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:01:33 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)) 05:01:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:01:33 INFO - Running setup.py (path:/tmp/pip-ntKPje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:01:33 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)) 05:01:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:01:33 INFO - Running setup.py (path:/tmp/pip-HkXUe4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:01:33 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)) 05:01:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:01:33 INFO - Running setup.py (path:/tmp/pip-74wcZ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:01:33 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)) 05:01:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:01:33 INFO - Running setup.py (path:/tmp/pip-K3HyVb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:01:33 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)) 05:01:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:01:33 INFO - Running setup.py (path:/tmp/pip-SXA78s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:01:33 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)) 05:01:33 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)) 05:01:33 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)) 05:01:33 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)) 05:01:33 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)) 05:01:33 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)) 05:01:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:35 INFO - Downloading blessings-1.5.1.tar.gz 05:01:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:01:35 INFO - Installing collected packages: blessings 05:01:35 INFO - Running setup.py install for blessings 05:01:35 INFO - Successfully installed blessings 05:01:35 INFO - Cleaning up... 05:01:35 INFO - Return code: 0 05:01:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:01:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:01:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:01:35 INFO - Reading from file tmpfile_stdout 05:01:35 INFO - Current package versions: 05:01:35 INFO - argparse == 1.2.1 05:01:35 INFO - blessings == 1.5.1 05:01:35 INFO - blobuploader == 1.2.4 05:01:35 INFO - docopt == 0.6.1 05:01:35 INFO - manifestparser == 1.1 05:01:35 INFO - mozInstall == 1.12 05:01:35 INFO - mozcrash == 0.16 05:01:35 INFO - mozdebug == 0.1 05:01:35 INFO - mozdevice == 0.48 05:01:35 INFO - mozfile == 1.2 05:01:35 INFO - mozhttpd == 0.7 05:01:35 INFO - mozinfo == 0.9 05:01:35 INFO - mozleak == 0.1 05:01:35 INFO - mozlog == 3.1 05:01:35 INFO - moznetwork == 0.27 05:01:35 INFO - mozprocess == 0.22 05:01:35 INFO - mozprofile == 0.28 05:01:35 INFO - mozrunner == 6.11 05:01:35 INFO - mozscreenshot == 0.1 05:01:35 INFO - mozsystemmonitor == 0.0 05:01:35 INFO - moztest == 0.7 05:01:35 INFO - mozversion == 1.4 05:01:35 INFO - psutil == 3.1.1 05:01:35 INFO - requests == 1.2.3 05:01:35 INFO - wsgiref == 0.1.2 05:01:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:01:35 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')]} 05:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:35 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')]} 05:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b2cb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2203630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294840>, '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 0x22016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', '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 05:01:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:01:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:01:35 INFO - Using env: {'DISPLAY': ':0', 05:01:35 INFO - 'HOME': '/home/cltbld', 05:01:35 INFO - 'LANG': 'en_US.UTF-8', 05:01:35 INFO - 'LANGUAGE': 'en_US:en', 05:01:35 INFO - 'LOGNAME': 'cltbld', 05:01:35 INFO - 'MAIL': '/var/mail/cltbld', 05:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:35 INFO - 'MOZ_NO_REMOTE': '1', 05:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:35 INFO - 'NO_EM_RESTART': '1', 05:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:35 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:35 INFO - 'SHELL': '/bin/bash', 05:01:35 INFO - 'SHLVL': '1', 05:01:35 INFO - 'TERM': 'linux', 05:01:35 INFO - 'TMOUT': '86400', 05:01:35 INFO - 'USER': 'cltbld', 05:01:35 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', 05:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:35 INFO - '_': '/tools/buildbot/bin/python'} 05:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:35 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)) 05:01:35 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)) 05:01:35 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)) 05:01:35 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)) 05:01:35 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)) 05:01:35 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)) 05:01:35 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)) 05:01:35 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)) 05:01:35 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)) 05:01:35 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)) 05:01:35 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)) 05:01:35 INFO - Cleaning up... 05:01:35 INFO - Return code: 0 05:01:35 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:01:35 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')]} 05:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:35 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')]} 05:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b2cb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2203630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294840>, '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 0x22016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', '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 05:01:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:01:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:01:35 INFO - Using env: {'DISPLAY': ':0', 05:01:35 INFO - 'HOME': '/home/cltbld', 05:01:35 INFO - 'LANG': 'en_US.UTF-8', 05:01:35 INFO - 'LANGUAGE': 'en_US:en', 05:01:35 INFO - 'LOGNAME': 'cltbld', 05:01:35 INFO - 'MAIL': '/var/mail/cltbld', 05:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:35 INFO - 'MOZ_NO_REMOTE': '1', 05:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:35 INFO - 'NO_EM_RESTART': '1', 05:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:35 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:35 INFO - 'SHELL': '/bin/bash', 05:01:35 INFO - 'SHLVL': '1', 05:01:35 INFO - 'TERM': 'linux', 05:01:35 INFO - 'TMOUT': '86400', 05:01:35 INFO - 'USER': 'cltbld', 05:01:35 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', 05:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:35 INFO - '_': '/tools/buildbot/bin/python'} 05:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:36 INFO - Downloading/unpacking jsonschema 05:01:36 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 05:01:36 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 05:01:36 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 05:01:36 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 05:01:36 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 05:01:36 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 05:01:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:01:38 INFO - Downloading/unpacking functools32 (from jsonschema) 05:01:38 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 05:01:38 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 05:01:38 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 05:01:38 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 05:01:38 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 05:01:38 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 05:01:38 INFO - Downloading functools32-3.2.3-2.tar.gz 05:01:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:01:38 INFO - warning: no files found matching '*.txt' 05:01:38 INFO - no previously-included directories found matching 'build' 05:01:38 INFO - no previously-included directories found matching 'dist' 05:01:38 INFO - no previously-included directories found matching '.git*' 05:01:38 INFO - Installing collected packages: jsonschema, functools32 05:01:38 INFO - Running setup.py install for functools32 05:01:38 INFO - warning: no files found matching '*.txt' 05:01:38 INFO - no previously-included directories found matching 'build' 05:01:38 INFO - no previously-included directories found matching 'dist' 05:01:38 INFO - no previously-included directories found matching '.git*' 05:01:38 INFO - Successfully installed jsonschema functools32 05:01:38 INFO - Cleaning up... 05:01:38 INFO - Return code: 0 05:01:38 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b2cb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2203630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294840>, '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 0x22016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', '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 05:01:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:01:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:01:38 INFO - Using env: {'DISPLAY': ':0', 05:01:38 INFO - 'HOME': '/home/cltbld', 05:01:38 INFO - 'LANG': 'en_US.UTF-8', 05:01:38 INFO - 'LANGUAGE': 'en_US:en', 05:01:38 INFO - 'LOGNAME': 'cltbld', 05:01:38 INFO - 'MAIL': '/var/mail/cltbld', 05:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:38 INFO - 'MOZ_NO_REMOTE': '1', 05:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:38 INFO - 'NO_EM_RESTART': '1', 05:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:38 INFO - 'SHELL': '/bin/bash', 05:01:38 INFO - 'SHLVL': '1', 05:01:38 INFO - 'TERM': 'linux', 05:01:38 INFO - 'TMOUT': '86400', 05:01:38 INFO - 'USER': 'cltbld', 05:01:38 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', 05:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:38 INFO - '_': '/tools/buildbot/bin/python'} 05:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:38 INFO - Downloading/unpacking flake8 05:01:38 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 05:01:38 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 05:01:38 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 05:01:38 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 05:01:38 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 05:01:38 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 05:01:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:01:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:01:40 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 05:01:40 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 05:01:40 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 05:01:40 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 05:01:40 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 05:01:40 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 05:01:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:01:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:01:40 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 05:01:40 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 05:01:40 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 05:01:40 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 05:01:40 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 05:01:40 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 05:01:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:01:40 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 05:01:40 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 05:01:40 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 05:01:40 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 05:01:40 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 05:01:40 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 05:01:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:01:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:01:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:01:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:01:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:01:41 INFO - no previously-included directories found matching 'docs/_build' 05:01:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:01:41 INFO - Running setup.py install for pep8 05:01:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:01:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:01:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:01:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:01:41 INFO - no previously-included directories found matching 'docs/_build' 05:01:41 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:01:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:01:41 INFO - Cleaning up... 05:01:41 INFO - Return code: 0 05:01:41 INFO - Running post-action listener: _resource_record_post_action 05:01:41 INFO - Running post-action listener: _start_resource_monitoring 05:01:41 INFO - Starting resource monitoring. 05:01:41 INFO - ##### 05:01:41 INFO - ##### Running install step. 05:01:41 INFO - ##### 05:01:41 INFO - Running pre-action listener: _resource_record_pre_action 05:01:41 INFO - Running main action method: install 05:01:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:01:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:01:41 INFO - Reading from file tmpfile_stdout 05:01:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:01:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:01:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:01:41 INFO - Reading from file tmpfile_stdout 05:01:41 INFO - Output received: 05:01:41 INFO - Usage: mozinstall [options] installer 05:01:41 INFO - Options: 05:01:41 INFO - -h, --help show this help message and exit 05:01:41 INFO - -d DEST, --destination=DEST 05:01:41 INFO - Directory to install application into. [default: 05:01:41 INFO - "/builds/slave/test-pgo"] 05:01:41 INFO - --app=APP Application being installed. [default: firefox] 05:01:41 INFO - mkdir: /builds/slave/test-pgo/build/application 05:01:41 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'] 05:01:41 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 05:01:57 INFO - Reading from file tmpfile_stdout 05:01:57 INFO - Output received: 05:01:57 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:01:57 INFO - Running post-action listener: _resource_record_post_action 05:01:57 INFO - ##### 05:01:57 INFO - ##### Running run-tests step. 05:01:57 INFO - ##### 05:01:57 INFO - Running pre-action listener: _resource_record_pre_action 05:01:57 INFO - Running main action method: run_tests 05:01:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:01:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:01:57 INFO - Python 2.7.3 05:01:57 INFO - Return code: 0 05:01:57 INFO - grabbing minidump binary from tooltool 05:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:57 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 0x2294840>, '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 0x22016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:01:57 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 05:01:57 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 05:01:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:01:57 INFO - Return code: 0 05:01:57 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:01:57 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:01:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:01:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:01:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:01:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:01:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:01:58 INFO - Return code: 0 05:01:58 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/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 05:01:58 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/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 05:01:58 INFO - Using env: {'DISPLAY': ':0', 05:01:58 INFO - 'HOME': '/home/cltbld', 05:01:58 INFO - 'LANG': 'en_US.UTF-8', 05:01:58 INFO - 'LANGUAGE': 'en_US:en', 05:01:58 INFO - 'LOGNAME': 'cltbld', 05:01:58 INFO - 'MAIL': '/var/mail/cltbld', 05:01:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:01:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:58 INFO - 'MOZ_NO_REMOTE': '1', 05:01:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:58 INFO - 'NO_EM_RESTART': '1', 05:01:58 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:58 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:01:58 INFO - 'SHELL': '/bin/bash', 05:01:58 INFO - 'SHLVL': '1', 05:01:58 INFO - 'TERM': 'linux', 05:01:58 INFO - 'TMOUT': '86400', 05:01:58 INFO - 'USER': 'cltbld', 05:01:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663', 05:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:58 INFO - '_': '/tools/buildbot/bin/python'} 05:01:58 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/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 05:01:58 INFO - mozversion application_buildid: 20160120005957 05:01:58 INFO - mozversion application_changeset: c6c9487c4236fa5a323be109922892dc5398d543 05:01:58 INFO - mozversion application_display_name: Nightly 05:01:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:01:58 INFO - mozversion application_name: Firefox 05:01:58 INFO - mozversion application_remotingname: firefox 05:01:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:01:58 INFO - mozversion application_vendor: Mozilla 05:01:58 INFO - mozversion application_version: 46.0a1 05:01:58 INFO - mozversion platform_buildid: 20160120005957 05:01:58 INFO - mozversion platform_changeset: c6c9487c4236fa5a323be109922892dc5398d543 05:01:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:01:58 INFO - mozversion platform_version: 46.0a1 05:01:58 INFO - using testdate: 1453294918 05:01:58 INFO - actual date: 1453294918 05:01:58 INFO - starting webserver on 'localhost:57033' 05:01:58 INFO - SUITE-START | Running 3 tests 05:01:58 INFO - TEST-START | dromaeo_css 05:01:58 INFO - operating with platform_type : linux_ 05:01:58 INFO - Initialising browser for dromaeo_css test... 05:01:58 INFO - TEST-INFO | started process 28320 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp82QA5g/profile http://localhost:57033/getInfo.html) 05:02:02 INFO - PROCESS | 28320 | __metrics Screen width/height:1600/1200 05:02:02 INFO - PROCESS | 28320 | colorDepth:24 05:02:02 INFO - PROCESS | 28320 | Browser inner width/height: 1024/697 05:02:02 INFO - PROCESS | 28320 | __metrics 05:02:03 INFO - PROCESS | 28320 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:02:03 INFO - PROCESS | 28320 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:04 INFO - TEST-INFO | 28320: exit 0 05:02:04 INFO - Browser initialized. 05:02:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:02:04 INFO - TEST-INFO | started process 28413 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp82QA5g/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:16 INFO - PROCESS | 28413 | RSS: Main: 149987328 05:02:16 INFO - PROCESS | 28413 | 05:03:07 INFO - PROCESS | 28413 | 1453294987365 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] 05:05:15 INFO - PROCESS | 28413 | Cycle 1(1): loaded http://localhost:57033/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57033/tests/dromaeo/cssquery-ext.html) 05:05:16 INFO - PROCESS | 28413 | RSS: Main: 268500992 05:05:16 INFO - PROCESS | 28413 | 05:08:18 INFO - PROCESS | 28413 | Cycle 1(1): loaded http://localhost:57033/tests/dromaeo/cssquery-ext.html (next: http://localhost:57033/tests/dromaeo/cssquery-jquery.html) 05:08:19 INFO - PROCESS | 28413 | RSS: Main: 225943552 05:08:19 INFO - PROCESS | 28413 | 05:11:21 INFO - PROCESS | 28413 | Cycle 1(1): loaded http://localhost:57033/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57033/tests/dromaeo/cssquery-mootools.html) 05:11:22 INFO - PROCESS | 28413 | RSS: Main: 236519424 05:11:22 INFO - PROCESS | 28413 | 05:14:24 INFO - PROCESS | 28413 | Cycle 1(1): loaded http://localhost:57033/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57033/tests/dromaeo/cssquery-prototype.html) 05:14:24 INFO - PROCESS | 28413 | RSS: Main: 210145280 05:14:24 INFO - PROCESS | 28413 | 05:17:27 INFO - PROCESS | 28413 | Cycle 1(1): loaded http://localhost:57033/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57033/tests/dromaeo/cssquery-yui.html) 05:17:27 INFO - PROCESS | 28413 | RSS: Main: 216989696 05:17:27 INFO - PROCESS | 28413 | 05:20:30 INFO - PROCESS | 28413 | Cycle 1(1): loaded http://localhost:57033/tests/dromaeo/cssquery-yui.html (next: http://localhost:57033/tests/dromaeo/cssquery-dojo.html) 05:20:30 INFO - PROCESS | 28413 | RSS: Main: 259207168 05:20:30 INFO - PROCESS | 28413 | 05:20:30 INFO - PROCESS | 28413 | __start_tp_report 05:20:30 INFO - PROCESS | 28413 | _x_x_mozilla_page_load 05:20:30 INFO - PROCESS | 28413 | _x_x_mozilla_page_load_details 05:20:30 INFO - PROCESS | 28413 | |i|pagename|runs| 05:20:30 INFO - PROCESS | 28413 | |0;dojo.html;3038.2404398900276;3050.496668049772;3086.6141732283463;3093.505039193728;3117.922051948701;4835.782389792459;4951.950480495194;4952.23240397738;4971.477994810542;4998.10034193845;4974.97512512437;4975.577075948549;5017.673851199669;5019.272205530196;5022.196448568221;4349.195398851207;4513.277875539914;4531.053858568953;4588.49526552079;4728.621710263188;4544.318352247156;4623.537646235383;4623.74569398683;4680.1809683305455;4717.764111794414;4552.157850797596;4573.977130114361;4599.08018396322;4625.121226966866;4626.8611941641975;4558.156741002925;4560.338750881104;4577.404937358122;4578.267477203632;4650.883727906796;4504.324351347292;4571.062932098912;4577.473590537064;4579.885502862422;4620.699654522446;4792.640551958617;4900.995295964319;4901.828436004758;4904.068227036852;4919.040787046527;5354.625176237665;5356.6518176318805;5367.221752845854;5375.784968601251;5390.272313237702;5362.544183744387;5410.945890541084;5421.620486565942;5438.809641662523;5459.372172200208;5054.696718196883;5070.518300761421;5091.87270318245;5098.082345177866;5146.8198613048735;5430.239766432703;5436.728163591804;5438.265834112344;5440.319960004999;5441.727913604304;5156.793728250828;5239.214117882349;5261.789528418897;5269.631125821233;5319.175527793198;5317.867053323698;5342.332208473941;5351.518363347317;5353.598480114007;5388.973055134699;5277.1292736698015;5294.391145018295;5315.548178404879;5316.574674026068;5362.651427657268;5190.11767999441;5213.921791173136;5270.051390749625;5284.339457567804;5287.07476191665;4160.43834082395;4207.053412982054;4209.97895010523;4213.2837417639075;4244.129953359554;3754.887353379403;3765.548134223911;3766.1714422826935;3782.8108594570162;3803.1823158021157;4929.359183306219;4984.102861484967;4989.952110056929;5023.899522009539;5038.118329292359;5358.33020872391;5435.565154787608;5486.945130548644;5498.560115190855;5520.309961254843;4971.850844474671;4986.4514903360605;4986.650934434628;4987.426445958761;5021.447640759514;4562.612177964844;4600.2869555218995;4602.539746025371;4605.378273933044;4639.8144074237325;5466.6993315367245;5544.251526044013;5550.861228469321;5551.306086739158;5558.805441809517;5404.891902162013;5408.648437851527;5427.6200665953;5427.701476418835;5430.728463576726;5562.137868630369;5591.580631452739;5608.38307786135;5615.101583746581;5668.178114173505;5225.085610018155;5265.6840589564745;5289.338832645919;5318.335208098988;5346.198070289488;5322.148456246982;5352.705601191972;5353.544948679406;5357.866053348697;5373.301470808769;5135.768890399866;5230.476952304739;5231.712255825966;5232.5552328052545;5272.578193744414;5142.151544995184;5165.483451654804;5181.35233095863;5281.630285879952;5300;5133.153029750049;5137.897242055213;5147.510986456281;5149.433562308218;5218.817341393033;5174.249733788655;5239.187925871496;5243.344581927259;5243.55429788457;5247.134222853187;5069.188929771219;5075.974620127024;5132.43543210254;5147.768350424165;5157.123289040797 05:20:30 INFO - PROCESS | 28413 | |1;ext.html;531.6358294568221;532.8960852633738;539.1293061705347;553.7923278770461;587.2248631806018;31387.372252554964;31948.36103277936;31950;36958.63041369592;37508;40516.59483405165;41138.79430602843;41161.17677646453;41211.587884121225;41263.79368103163;8395.412321137508;8593.484390936532;8601.354898382615;8612.39713220075;8629.180227878342;8335.083140854502;8485.151484851496;8502.574871256444;8551.743447696548;8555.657773689045;8507.95746021269;8665.220130188281;8665.870011949826;8668.219860212579;8668.306535477179;8666.480011199348;8752.8687069694;8757.343199260049;8759.912400876037;8763.56182190888;8505.702300419456;8632.309415246766;8647.913520864837;8649.091845356274;8654.177853103945;40265.396019059735;40341.79829100865;40710.59289407098;40724.59275407238;40783.388249176285;3214.5981752280964;3401.353742788887;3463.255400088993;3480.564929383827;3735.7758534488016;29860.701392986008;30550.388992220254;30583.847080764677;30607.540886886716;30632.38735225283;3945.842166313344;4082.81627326771;4110.876673699764;4132.40080188371;4189.2668782963165;201591;201975.99012004992;202580;202853;202932;52990;54247.45752542503;59450;59968.400315997154;61567.38432615706;60561.394386055574;60989.39010609926;61506.692466538276;61606.075908860505;61726.69136654288;14752.18862962526;14955.102693838404;14996.850031499764;15027.849721502645;15050.774238386433;9803;10061.748456288651;10895.945520272347;11050.557977680963;11129.721756956142;19851.602967940562;19960.3013894513;19991.901255305453;19994.70007949882;20034;7171.318724721144;7378.5941773202985;7418.591977441185;7436.405087593088;7451.366633836076;921.3780698028804;951.3768481644533;960.2941837749248;1002.1131298800468;1138.9886101139048;29130.563041554393;29605.851970740438;29665.947311368167;29852.253693657833;30032;1004.7186787699455;1019.2661283875598;1054.093479607537;1094.8412480190327;1116.994704765701;12859.292738899263;13910.930445347709;13982.650433739034;15964;16895.577610559834;321528;322958;323130;323802;324960;54643.72678136584;55103.44896551063;55334.44665553293;55486.44513554894;56015.43984560184;1286.8777466140702;1304.2500562176597;1311.4295281552554;1317.5125203674702;1319.3930791835862;29654.851725741235;30514.847425762728;30854.074377768702;31214.687853121177;31348.373032538766;48221.27668085052;48509;48586.75706621444;48628.27057594068;48711;285142;309244;311122;311214;311765;26629.671291088613;32491.675083248865;33057.33885322232;33136.33727325392;33420.33159336751;38262.6173738259;38739.80630096832;39009.609903901735;39123;39706;32867;33236.66763332432;33386.66613333835;34057.148571284924;34240;35777.64222357743;40777.59222407738;41944.79027604842;43283.783581081894;46600.53399465962;35947.640523594426;36687;36824.44763328606;37065.62934370622;37224.06939826526;35428.29143417169;38241;40422.79788601038;40598.1880362397;40634;28847.56728649114;29464.263393415335;29991.55012674768;31267;31622.683773161974 05:20:30 INFO - PROCESS | 28413 | |2;jquery.html;359.9352116619009;361.0810487309798;367.5772861209609;369.33519664603716;370.54608105071276;13418.597442076752;13610.931945340259;15613.453529126482;16855.83144168558;18060.367887123954;15957.281922313494;16127.43553975611;16670.83329166708;16679.583010424714;16689.33242670295;5297.708626025567;5504.504594586487;5512.200730894018;5512.4211957744465;5519.061759500894;3999.7800120993334;4141.503019637647;5356.437574054727;5470.124780035195;5774.220480235156;5674.148877668362;5909.556783241253;5945.37573554777;5959.314678811948;5959.52323814096;5835.854103647422;5887.381824908409;5889.1755154278435;5889.528837692974;5890.3226128995075;4934.654574179809;5132.050570644443;5136.460671629462;5203.531682148625;5206.453322401131;18340.266389344542;18409.355672551395;18620.348287809862;19164.520886977938;19173.424797256106;1976.377441106047;2059.3513043391285;2133.210712036541;2134.5197330600645;2276.10094012864;8872.290216782707;9185.908140918638;9439.905600943972;11305.265157764801;12004;1790;1825.1604262039477;1829.9359522416785;1839.4297767692058;1914.9904250478799;54528.45471545273;56869.715651421895;57950.71024644892;58426;58767.41232587662;9730;10013.64952226683;10050.949745251228;10070.848937265946;10090;13279.73440531184;13355.933220334031;13377.46490140403;13382.799258011137;13393.397297121654;7145.214026457085;7188.424926005907;7338.192798792129;7390.889136662954;7422.480426370103;6976.4767642426;6982.685779139951;7001.92998070023;7039.296070392919;7065.57606543609;4400.955990440055;4446.421965144576;4456.286994080931;4474.306482495218;4501.234790085693;1640.704673158819;1711.2213942656062;1761.5155832146263;1773.6009397885373;1806.494181629146;411.67889046543746;421.5278887645856;878.2447095497866;1029.8197815382277;1030.6907927621683;10161.237907156992;10470.581176752998;10519.368837869752;10676.0925321347;10849.132069434427;453.41735869408313;459.27434653247786;459.53127809633986;460.16709755342936;476.73302950347914;5870.559708021916;9440;9922.355046922072;9952.402855828674;9979.60081596728;513128;518218;528039;548236;551895;72750.63624681842;74428.62785686037;76032.23967760362;76595.61702191453;76817.61591192009;1108.6009036746764;1118.1390329446444;1129.711923459529;1131.196850236325;1136.4033882211904;15038.54884353471;15117.244137793286;15376.154311512973;15403.768943465633;15478.9226053869;33581.328373431905;33677.49483757795;34000.82999584986;34271.65728342784;34438.55614438536;42385.36421953735;42627.5737242636;43760;44619.55380446154;45731;6875.89686154698;7247.202807691256;7384.298491643285;7450.925490745023;7607.695692172251;9236.676716314896;10798.946005270238;11043.944780276368;11050.613228537284;11502.88497115018;9455.905440945502;9535.618575256913;9644.276679248944;9821.656242031495;9828.557714902703;10003.449810260505;10071.798564028824;10095.949520252352;10251.948740256252;10295.897041029493;9960.908209276133;10125.038121378751;10253.641122560675;10277.486125693835;10469.371837689763;5803.65178089316;7204.3155900189395;7309.561426314438;7417.629118544159;7559.962200188964;9538.713838584854;9724.465154416575;9951;10159.339642923187;10166 05:20:30 INFO - PROCESS | 28413 | |3;mootools.html;1295.4494339905539;1446.2190417174727;1452.1287227663404;1606.6304749907522;1788.9284428622855;6871.965640171805;7023.543469674474;7313.232110628387;7481.962590187041;7491.625418729069;7511.399088072954;7528.322450979411;7603.31570158687;7622.199669034755;7625.237476252372;1981.2273213446767;2039.388183544938;2210.149092599349;2232.7320721513443;2238.3061251012236;2233.6761169630395;2276.499170182557;2281.0533628544217;2284.166279308049;2288.5079707862806;2201.6917631531596;2212.966805497919;2254.4589298568308;2256.9322920312416;2261.050358849279;2244.5062086340977;2245.9663105053437;2259.9661005084936;2269.0470002598868;2299.0344055496566;2251.752307246202;2262.9773702263096;2264.1509433962265;2267.773222677719;2271.5797577448225;7592.810179745496;7604.201558836353;7605.467617266793;7693.807654808618;7701.3453856422275;4732.692374995614;4827.927581086286;4860.902781944376;4874.293227481995;4877.5366340197625;3115.376924615063;3121.1335062861567;3163.3673265346793;3202.823844688541;3287.8985539843943;992.3450522655013;1005.1657124586576;1034.4827586206898;1041.2763129624914;1050.7373156710823;10666.893331066667;10671.679849604525;10688.305260158142;10706.518206680641;10730.19523535738;4201.159768046403;4264.104538047045;4279.636230920407;4302.161078589707;4309.159713855768;9168.541572921327;9174.633014679339;9181.081891810765;9194.49430281341;9215.585298661576;4677.111348843709;4703.529647035338;4707.082118986765;4713.764311784397;4717.8112875485285;4251.256030194703;4277.294246449301;4285.635720963691;4285.935710964338;4286.185624731291;3375.476801095834;3453.32660131272;3611.602723700391;3622.9818850905576;3715.368387374153;1165.516310731054;1172.9941350293193;1174.277819141222;1179.4869231884159;1182.261086820737;1295.6825577733516;1302.9609111726663;1324.2716505921705;1346.4883344329091;1354.065694670674;7226.385757210696;7289.5261807982315;7309.232530584212;7312.23221561739;7316.561006339637;1124.6569796212234;1131.8924702153283;1144.5364627325946;1149.689583812366;1162.616336608917;5422.511973922287;5495.477929596762;5500.669959802424;5503.422140675251;5516.310461192351;8945.642174313085;9115.908840911507;9168.129027742354;9267.629294828132;9272.814543709088;9169.633214671472;9191.816163676689;9203.677871274473;9220.170184683411;9243.121903419164;7072.575645461289;7208.639568021578;7238.782836514913;7304.634768261566;7362.263773622702;7213.891791623025;7262.092238470192;7296.160941491797;7299.963500182465;7318.634068296457;8140.75577732669;8314.916850831414;8422.452540584842;8433.704820331259;8434.915650843413;8196.34429245647;8382.790430239293;8442.746717598482;8453.577321133796;8477.406581539233;6787.796366109024;6984.371406573433;6985.1617805863625;7020.613866237406;7047.189573199148;6608.933910660832;6684.331566843277;6773.254941956479;6988.266232045562;7397.223291554309;6910.067140935909;6952.061471701458;7053.083099197277;7073.328033836778;7094.574325540484;6773;6830.112085428863;6888.207856096613;6901.309869013259;6973.3375329343635;7007;7069.187043490065;7073.752418665322;7083.5041547091205;7104.360607545345;6065.969670151621;6222.782202622887;6258.843528911813;6337.207849018872;6354.52341074412;6176.320604733386;6232.906506402498;6233.158523599256;6241.687915604292;6254.061890716247 05:20:30 INFO - PROCESS | 28413 | |4;prototype.html;318.9505626627872;339.7316120264991;347.6054677940538;348.1418303880933;355.3213362477667;5755.884882302352;5794.449527294911;5835.649861008337;5872.5889187756875;5912.113183022549;5667.149927510865;5792.913106303398;5793.826185214451;5806.042003069499;5813.651180929147;4577.359169716243;4585.197590421662;4593.563611456923;4593.931091033637;4593.977030114845;4372.3878656988045;4462.1968045751755;4484.798184081707;4575.359449677047;4584.060267645142;4557.931631025537;4563.224251877172;4564.1556312082375;4579.152856721501;4583.404157459526;4541.023679908819;4552.430946131733;4565.292379681155;4568.040711450582;4579.740571342874;4036.6770658347264;4038.353863381845;4039.798010099513;4047.0691740899756;4051.5948405159543;5496.917546236809;5578.804741834057;5601.29983752031;5627.943720562824;5703;5238.947610523884;5321.627486075976;5322.1484562470205;5324.254604355393;5339.5461385782255;5890.2342695449315;6190.288116866573;6190.3190649028575;6213.03697926822;6244.094606282109;4376.277914144162;4379.058502421963;4477.261251893434;4481.148581769454;4499.707519011254;6314.179156709644;6402.743890244385;6450.4839612830865;6466.35336466359;6470.09418681385;4568.246239370533;4571.337156112345;4573.679842410999;4577.5880170784785;4579.633629309647;4563.566461186182;4641.071785642885;4641.883952901205;4648.767561621973;4669.486356500782;5282.577393808486;5291.9206211906085;5295.258663787073;5295.788168473295;5299.178627312773;6242.812715618538;6264.655443950626;6271.4669253114;6271.717772700239;6276.560640755103;1639.959001024984;1656.5113291579014;1658.7677725118492;1661.2358315175154;1664.991675041617;1134.6993046842592;1142.1433924556582;1144.0504381363448;1145.8052131137727;1167.9532818687157;5865.266841644794;5890.646561206341;5899.646021238739;5901.380355062656;5901.822945311562;6393.1688880445245;6393.840153996094;6409.102725618417;6413.230412350548;6416.165898433173;5797.681127538026;5881.206037184926;5884.0585506318785;5897.52819774417;5898.3216930053595;3405.1997780521556;3424.9143771405415;3455.6026057003264;3461.3077384523194;3469.098034511045;6621.33786621334;6632.801015969529;6648.40164385198;6650.733970641217;6653.4677225821815;6428.357164283534;6517.771877984248;6524.249711283168;6528.575642583217;6530.8367290818105;6422.389872962061;6613.371729685672;6617.404433600903;6641.302663220389;6652.733890644514;6154.076888466587;6351.301356850835;6398.488120950406;6405.519586030973;6413.903791443226;6267.2165979252595;6377.9795232762535;6388.776392826228;6415.647139407378;6417.679116044085;6660.56706314088;6679.098321726699;6683.131192944886;6686.665666716742;6693.799186024427;4452.5992660660695;4522.909541809211;4531.912341038193;4533.138703646297;4542.114287713864;6435.485161187187;6473.741050357933;6487.286398496256;6487.643179625166;6499.675016249074;6292.3078461368295;6307.810765677037;6326.367363263821;6326.462250708557;6331.841703957438;6171.105189747551;6283.560150789401;6283.96858015707;6294.748210071729;6309.2744334400295;6112.052631842072;6118.908216376669;6125.418085281891;6125.754969801158;6129.295131059986;6330.968345158245;6341.778037768656;6342.429181373698;6348.93651063502;6352.237731472253;6032.095185722177;6160.845978850564;6165.198524191826;6168;6170.167027451236 05:20:30 INFO - PROCESS | 28413 | |5;yui.html;710.6588837358069;726.2193142371945;828.3331917806164;832.3965125284168;837.484946757744;13171.802422963652;13310.068295219338;13327.733445331087;13334.866651333496;13356.06507544471;12608.93695531521;12669.683257918558;12737.363131843416;12759.489620415172;12763.872361276384;787.4881327137364;800.2717527050386;802.4463120446902;804.666063583615;804.8229389534293;652.781318258384;665.8967859981686;783.725696006399;787.9330256928168;792.1326147868075;836.4270474724833;837.9539125348103;838.1702114906229;840.7267638017638;844.1642773654099;835.1106072033265;836.4521238588734;837.9622916968782;838.8657814749641;844.4933040175907;507.19356223604643;516.6693316277585;613.1201725523888;620.770314983459;623.7317953280087;12953.417096230598;13030.934845325713;13036.152650077809;13046.41291141901;13051.412686429134;12136.817947730791;12497.812532812015;12511.124221304512;12626.30555319457;12708.745825083539;10373.429461379621;10425;10428.634997775118;10466.581336746598;10915.563377464892;3578.499010138583;3582.802945837978;3610.6208848070837;3611.458281257806;3615.096225943514;47259.76370118162;47341.526584734056;47351.28973065407;47438.762806186096;50634.746826266004;9570.186534144537;9844.655437059668;9857.309988300893;9912.752181195528;9939.353941993748;17523.649527009387;17580.208890599955;17630.559236019202;17698.115094245237;17750.37873674415;7009.544379615309;7127.4654400920135;7234.204237533867;7242.420606351479;7293.671784769698;3962.980185099114;4115.176964607031;4146.834126634961;4217.957820421757;4241.809118589671;3048.2531779713668;3096.9535456968165;3098.4422803895063;3106.6893310669207;3111.6732743062107;562.4937556199371;564.0552075273899;573.58988323349;575.0454245951784;578.3637998202029;500.6220303670705;585.5169485174748;610.087918561753;615.3446579392933;635.6503922842418;7821.374290056782;8103.517186250976;8117;8233.547154906537;8302.54336011525;554.841870067037;584.2813339592325;675.3246753246754;707.2291202589203;712.8431745016088;3877.4959255297194;4153.709240353146;4373.934390984138;4478.41780568524;4570.65720070996;49405.75297123563;49493.257601136014;49802.750986244835;50003.249951250764;50440.243396349084;46717.76641116773;46921.29618055732;46957.765211173726;47377.28934065992;47442.76278618654;41669.79165104155;42388;42881.35677964833;43202.351964720554;43203.13593728108;8702.216800487733;8769.342299327704;8867.48043133165;9056.728298151065;9196.218321442751;31064.91272805441;31981.840090799396;32413.18967025843;32630.83684581562;32668.673313267514;38205.80897095497;42125.15749684928;42523.36214956716;43158.13683726371;43429;10643.467826608483;11101.666949991513;11214.271072380268;11224.158188136085;11621;12220.327881966221;12517.687057823627;12562.623121306375;12772.552960646333;13206.933965330112;11310.434478276218;11794.469248883992;11809.881901180877;12106.334151621746;12220.450079746255;11219.71950701239;12035.217710848767;12375.69060773488;12439.937800310941;12468.625941221779;7501.544909857821;10494;10827.729306767395;11197.496112675111;11305.830412543983;9444.244460443011;9485.952570237105;9538.332316737762;9779.755506112404;9851.852222216816;9688.903110969082;10093.444860532742;10097.091261786474;10098.091171794575;10111.747206319607 05:20:30 INFO - PROCESS | 28413 | __end_tp_report 05:20:30 INFO - PROCESS | 28413 | __start_cc_report 05:20:30 INFO - PROCESS | 28413 | _x_x_mozilla_cycle_collect,912 05:20:30 INFO - PROCESS | 28413 | __end_cc_report 05:20:30 INFO - PROCESS | 28413 | __startTimestamp1453296030573__endTimestamp 05:20:30 INFO - PROCESS | 28413 | 05:20:30 INFO - PROCESS | 28413 | ------- Summary: start ------- 05:20:30 INFO - PROCESS | 28413 | Number of tests: 6 05:20:30 INFO - PROCESS | 28413 | 05:20:30 INFO - PROCESS | 28413 | [#0] dojo.html Cycles:165 Average:4984.42 Median:5147.51 stddev:529.79 (10.3%) stddev-sans-first:508.94 05:20:30 INFO - PROCESS | 28413 | Values: 3038.2 3050.5 3086.6 3093.5 3117.9 4835.8 4952.0 4952.2 4971.5 4998.1 4975.0 4975.6 5017.7 5019.3 5022.2 4349.2 4513.3 4531.1 4588.5 4728.6 4544.3 4623.5 4623.7 4680.2 4717.8 4552.2 4574.0 4599.1 4625.1 4626.9 4558.2 4560.3 4577.4 4578.3 4650.9 4504.3 4571.1 4577.5 4579.9 4620.7 4792.6 4901.0 4901.8 4904.1 4919.0 5354.6 5356.7 5367.2 5375.8 5390.3 5362.5 5410.9 5421.6 5438.8 5459.4 5054.7 5070.5 5091.9 5098.1 5146.8 5430.2 5436.7 5438.3 5440.3 5441.7 5156.8 5239.2 5261.8 5269.6 5319.2 5317.9 5342.3 5351.5 5353.6 5389.0 5277.1 5294.4 5315.5 5316.6 5362.7 5190.1 5213.9 5270.1 5284.3 5287.1 4160.4 4207.1 4210.0 4213.3 4244.1 3754.9 3765.5 3766.2 3782.8 3803.2 4929.4 4984.1 4990.0 5023.9 5038.1 5358.3 5435.6 5486.9 5498.6 5520.3 4971.9 4986.5 4986.7 4987.4 5021.4 4562.6 4600.3 4602.5 4605.4 4639.8 5466.7 5544.3 5550.9 5551.3 5558.8 5404.9 5408.6 5427.6 5427.7 5430.7 5562.1 5591.6 5608.4 5615.1 5668.2 5225.1 5265.7 5289.3 5318.3 5346.2 5322.1 5352.7 5353.5 5357.9 5373.3 5135.8 5230.5 5231.7 5232.6 5272.6 5142.2 5165.5 5181.4 5281.6 5300.0 5133.2 5137.9 5147.5 5149.4 5218.8 5174.2 5239.2 5243.3 5243.6 5247.1 5069.2 5076.0 5132.4 5147.8 5157.1 05:20:30 INFO - PROCESS | 28413 | 05:20:30 INFO - PROCESS | 28413 | [#1] ext.html Cycles:180 Average:45406.67 Median:20479.92 stddev:73834.84 (360.5%) stddev-sans-first:73965.09 05:20:30 INFO - PROCESS | 28413 | Values: 531.6 532.9 539.1 553.8 587.2 31387.4 31948.4 31950.0 36958.6 37508.0 40516.6 41138.8 41161.2 41211.6 41263.8 8395.4 8593.5 8601.4 8612.4 8629.2 8335.1 8485.2 8502.6 8551.7 8555.7 8508.0 8665.2 8665.9 8668.2 8668.3 8666.5 8752.9 8757.3 8759.9 8763.6 8505.7 8632.3 8647.9 8649.1 8654.2 40265.4 40341.8 40710.6 40724.6 40783.4 3214.6 3401.4 3463.3 3480.6 3735.8 29860.7 30550.4 30583.8 30607.5 30632.4 3945.8 4082.8 4110.9 4132.4 4189.3 201591.0 201976.0 202580.0 202853.0 202932.0 52990.0 54247.5 59450.0 59968.4 61567.4 60561.4 60989.4 61506.7 61606.1 61726.7 14752.2 14955.1 14996.9 15027.8 15050.8 9803.0 10061.7 10895.9 11050.6 11129.7 19851.6 19960.3 19991.9 19994.7 20034.0 7171.3 7378.6 7418.6 7436.4 7451.4 921.4 951.4 960.3 1002.1 1139.0 29130.6 29605.9 29665.9 29852.3 30032.0 1004.7 1019.3 1054.1 1094.8 1117.0 12859.3 13910.9 13982.7 15964.0 16895.6 321528.0 322958.0 323130.0 323802.0 324960.0 54643.7 55103.4 55334.4 55486.4 56015.4 1286.9 1304.3 1311.4 1317.5 1319.4 29654.9 30514.8 30854.1 31214.7 31348.4 48221.3 48509.0 48586.8 48628.3 48711.0 285142.0 309244.0 311122.0 311214.0 311765.0 26629.7 32491.7 33057.3 33136.3 33420.3 38262.6 38739.8 39009.6 39123.0 39706.0 32867.0 33236.7 33386.7 34057.1 34240.0 35777.6 40777.6 41944.8 43283.8 46600.5 35947.6 36687.0 36824.4 37065.6 37224.1 35428.3 38241.0 40422.8 40598.2 40634.0 28847.6 29464.3 29991.6 31267.0 31622.7 05:20:30 INFO - PROCESS | 28413 | 05:20:30 INFO - PROCESS | 28413 | [#2] jquery.html Cycles:180 Average:27247.11 Median:4423.69 stddev:87014.50 (1967.0%) stddev-sans-first:87235.18 05:20:30 INFO - PROCESS | 28413 | Values: 359.9 361.1 367.6 369.3 370.5 13418.6 13610.9 15613.5 16855.8 18060.4 15957.3 16127.4 16670.8 16679.6 16689.3 5297.7 5504.5 5512.2 5512.4 5519.1 3999.8 4141.5 5356.4 5470.1 5774.2 5674.1 5909.6 5945.4 5959.3 5959.5 5835.9 5887.4 5889.2 5889.5 5890.3 4934.7 5132.1 5136.5 5203.5 5206.5 18340.3 18409.4 18620.3 19164.5 19173.4 1976.4 2059.4 2133.2 2134.5 2276.1 8872.3 9185.9 9439.9 11305.3 12004.0 1790.0 1825.2 1829.9 1839.4 1915.0 54528.5 56869.7 57950.7 58426.0 58767.4 9730.0 10013.6 10050.9 10070.8 10090.0 13279.7 13355.9 13377.5 13382.8 13393.4 7145.2 7188.4 7338.2 7390.9 7422.5 6976.5 6982.7 7001.9 7039.3 7065.6 4401.0 4446.4 4456.3 4474.3 4501.2 1640.7 1711.2 1761.5 1773.6 1806.5 411.7 421.5 878.2 1029.8 1030.7 10161.2 10470.6 10519.4 10676.1 10849.1 453.4 459.3 459.5 460.2 476.7 5870.6 9440.0 9922.4 9952.4 9979.6 513128.0 518218.0 528039.0 548236.0 551895.0 72750.6 74428.6 76032.2 76595.6 76817.6 1108.6 1118.1 1129.7 1131.2 1136.4 15038.5 15117.2 15376.2 15403.8 15478.9 33581.3 33677.5 34000.8 34271.7 34438.6 42385.4 42627.6 43760.0 44619.6 45731.0 6875.9 7247.2 7384.3 7450.9 7607.7 9236.7 10798.9 11043.9 11050.6 11502.9 9455.9 9535.6 9644.3 9821.7 9828.6 10003.4 10071.8 10095.9 10251.9 10295.9 9960.9 10125.0 10253.6 10277.5 10469.4 5803.7 7204.3 7309.6 7417.6 7560.0 9538.7 9724.5 9951.0 10159.3 10166.0 05:20:30 INFO - PROCESS | 28413 | 05:20:30 INFO - PROCESS | 28413 | [#3] mootools.html Cycles:180 Average:5394.43 Median:6199.55 stddev:2769.94 (44.7%) stddev-sans-first:2760.57 05:20:30 INFO - PROCESS | 28413 | Values: 1295.4 1446.2 1452.1 1606.6 1788.9 6872.0 7023.5 7313.2 7482.0 7491.6 7511.4 7528.3 7603.3 7622.2 7625.2 1981.2 2039.4 2210.1 2232.7 2238.3 2233.7 2276.5 2281.1 2284.2 2288.5 2201.7 2213.0 2254.5 2256.9 2261.1 2244.5 2246.0 2260.0 2269.0 2299.0 2251.8 2263.0 2264.2 2267.8 2271.6 7592.8 7604.2 7605.5 7693.8 7701.3 4732.7 4827.9 4860.9 4874.3 4877.5 3115.4 3121.1 3163.4 3202.8 3287.9 992.3 1005.2 1034.5 1041.3 1050.7 10666.9 10671.7 10688.3 10706.5 10730.2 4201.2 4264.1 4279.6 4302.2 4309.2 9168.5 9174.6 9181.1 9194.5 9215.6 4677.1 4703.5 4707.1 4713.8 4717.8 4251.3 4277.3 4285.6 4285.9 4286.2 3375.5 3453.3 3611.6 3623.0 3715.4 1165.5 1173.0 1174.3 1179.5 1182.3 1295.7 1303.0 1324.3 1346.5 1354.1 7226.4 7289.5 7309.2 7312.2 7316.6 1124.7 1131.9 1144.5 1149.7 1162.6 5422.5 5495.5 5500.7 5503.4 5516.3 8945.6 9115.9 9168.1 9267.6 9272.8 9169.6 9191.8 9203.7 9220.2 9243.1 7072.6 7208.6 7238.8 7304.6 7362.3 7213.9 7262.1 7296.2 7300.0 7318.6 8140.8 8314.9 8422.5 8433.7 8434.9 8196.3 8382.8 8442.7 8453.6 8477.4 6787.8 6984.4 6985.2 7020.6 7047.2 6608.9 6684.3 6773.3 6988.3 7397.2 6910.1 6952.1 7053.1 7073.3 7094.6 6773.0 6830.1 6888.2 6901.3 6973.3 7007.0 7069.2 7073.8 7083.5 7104.4 6066.0 6222.8 6258.8 6337.2 6354.5 6176.3 6232.9 6233.2 6241.7 6254.1 05:20:30 INFO - PROCESS | 28413 | 05:20:30 INFO - PROCESS | 28413 | [#4] prototype.html Cycles:180 Average:5239.68 Median:5876.90 stddev:1540.21 (26.2%) stddev-sans-first:1499.59 05:20:30 INFO - PROCESS | 28413 | Values: 319.0 339.7 347.6 348.1 355.3 5755.9 5794.4 5835.6 5872.6 5912.1 5667.1 5792.9 5793.8 5806.0 5813.7 4577.4 4585.2 4593.6 4593.9 4594.0 4372.4 4462.2 4484.8 4575.4 4584.1 4557.9 4563.2 4564.2 4579.2 4583.4 4541.0 4552.4 4565.3 4568.0 4579.7 4036.7 4038.4 4039.8 4047.1 4051.6 5496.9 5578.8 5601.3 5627.9 5703.0 5238.9 5321.6 5322.1 5324.3 5339.5 5890.2 6190.3 6190.3 6213.0 6244.1 4376.3 4379.1 4477.3 4481.1 4499.7 6314.2 6402.7 6450.5 6466.4 6470.1 4568.2 4571.3 4573.7 4577.6 4579.6 4563.6 4641.1 4641.9 4648.8 4669.5 5282.6 5291.9 5295.3 5295.8 5299.2 6242.8 6264.7 6271.5 6271.7 6276.6 1640.0 1656.5 1658.8 1661.2 1665.0 1134.7 1142.1 1144.1 1145.8 1168.0 5865.3 5890.6 5899.6 5901.4 5901.8 6393.2 6393.8 6409.1 6413.2 6416.2 5797.7 5881.2 5884.1 5897.5 5898.3 3405.2 3424.9 3455.6 3461.3 3469.1 6621.3 6632.8 6648.4 6650.7 6653.5 6428.4 6517.8 6524.2 6528.6 6530.8 6422.4 6613.4 6617.4 6641.3 6652.7 6154.1 6351.3 6398.5 6405.5 6413.9 6267.2 6378.0 6388.8 6415.6 6417.7 6660.6 6679.1 6683.1 6686.7 6693.8 4452.6 4522.9 4531.9 4533.1 4542.1 6435.5 6473.7 6487.3 6487.6 6499.7 6292.3 6307.8 6326.4 6326.5 6331.8 6171.1 6283.6 6284.0 6294.7 6309.3 6112.1 6118.9 6125.4 6125.8 6129.3 6331.0 6341.8 6342.4 6348.9 6352.2 6032.1 6160.8 6165.2 6168.0 6170.2 05:20:30 INFO - PROCESS | 28413 | 05:20:30 INFO - PROCESS | 28413 | [#5] yui.html Cycles:180 Average:13181.51 Median:4426.18 stddev:14646.10 (330.9%) stddev-sans-first:14657.24 05:20:30 INFO - PROCESS | 28413 | Values: 710.7 726.2 828.3 832.4 837.5 13171.8 13310.1 13327.7 13334.9 13356.1 12608.9 12669.7 12737.4 12759.5 12763.9 787.5 800.3 802.4 804.7 804.8 652.8 665.9 783.7 787.9 792.1 836.4 838.0 838.2 840.7 844.2 835.1 836.5 838.0 838.9 844.5 507.2 516.7 613.1 620.8 623.7 12953.4 13030.9 13036.2 13046.4 13051.4 12136.8 12497.8 12511.1 12626.3 12708.7 10373.4 10425.0 10428.6 10466.6 10915.6 3578.5 3582.8 3610.6 3611.5 3615.1 47259.8 47341.5 47351.3 47438.8 50634.7 9570.2 9844.7 9857.3 9912.8 9939.4 17523.6 17580.2 17630.6 17698.1 17750.4 7009.5 7127.5 7234.2 7242.4 7293.7 3963.0 4115.2 4146.8 4218.0 4241.8 3048.3 3097.0 3098.4 3106.7 3111.7 562.5 564.1 573.6 575.0 578.4 500.6 585.5 610.1 615.3 635.7 7821.4 8103.5 8117.0 8233.5 8302.5 554.8 584.3 675.3 707.2 712.8 3877.5 4153.7 4373.9 4478.4 4570.7 49405.8 49493.3 49802.8 50003.2 50440.2 46717.8 46921.3 46957.8 47377.3 47442.8 41669.8 42388.0 42881.4 43202.4 43203.1 8702.2 8769.3 8867.5 9056.7 9196.2 31064.9 31981.8 32413.2 32630.8 32668.7 38205.8 42125.2 42523.4 43158.1 43429.0 10643.5 11101.7 11214.3 11224.2 11621.0 12220.3 12517.7 12562.6 12772.6 13206.9 11310.4 11794.5 11809.9 12106.3 12220.5 11219.7 12035.2 12375.7 12439.9 12468.6 7501.5 10494.0 10827.7 11197.5 11305.8 9444.2 9486.0 9538.3 9779.8 9851.9 9688.9 10093.4 10097.1 10098.1 10111.7 05:20:30 INFO - PROCESS | 28413 | -------- Summary: end -------- 05:20:30 INFO - PROCESS | 28413 | 05:20:31 INFO - TEST-INFO | 28413: exit 0 05:20:31 INFO - TEST-OK | dromaeo_css | took 1112349ms 05:20:31 INFO - TEST-START | kraken 05:20:31 INFO - operating with platform_type : linux_ 05:20:31 INFO - Initialising browser for kraken test... 05:20:31 INFO - TEST-INFO | started process 28616 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9Yvnme/profile http://localhost:57033/getInfo.html) 05:20:34 INFO - PROCESS | 28616 | __metrics Screen width/height:1600/1200 05:20:34 INFO - PROCESS | 28616 | colorDepth:24 05:20:34 INFO - PROCESS | 28616 | Browser inner width/height: 1024/697 05:20:34 INFO - PROCESS | 28616 | __metrics 05:20:35 INFO - PROCESS | 28616 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:20:35 INFO - PROCESS | 28616 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:20:36 INFO - TEST-INFO | 28616: exit 0 05:20:36 INFO - Browser initialized. 05:20:36 INFO - Running cycle 1/1 for kraken test... 05:20:36 INFO - TEST-INFO | started process 28697 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9Yvnme/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:48 INFO - PROCESS | 28697 | RSS: Main: 148942848 05:20:48 INFO - PROCESS | 28697 | 05:20:50 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57033/tests/kraken/driver.html?testName=audio-beat-detection) 05:20:51 INFO - PROCESS | 28697 | RSS: Main: 186241024 05:20:51 INFO - PROCESS | 28697 | 05:20:53 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57033/tests/kraken/driver.html?testName=audio-dft) 05:20:54 INFO - PROCESS | 28697 | RSS: Main: 176971776 05:20:54 INFO - PROCESS | 28697 | 05:20:57 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57033/tests/kraken/driver.html?testName=audio-fft) 05:20:57 INFO - PROCESS | 28697 | RSS: Main: 162545664 05:20:57 INFO - PROCESS | 28697 | 05:20:59 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57033/tests/kraken/driver.html?testName=audio-oscillator) 05:21:00 INFO - PROCESS | 28697 | RSS: Main: 164954112 05:21:00 INFO - PROCESS | 28697 | 05:21:02 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57033/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:21:03 INFO - PROCESS | 28697 | RSS: Main: 165957632 05:21:03 INFO - PROCESS | 28697 | 05:21:06 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57033/tests/kraken/driver.html?testName=imaging-darkroom) 05:21:06 INFO - PROCESS | 28697 | RSS: Main: 165740544 05:21:06 INFO - PROCESS | 28697 | 05:21:10 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57033/tests/kraken/driver.html?testName=imaging-desaturate) 05:21:10 INFO - PROCESS | 28697 | RSS: Main: 166744064 05:21:10 INFO - PROCESS | 28697 | 05:21:13 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57033/tests/kraken/driver.html?testName=json-parse-financial) 05:21:13 INFO - PROCESS | 28697 | RSS: Main: 166875136 05:21:13 INFO - PROCESS | 28697 | 05:21:15 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57033/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:21:16 INFO - PROCESS | 28697 | RSS: Main: 178315264 05:21:16 INFO - PROCESS | 28697 | 05:21:17 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57033/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:21:18 INFO - PROCESS | 28697 | RSS: Main: 175480832 05:21:18 INFO - PROCESS | 28697 | 05:21:20 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57033/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:21:21 INFO - PROCESS | 28697 | RSS: Main: 190472192 05:21:21 INFO - PROCESS | 28697 | 05:21:23 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:21:24 INFO - PROCESS | 28697 | RSS: Main: 195416064 05:21:24 INFO - PROCESS | 28697 | 05:21:26 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:21:27 INFO - PROCESS | 28697 | RSS: Main: 193904640 05:21:27 INFO - PROCESS | 28697 | 05:21:28 INFO - PROCESS | 28697 | Cycle 1(1): loaded http://localhost:57033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57033/tests/kraken/driver.html?testName=ai-astar) 05:21:29 INFO - PROCESS | 28697 | RSS: Main: 251150336 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | __start_tp_report 05:21:29 INFO - PROCESS | 28697 | _x_x_mozilla_page_load 05:21:29 INFO - PROCESS | 28697 | _x_x_mozilla_page_load_details 05:21:29 INFO - PROCESS | 28697 | |i|pagename|runs| 05:21:29 INFO - PROCESS | 28697 | |0;ai-astar;110;111;107;110;111;111;111;111;104;111 05:21:29 INFO - PROCESS | 28697 | |1;audio-beat-detection;153;129;158;172;128;157;158;141;172;127 05:21:29 INFO - PROCESS | 28697 | |2;audio-dft;164;165;162;164;166;165;166;164;165;166 05:21:29 INFO - PROCESS | 28697 | |3;audio-fft;76;73;95;94;74;73;73;102;96;74 05:21:29 INFO - PROCESS | 28697 | |4;audio-oscillator;99;97;138;95;96;96;139;97;96;146 05:21:29 INFO - PROCESS | 28697 | |5;imaging-gaussian-blur;109;110;110;109;110;109;109;110;109;110 05:21:29 INFO - PROCESS | 28697 | |6;imaging-darkroom;149;147;147;149;145;147;145;147;147;147 05:21:29 INFO - PROCESS | 28697 | |7;imaging-desaturate;96;96;96;96;97;96;96;96;96;96 05:21:29 INFO - PROCESS | 28697 | |8;json-parse-financial;56;56;56;56;57;54;57;57;56;54 05:21:29 INFO - PROCESS | 28697 | |9;json-stringify-tinderbox;69;70;69;69;70;71;69;69;70;70 05:21:29 INFO - PROCESS | 28697 | |10;stanford-crypto-aes;82;84;82;83;83;85;83;84;85;87 05:21:29 INFO - PROCESS | 28697 | |11;stanford-crypto-ccm;119;121;122;119;113;119;117;121;114;122 05:21:29 INFO - PROCESS | 28697 | |12;stanford-crypto-pbkdf2;135;150;147;144;148;133;144;146;146;145 05:21:29 INFO - PROCESS | 28697 | |13;stanford-crypto-sha256-iterative;68;71;68;67;66;67;69;68;68;73 05:21:29 INFO - PROCESS | 28697 | __end_tp_report 05:21:29 INFO - PROCESS | 28697 | __start_cc_report 05:21:29 INFO - PROCESS | 28697 | _x_x_mozilla_cycle_collect,939 05:21:29 INFO - PROCESS | 28697 | __end_cc_report 05:21:29 INFO - PROCESS | 28697 | __startTimestamp1453296089178__endTimestamp 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | ------- Summary: start ------- 05:21:29 INFO - PROCESS | 28697 | Number of tests: 14 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:2.36 (2.1%) stddev-sans-first:2.50 05:21:29 INFO - PROCESS | 28697 | Values: 110.0 111.0 107.0 110.0 111.0 111.0 111.0 111.0 104.0 111.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:157.50 stddev:17.28 (11.0%) stddev-sans-first:18.28 05:21:29 INFO - PROCESS | 28697 | Values: 153.0 129.0 158.0 172.0 128.0 157.0 158.0 141.0 172.0 127.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:1.25 (0.8%) stddev-sans-first:1.30 05:21:29 INFO - PROCESS | 28697 | Values: 164.0 165.0 162.0 164.0 166.0 165.0 166.0 164.0 165.0 166.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:12.05 (16.1%) stddev-sans-first:12.51 05:21:29 INFO - PROCESS | 28697 | Values: 76.0 73.0 95.0 94.0 74.0 73.0 73.0 102.0 96.0 74.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.00 stddev:21.58 (22.5%) stddev-sans-first:22.53 05:21:29 INFO - PROCESS | 28697 | Values: 99.0 97.0 138.0 95.0 96.0 96.0 139.0 97.0 96.0 146.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:21:29 INFO - PROCESS | 28697 | Values: 109.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.33 (0.9%) stddev-sans-first:1.20 05:21:29 INFO - PROCESS | 28697 | Values: 149.0 147.0 147.0 149.0 145.0 147.0 145.0 147.0 147.0 147.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:21:29 INFO - PROCESS | 28697 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.10 (2.0%) stddev-sans-first:1.17 05:21:29 INFO - PROCESS | 28697 | Values: 56.0 56.0 56.0 56.0 57.0 54.0 57.0 57.0 56.0 54.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 05:21:29 INFO - PROCESS | 28697 | Values: 69.0 70.0 69.0 69.0 70.0 71.0 69.0 69.0 70.0 70.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.55 (1.8%) stddev-sans-first:1.50 05:21:29 INFO - PROCESS | 28697 | Values: 82.0 84.0 82.0 83.0 83.0 85.0 83.0 84.0 85.0 87.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:120.00 stddev:3.16 (2.6%) stddev-sans-first:3.35 05:21:29 INFO - PROCESS | 28697 | Values: 119.0 121.0 122.0 119.0 113.0 119.0 117.0 121.0 114.0 122.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.80 Median:146.00 stddev:5.49 (3.8%) stddev-sans-first:4.82 05:21:29 INFO - PROCESS | 28697 | Values: 135.0 150.0 147.0 144.0 148.0 133.0 144.0 146.0 146.0 145.0 05:21:29 INFO - PROCESS | 28697 | 05:21:29 INFO - PROCESS | 28697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:2.07 (3.0%) stddev-sans-first:2.19 05:21:29 INFO - PROCESS | 28697 | Values: 68.0 71.0 68.0 67.0 66.0 67.0 69.0 68.0 68.0 73.0 05:21:29 INFO - PROCESS | 28697 | -------- Summary: end -------- 05:21:29 INFO - PROCESS | 28697 | 05:21:30 INFO - TEST-INFO | 28697: exit 0 05:21:30 INFO - TEST-OK | kraken | took 58857ms 05:21:30 INFO - TEST-START | v8_7 05:21:30 INFO - operating with platform_type : linux_ 05:21:30 INFO - Initialising browser for v8_7 test... 05:21:30 INFO - TEST-INFO | started process 28947 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXLUba5/profile http://localhost:57033/getInfo.html) 05:21:34 INFO - PROCESS | 28947 | __metrics Screen width/height:1600/1200 05:21:34 INFO - PROCESS | 28947 | colorDepth:24 05:21:34 INFO - PROCESS | 28947 | Browser inner width/height: 1024/697 05:21:34 INFO - PROCESS | 28947 | __metrics 05:21:34 INFO - PROCESS | 28947 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:21:34 INFO - PROCESS | 28947 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:21:35 INFO - TEST-INFO | 28947: exit 0 05:21:35 INFO - Browser initialized. 05:21:35 INFO - Running cycle 1/1 for v8_7 test... 05:21:35 INFO - TEST-INFO | started process 29030 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXLUba5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:46 INFO - PROCESS | 29030 | RSS: Main: 149237760 05:21:46 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:57033/tests/v8_7/run.html (next: http://localhost:57033/tests/v8_7/run.html) 05:22:09 INFO - PROCESS | 29030 | RSS: Main: 541593600 05:22:09 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | __start_tp_report 05:22:09 INFO - PROCESS | 29030 | _x_x_mozilla_page_load 05:22:09 INFO - PROCESS | 29030 | _x_x_mozilla_page_load_details 05:22:09 INFO - PROCESS | 29030 | |i|pagename|runs| 05:22:09 INFO - PROCESS | 29030 | |0;Richards;166.75004168751042 05:22:09 INFO - PROCESS | 29030 | |1;DeltaBlue;190.76688286913392 05:22:09 INFO - PROCESS | 29030 | |2;Encrypt;280.58361391694723 05:22:09 INFO - PROCESS | 29030 | |3;Decrypt;5278.9473684210525 05:22:09 INFO - PROCESS | 29030 | |4;RayTrace;1992.03187250996 05:22:09 INFO - PROCESS | 29030 | |5;Earley;795.0754567116759 05:22:09 INFO - PROCESS | 29030 | |6;Boyer;12575 05:22:09 INFO - PROCESS | 29030 | |7;RegExp;43106.382978723406 05:22:09 INFO - PROCESS | 29030 | |8;Splay;568.5048322910744 05:22:09 INFO - PROCESS | 29030 | |9;NavierStokes;4835.748792270531 05:22:09 INFO - PROCESS | 29030 | __end_tp_report 05:22:09 INFO - PROCESS | 29030 | __startTimestamp1453296129556__endTimestamp 05:22:09 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | ------- Summary: start ------- 05:22:09 INFO - PROCESS | 29030 | Number of tests: 10 05:22:09 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | [#0] Richards Cycles:1 Average:166.75 Median:166.75 stddev:0.00 (0.0%) 05:22:09 INFO - PROCESS | 29030 | Values: 166.8 05:22:09 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | [#1] DeltaBlue Cycles:1 Average:190.77 Median:190.77 stddev:0.00 (0.0%) 05:22:09 INFO - PROCESS | 29030 | Values: 190.8 05:22:09 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 05:22:09 INFO - PROCESS | 29030 | Values: 280.6 05:22:09 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | [#3] Decrypt Cycles:1 Average:5278.95 Median:5278.95 stddev:0.00 (0.0%) 05:22:09 INFO - PROCESS | 29030 | Values: 5278.9 05:22:09 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 05:22:09 INFO - PROCESS | 29030 | Values: 1992.0 05:22:09 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | [#5] Earley Cycles:1 Average:795.08 Median:795.08 stddev:0.00 (0.0%) 05:22:09 INFO - PROCESS | 29030 | Values: 795.1 05:22:09 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | [#6] Boyer Cycles:1 Average:12575.00 Median:12575.00 stddev:0.00 (0.0%) 05:22:09 INFO - PROCESS | 29030 | Values: 12575.0 05:22:09 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | [#7] RegExp Cycles:1 Average:43106.38 Median:43106.38 stddev:0.00 (0.0%) 05:22:09 INFO - PROCESS | 29030 | Values: 43106.4 05:22:09 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | [#8] Splay Cycles:1 Average:568.50 Median:568.50 stddev:0.00 (0.0%) 05:22:09 INFO - PROCESS | 29030 | Values: 568.5 05:22:09 INFO - PROCESS | 29030 | 05:22:09 INFO - PROCESS | 29030 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:22:09 INFO - PROCESS | 29030 | Values: 4835.7 05:22:09 INFO - PROCESS | 29030 | -------- Summary: end -------- 05:22:09 INFO - PROCESS | 29030 | 05:22:10 INFO - TEST-INFO | 29030: exit 0 05:22:10 INFO - TEST-OK | v8_7 | took 40283ms 05:22:10 INFO - SUITE-END | took 1211s 05:22:10 INFO - Completed test suite (00:20:11) 05:22:10 INFO - Working with test: dromaeo_css 05:22:10 INFO - Generating results file: dromaeo_css 05:22:10 INFO - Working with test: kraken 05:22:10 INFO - Generating results file: kraken 05:22:10 INFO - javascript benchmark 05:22:10 INFO - Working with test: v8_7 05:22:10 INFO - Generating results file: v8_7 05:22:10 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:22:10 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:22:10 INFO - process_Request line: dromaeo_css 6744.36 graph.html#tests=[[72,64,35]] 05:22:10 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:22:10 INFO - process_Request line: kraken 1509.70 graph.html#tests=[[232,64,35]] 05:22:10 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:22:10 INFO - process_Request line: v8_7 18857.34 graph.html#tests=[[230,64,35]] 05:22:10 INFO - RETURN: dromaeo_css: 6744.36 05:22:10 INFO - RETURN: kraken: 1509.70 05:22:10 INFO - RETURN: v8_7: 18857.34 05:22:10 INFO - javascript benchmark 05:22:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3038.2404398900276, 3050.496668049772, 3086.6141732283463, 3093.505039193728, 3117.922051948701, 4835.782389792459, 4951.950480495194, 4952.23240397738, 4971.477994810542, 4998.10034193845, 4974.97512512437, 4975.577075948549, 5017.673851199669, 5019.272205530196, 5022.196448568221, 4349.195398851207, 4513.277875539914, 4531.053858568953, 4588.49526552079, 4728.621710263188, 4544.318352247156, 4623.537646235383, 4623.74569398683, 4680.1809683305455, 4717.764111794414, 4552.157850797596, 4573.977130114361, 4599.08018396322, 4625.121226966866, 4626.8611941641975, 4558.156741002925, 4560.338750881104, 4577.404937358122, 4578.267477203632, 4650.883727906796, 4504.324351347292, 4571.062932098912, 4577.473590537064, 4579.885502862422, 4620.699654522446, 4792.640551958617, 4900.995295964319, 4901.828436004758, 4904.068227036852, 4919.040787046527, 5354.625176237665, 5356.6518176318805, 5367.221752845854, 5375.784968601251, 5390.272313237702, 5362.544183744387, 5410.945890541084, 5421.620486565942, 5438.809641662523, 5459.372172200208, 5054.696718196883, 5070.518300761421, 5091.87270318245, 5098.082345177866, 5146.8198613048735, 5430.239766432703, 5436.728163591804, 5438.265834112344, 5440.319960004999, 5441.727913604304, 5156.793728250828, 5239.214117882349, 5261.789528418897, 5269.631125821233, 5319.175527793198, 5317.867053323698, 5342.332208473941, 5351.518363347317, 5353.598480114007, 5388.973055134699, 5277.1292736698015, 5294.391145018295, 5315.548178404879, 5316.574674026068, 5362.651427657268, 5190.11767999441, 5213.921791173136, 5270.051390749625, 5284.339457567804, 5287.07476191665, 4160.43834082395, 4207.053412982054, 4209.97895010523, 4213.2837417639075, 4244.129953359554, 3754.887353379403, 3765.548134223911, 3766.1714422826935, 3782.8108594570162, 3803.1823158021157, 4929.359183306219, 4984.102861484967, 4989.952110056929, 5023.899522009539, 5038.118329292359, 5358.33020872391, 5435.565154787608, 5486.945130548644, 5498.560115190855, 5520.309961254843, 4971.850844474671, 4986.4514903360605, 4986.650934434628, 4987.426445958761, 5021.447640759514, 4562.612177964844, 4600.2869555218995, 4602.539746025371, 4605.378273933044, 4639.8144074237325, 5466.6993315367245, 5544.251526044013, 5550.861228469321, 5551.306086739158, 5558.805441809517, 5404.891902162013, 5408.648437851527, 5427.6200665953, 5427.701476418835, 5430.728463576726, 5562.137868630369, 5591.580631452739, 5608.38307786135, 5615.101583746581, 5668.178114173505, 5225.085610018155, 5265.6840589564745, 5289.338832645919, 5318.335208098988, 5346.198070289488, 5322.148456246982, 5352.705601191972, 5353.544948679406, 5357.866053348697, 5373.301470808769, 5135.768890399866, 5230.476952304739, 5231.712255825966, 5232.5552328052545, 5272.578193744414, 5142.151544995184, 5165.483451654804, 5181.35233095863, 5281.630285879952, 5300.0, 5133.153029750049, 5137.897242055213, 5147.510986456281, 5149.433562308218, 5218.817341393033, 5174.249733788655, 5239.187925871496, 5243.344581927259, 5243.55429788457, 5247.134222853187, 5069.188929771219, 5075.974620127024, 5132.43543210254, 5147.768350424165, 5157.123289040797], "unit": "score", "name": "dojo.html", "value": 4951.872290160692}, {"lowerIsBetter": false, "replicates": [531.6358294568221, 532.8960852633738, 539.1293061705347, 553.7923278770461, 587.2248631806018, 31387.372252554964, 31948.36103277936, 31950.0, 36958.63041369592, 37508.0, 40516.59483405165, 41138.79430602843, 41161.17677646453, 41211.587884121225, 41263.79368103163, 8395.412321137508, 8593.484390936532, 8601.354898382615, 8612.39713220075, 8629.180227878342, 8335.083140854502, 8485.151484851496, 8502.574871256444, 8551.743447696548, 8555.657773689045, 8507.95746021269, 8665.220130188281, 8665.870011949826, 8668.219860212579, 8668.306535477179, 8666.480011199348, 8752.8687069694, 8757.343199260049, 8759.912400876037, 8763.56182190888, 8505.702300419456, 8632.309415246766, 8647.913520864837, 8649.091845356274, 8654.177853103945, 40265.396019059735, 40341.79829100865, 40710.59289407098, 40724.59275407238, 40783.388249176285, 3214.5981752280964, 3401.353742788887, 3463.255400088993, 3480.564929383827, 3735.7758534488016, 29860.701392986008, 30550.388992220254, 30583.847080764677, 30607.540886886716, 30632.38735225283, 3945.842166313344, 4082.81627326771, 4110.876673699764, 4132.40080188371, 4189.2668782963165, 201591.0, 201975.99012004992, 202580.0, 202853.0, 202932.0, 52990.0, 54247.45752542503, 59450.0, 59968.400315997154, 61567.38432615706, 60561.394386055574, 60989.39010609926, 61506.692466538276, 61606.075908860505, 61726.69136654288, 14752.18862962526, 14955.102693838404, 14996.850031499764, 15027.849721502645, 15050.774238386433, 9803.0, 10061.748456288651, 10895.945520272347, 11050.557977680963, 11129.721756956142, 19851.602967940562, 19960.3013894513, 19991.901255305453, 19994.70007949882, 20034.0, 7171.318724721144, 7378.5941773202985, 7418.591977441185, 7436.405087593088, 7451.366633836076, 921.3780698028804, 951.3768481644533, 960.2941837749248, 1002.1131298800468, 1138.9886101139048, 29130.563041554393, 29605.851970740438, 29665.947311368167, 29852.253693657833, 30032.0, 1004.7186787699455, 1019.2661283875598, 1054.093479607537, 1094.8412480190327, 1116.994704765701, 12859.292738899263, 13910.930445347709, 13982.650433739034, 15964.0, 16895.577610559834, 321528.0, 322958.0, 323130.0, 323802.0, 324960.0, 54643.72678136584, 55103.44896551063, 55334.44665553293, 55486.44513554894, 56015.43984560184, 1286.8777466140702, 1304.2500562176597, 1311.4295281552554, 1317.5125203674702, 1319.3930791835862, 29654.851725741235, 30514.847425762728, 30854.074377768702, 31214.687853121177, 31348.373032538766, 48221.27668085052, 48509.0, 48586.75706621444, 48628.27057594068, 48711.0, 285142.0, 309244.0, 311122.0, 311214.0, 311765.0, 26629.671291088613, 32491.675083248865, 33057.33885322232, 33136.33727325392, 33420.33159336751, 38262.6173738259, 38739.80630096832, 39009.609903901735, 39123.0, 39706.0, 32867.0, 33236.66763332432, 33386.66613333835, 34057.148571284924, 34240.0, 35777.64222357743, 40777.59222407738, 41944.79027604842, 43283.783581081894, 46600.53399465962, 35947.640523594426, 36687.0, 36824.44763328606, 37065.62934370622, 37224.06939826526, 35428.29143417169, 38241.0, 40422.79788601038, 40598.1880362397, 40634.0, 28847.56728649114, 29464.263393415335, 29991.55012674768, 31267.0, 31622.683773161974], "unit": "score", "name": "ext.html", "value": 18467.32238946755}, {"lowerIsBetter": false, "replicates": [359.9352116619009, 361.0810487309798, 367.5772861209609, 369.33519664603716, 370.54608105071276, 13418.597442076752, 13610.931945340259, 15613.453529126482, 16855.83144168558, 18060.367887123954, 15957.281922313494, 16127.43553975611, 16670.83329166708, 16679.583010424714, 16689.33242670295, 5297.708626025567, 5504.504594586487, 5512.200730894018, 5512.4211957744465, 5519.061759500894, 3999.7800120993334, 4141.503019637647, 5356.437574054727, 5470.124780035195, 5774.220480235156, 5674.148877668362, 5909.556783241253, 5945.37573554777, 5959.314678811948, 5959.52323814096, 5835.854103647422, 5887.381824908409, 5889.1755154278435, 5889.528837692974, 5890.3226128995075, 4934.654574179809, 5132.050570644443, 5136.460671629462, 5203.531682148625, 5206.453322401131, 18340.266389344542, 18409.355672551395, 18620.348287809862, 19164.520886977938, 19173.424797256106, 1976.377441106047, 2059.3513043391285, 2133.210712036541, 2134.5197330600645, 2276.10094012864, 8872.290216782707, 9185.908140918638, 9439.905600943972, 11305.265157764801, 12004.0, 1790.0, 1825.1604262039477, 1829.9359522416785, 1839.4297767692058, 1914.9904250478799, 54528.45471545273, 56869.715651421895, 57950.71024644892, 58426.0, 58767.41232587662, 9730.0, 10013.64952226683, 10050.949745251228, 10070.848937265946, 10090.0, 13279.73440531184, 13355.933220334031, 13377.46490140403, 13382.799258011137, 13393.397297121654, 7145.214026457085, 7188.424926005907, 7338.192798792129, 7390.889136662954, 7422.480426370103, 6976.4767642426, 6982.685779139951, 7001.92998070023, 7039.296070392919, 7065.57606543609, 4400.955990440055, 4446.421965144576, 4456.286994080931, 4474.306482495218, 4501.234790085693, 1640.704673158819, 1711.2213942656062, 1761.5155832146263, 1773.6009397885373, 1806.494181629146, 411.67889046543746, 421.5278887645856, 878.2447095497866, 1029.8197815382277, 1030.6907927621683, 10161.237907156992, 10470.581176752998, 10519.368837869752, 10676.0925321347, 10849.132069434427, 453.41735869408313, 459.27434653247786, 459.53127809633986, 460.16709755342936, 476.73302950347914, 5870.559708021916, 9440.0, 9922.355046922072, 9952.402855828674, 9979.60081596728, 513128.0, 518218.0, 528039.0, 548236.0, 551895.0, 72750.63624681842, 74428.62785686037, 76032.23967760362, 76595.61702191453, 76817.61591192009, 1108.6009036746764, 1118.1390329446444, 1129.711923459529, 1131.196850236325, 1136.4033882211904, 15038.54884353471, 15117.244137793286, 15376.154311512973, 15403.768943465633, 15478.9226053869, 33581.328373431905, 33677.49483757795, 34000.82999584986, 34271.65728342784, 34438.55614438536, 42385.36421953735, 42627.5737242636, 43760.0, 44619.55380446154, 45731.0, 6875.89686154698, 7247.202807691256, 7384.298491643285, 7450.925490745023, 7607.695692172251, 9236.676716314896, 10798.946005270238, 11043.944780276368, 11050.613228537284, 11502.88497115018, 9455.905440945502, 9535.618575256913, 9644.276679248944, 9821.656242031495, 9828.557714902703, 10003.449810260505, 10071.798564028824, 10095.949520252352, 10251.948740256252, 10295.897041029493, 9960.908209276133, 10125.038121378751, 10253.641122560675, 10277.486125693835, 10469.371837689763, 5803.65178089316, 7204.3155900189395, 7309.561426314438, 7417.629118544159, 7559.962200188964, 9538.713838584854, 9724.465154416575, 9951.0, 10159.339642923187, 10166.0], "unit": "score", "name": "jquery.html", "value": 7880.970802674092}, {"lowerIsBetter": false, "replicates": [1295.4494339905539, 1446.2190417174727, 1452.1287227663404, 1606.6304749907522, 1788.9284428622855, 6871.965640171805, 7023.543469674474, 7313.232110628387, 7481.962590187041, 7491.625418729069, 7511.399088072954, 7528.322450979411, 7603.31570158687, 7622.199669034755, 7625.237476252372, 1981.2273213446767, 2039.388183544938, 2210.149092599349, 2232.7320721513443, 2238.3061251012236, 2233.6761169630395, 2276.499170182557, 2281.0533628544217, 2284.166279308049, 2288.5079707862806, 2201.6917631531596, 2212.966805497919, 2254.4589298568308, 2256.9322920312416, 2261.050358849279, 2244.5062086340977, 2245.9663105053437, 2259.9661005084936, 2269.0470002598868, 2299.0344055496566, 2251.752307246202, 2262.9773702263096, 2264.1509433962265, 2267.773222677719, 2271.5797577448225, 7592.810179745496, 7604.201558836353, 7605.467617266793, 7693.807654808618, 7701.3453856422275, 4732.692374995614, 4827.927581086286, 4860.902781944376, 4874.293227481995, 4877.5366340197625, 3115.376924615063, 3121.1335062861567, 3163.3673265346793, 3202.823844688541, 3287.8985539843943, 992.3450522655013, 1005.1657124586576, 1034.4827586206898, 1041.2763129624914, 1050.7373156710823, 10666.893331066667, 10671.679849604525, 10688.305260158142, 10706.518206680641, 10730.19523535738, 4201.159768046403, 4264.104538047045, 4279.636230920407, 4302.161078589707, 4309.159713855768, 9168.541572921327, 9174.633014679339, 9181.081891810765, 9194.49430281341, 9215.585298661576, 4677.111348843709, 4703.529647035338, 4707.082118986765, 4713.764311784397, 4717.8112875485285, 4251.256030194703, 4277.294246449301, 4285.635720963691, 4285.935710964338, 4286.185624731291, 3375.476801095834, 3453.32660131272, 3611.602723700391, 3622.9818850905576, 3715.368387374153, 1165.516310731054, 1172.9941350293193, 1174.277819141222, 1179.4869231884159, 1182.261086820737, 1295.6825577733516, 1302.9609111726663, 1324.2716505921705, 1346.4883344329091, 1354.065694670674, 7226.385757210696, 7289.5261807982315, 7309.232530584212, 7312.23221561739, 7316.561006339637, 1124.6569796212234, 1131.8924702153283, 1144.5364627325946, 1149.689583812366, 1162.616336608917, 5422.511973922287, 5495.477929596762, 5500.669959802424, 5503.422140675251, 5516.310461192351, 8945.642174313085, 9115.908840911507, 9168.129027742354, 9267.629294828132, 9272.814543709088, 9169.633214671472, 9191.816163676689, 9203.677871274473, 9220.170184683411, 9243.121903419164, 7072.575645461289, 7208.639568021578, 7238.782836514913, 7304.634768261566, 7362.263773622702, 7213.891791623025, 7262.092238470192, 7296.160941491797, 7299.963500182465, 7318.634068296457, 8140.75577732669, 8314.916850831414, 8422.452540584842, 8433.704820331259, 8434.915650843413, 8196.34429245647, 8382.790430239293, 8442.746717598482, 8453.577321133796, 8477.406581539233, 6787.796366109024, 6984.371406573433, 6985.1617805863625, 7020.613866237406, 7047.189573199148, 6608.933910660832, 6684.331566843277, 6773.254941956479, 6988.266232045562, 7397.223291554309, 6910.067140935909, 6952.061471701458, 7053.083099197277, 7073.328033836778, 7094.574325540484, 6773.0, 6830.112085428863, 6888.207856096613, 6901.309869013259, 6973.3375329343635, 7007.0, 7069.187043490065, 7073.752418665322, 7083.5041547091205, 7104.360607545345, 6065.969670151621, 6222.782202622887, 6258.843528911813, 6337.207849018872, 6354.52341074412, 6176.320604733386, 6232.906506402498, 6233.158523599256, 6241.687915604292, 6254.061890716247], "unit": "score", "name": "mootools.html", "value": 4459.445798983115}, {"lowerIsBetter": false, "replicates": [318.9505626627872, 339.7316120264991, 347.6054677940538, 348.1418303880933, 355.3213362477667, 5755.884882302352, 5794.449527294911, 5835.649861008337, 5872.5889187756875, 5912.113183022549, 5667.149927510865, 5792.913106303398, 5793.826185214451, 5806.042003069499, 5813.651180929147, 4577.359169716243, 4585.197590421662, 4593.563611456923, 4593.931091033637, 4593.977030114845, 4372.3878656988045, 4462.1968045751755, 4484.798184081707, 4575.359449677047, 4584.060267645142, 4557.931631025537, 4563.224251877172, 4564.1556312082375, 4579.152856721501, 4583.404157459526, 4541.023679908819, 4552.430946131733, 4565.292379681155, 4568.040711450582, 4579.740571342874, 4036.6770658347264, 4038.353863381845, 4039.798010099513, 4047.0691740899756, 4051.5948405159543, 5496.917546236809, 5578.804741834057, 5601.29983752031, 5627.943720562824, 5703.0, 5238.947610523884, 5321.627486075976, 5322.1484562470205, 5324.254604355393, 5339.5461385782255, 5890.2342695449315, 6190.288116866573, 6190.3190649028575, 6213.03697926822, 6244.094606282109, 4376.277914144162, 4379.058502421963, 4477.261251893434, 4481.148581769454, 4499.707519011254, 6314.179156709644, 6402.743890244385, 6450.4839612830865, 6466.35336466359, 6470.09418681385, 4568.246239370533, 4571.337156112345, 4573.679842410999, 4577.5880170784785, 4579.633629309647, 4563.566461186182, 4641.071785642885, 4641.883952901205, 4648.767561621973, 4669.486356500782, 5282.577393808486, 5291.9206211906085, 5295.258663787073, 5295.788168473295, 5299.178627312773, 6242.812715618538, 6264.655443950626, 6271.4669253114, 6271.717772700239, 6276.560640755103, 1639.959001024984, 1656.5113291579014, 1658.7677725118492, 1661.2358315175154, 1664.991675041617, 1134.6993046842592, 1142.1433924556582, 1144.0504381363448, 1145.8052131137727, 1167.9532818687157, 5865.266841644794, 5890.646561206341, 5899.646021238739, 5901.380355062656, 5901.822945311562, 6393.1688880445245, 6393.840153996094, 6409.102725618417, 6413.230412350548, 6416.165898433173, 5797.681127538026, 5881.206037184926, 5884.0585506318785, 5897.52819774417, 5898.3216930053595, 3405.1997780521556, 3424.9143771405415, 3455.6026057003264, 3461.3077384523194, 3469.098034511045, 6621.33786621334, 6632.801015969529, 6648.40164385198, 6650.733970641217, 6653.4677225821815, 6428.357164283534, 6517.771877984248, 6524.249711283168, 6528.575642583217, 6530.8367290818105, 6422.389872962061, 6613.371729685672, 6617.404433600903, 6641.302663220389, 6652.733890644514, 6154.076888466587, 6351.301356850835, 6398.488120950406, 6405.519586030973, 6413.903791443226, 6267.2165979252595, 6377.9795232762535, 6388.776392826228, 6415.647139407378, 6417.679116044085, 6660.56706314088, 6679.098321726699, 6683.131192944886, 6686.665666716742, 6693.799186024427, 4452.5992660660695, 4522.909541809211, 4531.912341038193, 4533.138703646297, 4542.114287713864, 6435.485161187187, 6473.741050357933, 6487.286398496256, 6487.643179625166, 6499.675016249074, 6292.3078461368295, 6307.810765677037, 6326.367363263821, 6326.462250708557, 6331.841703957438, 6171.105189747551, 6283.560150789401, 6283.96858015707, 6294.748210071729, 6309.2744334400295, 6112.052631842072, 6118.908216376669, 6125.418085281891, 6125.754969801158, 6129.295131059986, 6330.968345158245, 6341.778037768656, 6342.429181373698, 6348.93651063502, 6352.237731472253, 6032.095185722177, 6160.845978850564, 6165.198524191826, 6168.0, 6170.167027451236], "unit": "score", "name": "prototype.html", "value": 4748.243711462772}, {"lowerIsBetter": false, "replicates": [710.6588837358069, 726.2193142371945, 828.3331917806164, 832.3965125284168, 837.484946757744, 13171.802422963652, 13310.068295219338, 13327.733445331087, 13334.866651333496, 13356.06507544471, 12608.93695531521, 12669.683257918558, 12737.363131843416, 12759.489620415172, 12763.872361276384, 787.4881327137364, 800.2717527050386, 802.4463120446902, 804.666063583615, 804.8229389534293, 652.781318258384, 665.8967859981686, 783.725696006399, 787.9330256928168, 792.1326147868075, 836.4270474724833, 837.9539125348103, 838.1702114906229, 840.7267638017638, 844.1642773654099, 835.1106072033265, 836.4521238588734, 837.9622916968782, 838.8657814749641, 844.4933040175907, 507.19356223604643, 516.6693316277585, 613.1201725523888, 620.770314983459, 623.7317953280087, 12953.417096230598, 13030.934845325713, 13036.152650077809, 13046.41291141901, 13051.412686429134, 12136.817947730791, 12497.812532812015, 12511.124221304512, 12626.30555319457, 12708.745825083539, 10373.429461379621, 10425.0, 10428.634997775118, 10466.581336746598, 10915.563377464892, 3578.499010138583, 3582.802945837978, 3610.6208848070837, 3611.458281257806, 3615.096225943514, 47259.76370118162, 47341.526584734056, 47351.28973065407, 47438.762806186096, 50634.746826266004, 9570.186534144537, 9844.655437059668, 9857.309988300893, 9912.752181195528, 9939.353941993748, 17523.649527009387, 17580.208890599955, 17630.559236019202, 17698.115094245237, 17750.37873674415, 7009.544379615309, 7127.4654400920135, 7234.204237533867, 7242.420606351479, 7293.671784769698, 3962.980185099114, 4115.176964607031, 4146.834126634961, 4217.957820421757, 4241.809118589671, 3048.2531779713668, 3096.9535456968165, 3098.4422803895063, 3106.6893310669207, 3111.6732743062107, 562.4937556199371, 564.0552075273899, 573.58988323349, 575.0454245951784, 578.3637998202029, 500.6220303670705, 585.5169485174748, 610.087918561753, 615.3446579392933, 635.6503922842418, 7821.374290056782, 8103.517186250976, 8117.0, 8233.547154906537, 8302.54336011525, 554.841870067037, 584.2813339592325, 675.3246753246754, 707.2291202589203, 712.8431745016088, 3877.4959255297194, 4153.709240353146, 4373.934390984138, 4478.41780568524, 4570.65720070996, 49405.75297123563, 49493.257601136014, 49802.750986244835, 50003.249951250764, 50440.243396349084, 46717.76641116773, 46921.29618055732, 46957.765211173726, 47377.28934065992, 47442.76278618654, 41669.79165104155, 42388.0, 42881.35677964833, 43202.351964720554, 43203.13593728108, 8702.216800487733, 8769.342299327704, 8867.48043133165, 9056.728298151065, 9196.218321442751, 31064.91272805441, 31981.840090799396, 32413.18967025843, 32630.83684581562, 32668.673313267514, 38205.80897095497, 42125.15749684928, 42523.36214956716, 43158.13683726371, 43429.0, 10643.467826608483, 11101.666949991513, 11214.271072380268, 11224.158188136085, 11621.0, 12220.327881966221, 12517.687057823627, 12562.623121306375, 12772.552960646333, 13206.933965330112, 11310.434478276218, 11794.469248883992, 11809.881901180877, 12106.334151621746, 12220.450079746255, 11219.71950701239, 12035.217710848767, 12375.69060773488, 12439.937800310941, 12468.625941221779, 7501.544909857821, 10494.0, 10827.729306767395, 11197.496112675111, 11305.830412543983, 9444.244460443011, 9485.952570237105, 9538.332316737762, 9779.755506112404, 9851.852222216816, 9688.903110969082, 10093.444860532742, 10097.091261786474, 10098.091171794575, 10111.747206319607], "unit": "score", "name": "yui.html", "value": 6166.500790143016}], "name": "dromaeo_css", "value": 6744.361391957286}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 110.0, 111.0, 111.0, 111.0, 111.0, 104.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [153.0, 129.0, 158.0, 172.0, 128.0, 157.0, 158.0, 141.0, 172.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 162.0, 164.0, 166.0, 165.0, 166.0, 164.0, 165.0, 166.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 95.0, 94.0, 74.0, 73.0, 73.0, 102.0, 96.0, 74.0], "unit": "score", "name": "audio-fft", "value": 83.0}, {"lowerIsBetter": true, "replicates": [99.0, 97.0, 138.0, 95.0, 96.0, 96.0, 139.0, 97.0, 96.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 147.0, 149.0, 145.0, 147.0, 145.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 56.0, 56.0, 57.0, 54.0, 57.0, 57.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 70.0, 71.0, 69.0, 69.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 82.0, 83.0, 83.0, 85.0, 83.0, 84.0, 85.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [119.0, 121.0, 122.0, 119.0, 113.0, 119.0, 117.0, 121.0, 114.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [135.0, 150.0, 147.0, 144.0, 148.0, 133.0, 144.0, 146.0, 146.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.8}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 68.0, 67.0, 66.0, 67.0, 69.0, 68.0, 68.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1509.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.75004168751042], "unit": "score", "name": "Richards", "value": 211.70609399999992}, {"lowerIsBetter": false, "replicates": [190.76688286913392], "unit": "score", "name": "DeltaBlue", "value": 346.59055600000005}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5278.9473684210525], "unit": "score", "name": "Decrypt", "value": 50.423120638085756}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [795.0754567116759], "unit": "score", "name": "Earley", "value": 838.2386783216788}, {"lowerIsBetter": false, "replicates": [12575.0], "unit": "score", "name": "Boyer", "value": 52.99904572564615}, {"lowerIsBetter": false, "replicates": [43106.382978723406], "unit": "score", "name": "RegExp", "value": 21.133413129318836}, {"lowerIsBetter": false, "replicates": [568.5048322910744], "unit": "score", "name": "Splay", "value": 143.34266900000006}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 18857.33524783012}]} 05:22:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18857.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1509.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6744.36"}}} 05:22:10 INFO - Return code: 0 05:22:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:22:10 INFO - # TBPL SUCCESS # 05:22:10 INFO - Running post-action listener: _resource_record_post_action 05:22:10 INFO - Running post-run listener: _resource_record_post_run 05:22:11 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 539394048; Read time: 0; Write time: 423404 05:22:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237195264; Read time: 0; Write time: 253676 05:22:11 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 302198784; Read time: 0; Write time: 169728 05:22:11 INFO - Running post-run listener: _upload_blobber_files 05:22:11 INFO - Blob upload gear active. 05:22:11 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:22:11 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 05:22:11 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'] 05:22:11 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 05:22:12 INFO - (blobuploader) - INFO - Open directory for files ... 05:22:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:22:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:22:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:13 INFO - (blobuploader) - INFO - Done attempting. 05:22:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:22:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:22:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:14 INFO - (blobuploader) - INFO - Done attempting. 05:22:14 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:14 INFO - Return code: 0 05:22:14 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:22:14 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f54b39da0597f6c11e5ec63edec6a511b4a2d9954319c7f5f78c5e620517510c0e47577394e80a937b1d889b08135b0ee4ad66e56effe7255d0c2cf2f259072", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eff05222265503a09d0122988bc9ff2dacbe1ef42002c682e8ef436a47ca9e49fc7a429454c761397f5789ea72ce3f7bf2f32de18652c90073d383e2b8dae8c4"} 05:22:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:22:14 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:22:14 INFO - Contents: 05:22:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f54b39da0597f6c11e5ec63edec6a511b4a2d9954319c7f5f78c5e620517510c0e47577394e80a937b1d889b08135b0ee4ad66e56effe7255d0c2cf2f259072", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eff05222265503a09d0122988bc9ff2dacbe1ef42002c682e8ef436a47ca9e49fc7a429454c761397f5789ea72ce3f7bf2f32de18652c90073d383e2b8dae8c4"} 05:22:14 INFO - Running post-run listener: copy_logs_to_upload_dir 05:22:14 INFO - Copying logs to upload dir... 05:22:14 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:22:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.490750 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-20 05:22:14.069096) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 05:22:14.072428) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663 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/0f54b39da0597f6c11e5ec63edec6a511b4a2d9954319c7f5f78c5e620517510c0e47577394e80a937b1d889b08135b0ee4ad66e56effe7255d0c2cf2f259072", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eff05222265503a09d0122988bc9ff2dacbe1ef42002c682e8ef436a47ca9e49fc7a429454c761397f5789ea72ce3f7bf2f32de18652c90073d383e2b8dae8c4"} build_url:https://queue.taskcluster.net/v1/task/QRpxVfGhR5G8uEuubq3isg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/QRpxVfGhR5G8uEuubq3isg/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/0f54b39da0597f6c11e5ec63edec6a511b4a2d9954319c7f5f78c5e620517510c0e47577394e80a937b1d889b08135b0ee4ad66e56effe7255d0c2cf2f259072", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eff05222265503a09d0122988bc9ff2dacbe1ef42002c682e8ef436a47ca9e49fc7a429454c761397f5789ea72ce3f7bf2f32de18652c90073d383e2b8dae8c4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 05:22:14.098449) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:22:14.098930) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453294866.119751-566875663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:22:14.184095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 05:22:14.184482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 05:22:14.184865) ========= ========= Total master_lag: 0.28 =========