builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1452732651.42 results: success (0) buildid: 20160113143020 builduid: daa50ea7148d465f9426fe98e4c1a363 revision: 8d44035ebdd6e764015d668d3e9a7908ff2a5264 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.424955) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.425493) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.425919) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006345 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.453969) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.454657) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.469765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.470398) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.526101) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.526816) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.527615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.528276) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 16:50:52-- 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% 12.8M=0.001s 2016-01-13 16:50:52 (12.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159962 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.705050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.705782) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018966 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.758158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:51.758989) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 8d44035ebdd6e764015d668d3e9a7908ff2a5264 --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/b2g-inbound --rev 8d44035ebdd6e764015d668d3e9a7908ff2a5264 --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=5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 16:50:52,694 truncating revision to first 12 chars 2016-01-13 16:50:52,694 Setting DEBUG logging. 2016-01-13 16:50:52,694 attempt 1/10 2016-01-13 16:50:52,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/8d44035ebdd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 16:50:52,998 unpacking tar archive at: b2g-inbound-8d44035ebdd6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628455 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:52.405790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:52.406121) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:52.416764) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:52.417421) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 16:50:52.418386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-13 16:50:52.419145) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:50:53 INFO - MultiFileLogger online at 20160113 16:50:53 in /builds/slave/test-pgo 16:50:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 16:50:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:50:53 INFO - {'append_to_log': False, 16:50:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:50:53 INFO - 'blob_upload_branch': 'B2G-Inbound', 16:50:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:50:53 INFO - 'branch': 'B2G-Inbound', 16:50:53 INFO - 'buildbot_json_path': 'buildprops.json', 16:50:53 INFO - 'config_files': ('talos/linux_config.py',), 16:50:53 INFO - 'default_actions': ('clobber', 16:50:53 INFO - 'read-buildbot-config', 16:50:53 INFO - 'download-and-extract', 16:50:53 INFO - 'populate-webroot', 16:50:53 INFO - 'create-virtualenv', 16:50:53 INFO - 'install', 16:50:53 INFO - 'run-tests'), 16:50:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:50:53 INFO - 'download_minidump_stackwalk': True, 16:50:53 INFO - 'download_symbols': 'ondemand', 16:50:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:50:53 INFO - 'tooltool.py': '/tools/tooltool.py', 16:50:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:50:53 INFO - '/tools/misc-python/virtualenv.py')}, 16:50:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:50:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:50:53 INFO - 'installer_path': 'installer.exe', 16:50:53 INFO - 'log_level': 'info', 16:50:53 INFO - 'log_name': 'talos', 16:50:53 INFO - 'log_to_console': True, 16:50:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:50:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:50:53 INFO - 'opt_config_files': (), 16:50:53 INFO - 'pip_index': False, 16:50:53 INFO - 'sps_profile': False, 16:50:53 INFO - 'sps_profile_interval': 0, 16:50:53 INFO - 'suite': 'dromaeojs', 16:50:53 INFO - 'system_bits': '32', 16:50:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:50:53 INFO - 'title': 'talos-linux64-ix-011', 16:50:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:50:53 INFO - 'use_talos_json': True, 16:50:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:50:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:50:53 INFO - 'work_dir': 'build'} 16:50:53 INFO - ##### 16:50:53 INFO - ##### Running clobber step. 16:50:53 INFO - ##### 16:50:53 INFO - Running pre-action listener: _resource_record_pre_action 16:50:53 INFO - Running main action method: clobber 16:50:53 INFO - rmtree: /builds/slave/test-pgo/build 16:50:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:50:53 INFO - Running post-action listener: _resource_record_post_action 16:50:53 INFO - ##### 16:50:53 INFO - ##### Running read-buildbot-config step. 16:50:53 INFO - ##### 16:50:53 INFO - Running pre-action listener: _resource_record_pre_action 16:50:53 INFO - Running main action method: read_buildbot_config 16:50:53 INFO - Using buildbot properties: 16:50:53 INFO - { 16:50:53 INFO - "project": "", 16:50:53 INFO - "product": "firefox", 16:50:53 INFO - "script_repo_revision": "production", 16:50:53 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 16:50:53 INFO - "repository": "", 16:50:53 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 16:50:53 INFO - "buildid": "20160113143020", 16:50:53 INFO - "pgo_build": "True", 16:50:53 INFO - "basedir": "/builds/slave/test-pgo", 16:50:53 INFO - "buildnumber": 15, 16:50:53 INFO - "slavename": "talos-linux64-ix-011", 16:50:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:50:53 INFO - "platform": "ubuntu64_hw", 16:50:53 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 16:50:53 INFO - "branch": "b2g-inbound", 16:50:53 INFO - "repo_path": "integration/b2g-inbound", 16:50:53 INFO - "revision": "8d44035ebdd6e764015d668d3e9a7908ff2a5264", 16:50:53 INFO - "stage_platform": "linux64-pgo", 16:50:53 INFO - "builduid": "daa50ea7148d465f9426fe98e4c1a363", 16:50:53 INFO - "slavebuilddir": "test" 16:50:53 INFO - } 16:50:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:50:53 INFO - Running post-action listener: _resource_record_post_action 16:50:53 INFO - ##### 16:50:53 INFO - ##### Running download-and-extract step. 16:50:53 INFO - ##### 16:50:53 INFO - Running pre-action listener: _resource_record_pre_action 16:50:53 INFO - Running main action method: download_and_extract 16:50:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:50:53 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')]} 16:50:53 INFO - https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:50:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/test_packages.json 16:50:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/test_packages.json 16:50:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:50:55 INFO - Downloaded 1448 bytes. 16:50:55 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:50:55 INFO - Using the following test package requirements: 16:50:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:50:55 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:50:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:55 INFO - u'jsshell-linux-x86_64.zip'], 16:50:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:50:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:50:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:50:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:50:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:50:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:50:55 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')]} 16:50:55 INFO - https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:50:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/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 16:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/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 16:51:04 INFO - Downloaded 24028986 bytes. 16:51:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:51:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:51:05 INFO - Return code: 0 16:51:05 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 16:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:05 INFO - https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:51:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/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 16:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/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 16:51:08 INFO - Downloaded 24028986 bytes. 16:51:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:51:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:51:10 INFO - Return code: 0 16:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:10 INFO - https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:51:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:51:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:51:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/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 16:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/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 16:51:12 INFO - Downloaded 11132279 bytes. 16:51:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:51:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:51:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:51:13 INFO - Return code: 0 16:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:13 INFO - https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:51:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/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 16:51:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTGycgKkQCuIAuqMtscXng/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 16:51:18 INFO - Downloaded 55882871 bytes. 16:51:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:18 INFO - mkdir: /builds/slave/test-pgo/properties 16:51:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:51:18 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:51:18 INFO - Contents: 16:51:18 INFO - build_url:https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:18 INFO - Running post-action listener: _resource_record_post_action 16:51:18 INFO - Running post-action listener: set_extra_try_arguments 16:51:18 INFO - ##### 16:51:18 INFO - ##### Running populate-webroot step. 16:51:18 INFO - ##### 16:51:18 INFO - Running pre-action listener: _resource_record_pre_action 16:51:18 INFO - Running main action method: populate_webroot 16:51:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:51:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:51:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:51:18 INFO - '--tppagecycles', 16:51:18 INFO - '7'], 16:51:18 INFO - 'tests': ['tsvgm']}}, 16:51:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:51:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:51:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:51:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:51:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:51:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:51:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:18 INFO - 'talos_options': ['--e10s'], 16:51:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:18 INFO - 'tests': ['damp', 'tps']}, 16:51:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:18 INFO - 'talos_options': ['--e10s'], 16:51:18 INFO - 'tests': ['damp', 'tps']}, 16:51:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:51:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:51:18 INFO - 'other': {'tests': ['a11yr', 16:51:18 INFO - 'ts_paint', 16:51:18 INFO - 'tpaint', 16:51:18 INFO - 'sessionrestore', 16:51:18 INFO - 'sessionrestore_no_auto_restore']}, 16:51:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:51:18 INFO - 'tests': ['a11yr', 16:51:18 INFO - 'ts_paint', 16:51:18 INFO - 'tpaint', 16:51:18 INFO - 'sessionrestore', 16:51:18 INFO - 'sessionrestore_no_auto_restore']}, 16:51:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:51:18 INFO - 'tests': ['a11yr', 16:51:18 INFO - 'ts_paint', 16:51:18 INFO - 'tpaint', 16:51:18 INFO - 'sessionrestore', 16:51:18 INFO - 'sessionrestore_no_auto_restore']}, 16:51:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:51:18 INFO - 'tests': ['a11yr', 16:51:18 INFO - 'ts_paint', 16:51:18 INFO - 'tpaint', 16:51:18 INFO - 'sessionrestore', 16:51:18 INFO - 'sessionrestore_no_auto_restore']}, 16:51:18 INFO - 'other_l64': {'tests': ['a11yr', 16:51:18 INFO - 'ts_paint', 16:51:18 INFO - 'tpaint', 16:51:18 INFO - 'sessionrestore', 16:51:18 INFO - 'sessionrestore_no_auto_restore']}, 16:51:18 INFO - 'other_nol64': {'tests': ['a11yr', 16:51:18 INFO - 'ts_paint', 16:51:18 INFO - 'tpaint', 16:51:18 INFO - 'sessionrestore', 16:51:18 INFO - 'sessionrestore_no_auto_restore']}, 16:51:18 INFO - 'svgr': {'tests': ['tsvgx', 16:51:18 INFO - 'tsvgr_opacity', 16:51:18 INFO - 'tart', 16:51:18 INFO - 'tscrollx', 16:51:18 INFO - 'cart']}, 16:51:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:51:18 INFO - 'tests': ['tsvgx', 16:51:18 INFO - 'tsvgr_opacity', 16:51:18 INFO - 'tart', 16:51:18 INFO - 'tscrollx', 16:51:18 INFO - 'cart']}, 16:51:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:18 INFO - 'tests': ['tp5o']}, 16:51:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:18 INFO - 'talos_options': ['--e10s'], 16:51:18 INFO - 'tests': ['tp5o']}, 16:51:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:18 INFO - 'talos_options': ['--xperf_path', 16:51:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:18 INFO - 'tests': ['tp5n']}, 16:51:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:18 INFO - 'talos_options': ['--e10s', 16:51:18 INFO - '--xperf_path', 16:51:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:18 INFO - 'tests': ['tp5n']}}, 16:51:18 INFO - 'talos.zip': {'path': '', 16:51:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:51:18 INFO - Running post-action listener: _resource_record_post_action 16:51:18 INFO - ##### 16:51:18 INFO - ##### Running create-virtualenv step. 16:51:18 INFO - ##### 16:51:18 INFO - Running pre-action listener: _resource_record_pre_action 16:51:18 INFO - Running main action method: create_virtualenv 16:51:18 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:51:18 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 16:51:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:51:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:51:18 INFO - Using real prefix '/usr' 16:51:18 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:51:19 INFO - Installing distribute.............................................................................................................................................................................................done. 16:51:21 INFO - Installing pip.................done. 16:51:21 INFO - Return code: 0 16:51:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74f30b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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 0x14666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1466b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', '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 16:51:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:51:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:51:21 INFO - Using env: {'DISPLAY': ':0', 16:51:21 INFO - 'HOME': '/home/cltbld', 16:51:21 INFO - 'LANG': 'en_US.UTF-8', 16:51:21 INFO - 'LANGUAGE': 'en_US:en', 16:51:21 INFO - 'LOGNAME': 'cltbld', 16:51:21 INFO - 'MAIL': '/var/mail/cltbld', 16:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:21 INFO - 'MOZ_NO_REMOTE': '1', 16:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:21 INFO - 'NO_EM_RESTART': '1', 16:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:21 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:21 INFO - 'SHELL': '/bin/bash', 16:51:21 INFO - 'SHLVL': '1', 16:51:21 INFO - 'TERM': 'linux', 16:51:21 INFO - 'TMOUT': '86400', 16:51:21 INFO - 'USER': 'cltbld', 16:51:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', 16:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:21 INFO - '_': '/tools/buildbot/bin/python'} 16:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:21 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 16:51:21 INFO - Cleaning up... 16:51:21 INFO - Return code: 0 16:51:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f74f30b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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 0x14666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1466b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', '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 16:51:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:51:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:51:21 INFO - Using env: {'DISPLAY': ':0', 16:51:21 INFO - 'HOME': '/home/cltbld', 16:51:21 INFO - 'LANG': 'en_US.UTF-8', 16:51:21 INFO - 'LANGUAGE': 'en_US:en', 16:51:21 INFO - 'LOGNAME': 'cltbld', 16:51:21 INFO - 'MAIL': '/var/mail/cltbld', 16:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:21 INFO - 'MOZ_NO_REMOTE': '1', 16:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:21 INFO - 'NO_EM_RESTART': '1', 16:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:21 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:21 INFO - 'SHELL': '/bin/bash', 16:51:21 INFO - 'SHLVL': '1', 16:51:21 INFO - 'TERM': 'linux', 16:51:21 INFO - 'TMOUT': '86400', 16:51:21 INFO - 'USER': 'cltbld', 16:51:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', 16:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:21 INFO - '_': '/tools/buildbot/bin/python'} 16:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:21 INFO - Downloading/unpacking psutil>=0.7.1 16:51:21 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 16:51:21 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 16:51:21 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 16:51:21 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 16:51:21 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 16:51:21 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 16:51:23 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:51:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:51:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:51:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:23 INFO - Installing collected packages: psutil 16:51:23 INFO - Running setup.py install for psutil 16:51:23 INFO - building 'psutil._psutil_linux' extension 16:51:23 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 16:51: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:51:24 INFO - building 'psutil._psutil_posix' extension 16:51:24 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 16:51:24 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 16:51:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:24 INFO - Successfully installed psutil 16:51:24 INFO - Cleaning up... 16:51:24 INFO - Return code: 0 16:51:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f74f30b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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 0x14666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1466b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', '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 16:51:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:51:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:51:24 INFO - Using env: {'DISPLAY': ':0', 16:51:24 INFO - 'HOME': '/home/cltbld', 16:51:24 INFO - 'LANG': 'en_US.UTF-8', 16:51:24 INFO - 'LANGUAGE': 'en_US:en', 16:51:24 INFO - 'LOGNAME': 'cltbld', 16:51:24 INFO - 'MAIL': '/var/mail/cltbld', 16:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:24 INFO - 'MOZ_NO_REMOTE': '1', 16:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:24 INFO - 'NO_EM_RESTART': '1', 16:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:24 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:24 INFO - 'SHELL': '/bin/bash', 16:51:24 INFO - 'SHLVL': '1', 16:51:24 INFO - 'TERM': 'linux', 16:51:24 INFO - 'TMOUT': '86400', 16:51:24 INFO - 'USER': 'cltbld', 16:51:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', 16:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:24 INFO - '_': '/tools/buildbot/bin/python'} 16:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:51:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:51:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:51:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:51:26 INFO - Installing collected packages: mozsystemmonitor 16:51:26 INFO - Running setup.py install for mozsystemmonitor 16:51:26 INFO - Successfully installed mozsystemmonitor 16:51:26 INFO - Cleaning up... 16:51:26 INFO - Return code: 0 16:51:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74f30b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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 0x14666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1466b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', '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 16:51:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:51:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:51:26 INFO - Using env: {'DISPLAY': ':0', 16:51:26 INFO - 'HOME': '/home/cltbld', 16:51:26 INFO - 'LANG': 'en_US.UTF-8', 16:51:26 INFO - 'LANGUAGE': 'en_US:en', 16:51:26 INFO - 'LOGNAME': 'cltbld', 16:51:26 INFO - 'MAIL': '/var/mail/cltbld', 16:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:26 INFO - 'MOZ_NO_REMOTE': '1', 16:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:26 INFO - 'NO_EM_RESTART': '1', 16:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:26 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:26 INFO - 'SHELL': '/bin/bash', 16:51:26 INFO - 'SHLVL': '1', 16:51:26 INFO - 'TERM': 'linux', 16:51:26 INFO - 'TMOUT': '86400', 16:51:26 INFO - 'USER': 'cltbld', 16:51:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', 16:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:26 INFO - '_': '/tools/buildbot/bin/python'} 16:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:26 INFO - Downloading/unpacking blobuploader==1.2.4 16:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:28 INFO - Downloading blobuploader-1.2.4.tar.gz 16:51:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:51:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:51:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:51:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:51:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:28 INFO - Downloading docopt-0.6.1.tar.gz 16:51:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:51:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:51:29 INFO - Installing collected packages: blobuploader, requests, docopt 16:51:29 INFO - Running setup.py install for blobuploader 16:51:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:51:29 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:51:29 INFO - Running setup.py install for requests 16:51:29 INFO - Running setup.py install for docopt 16:51:29 INFO - Successfully installed blobuploader requests docopt 16:51:29 INFO - Cleaning up... 16:51:29 INFO - Return code: 0 16:51:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74f30b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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 0x14666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1466b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', '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 16:51:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:51:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:51:29 INFO - Using env: {'DISPLAY': ':0', 16:51:29 INFO - 'HOME': '/home/cltbld', 16:51:29 INFO - 'LANG': 'en_US.UTF-8', 16:51:29 INFO - 'LANGUAGE': 'en_US:en', 16:51:29 INFO - 'LOGNAME': 'cltbld', 16:51:29 INFO - 'MAIL': '/var/mail/cltbld', 16:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:29 INFO - 'MOZ_NO_REMOTE': '1', 16:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:29 INFO - 'NO_EM_RESTART': '1', 16:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:29 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:29 INFO - 'SHELL': '/bin/bash', 16:51:29 INFO - 'SHLVL': '1', 16:51:29 INFO - 'TERM': 'linux', 16:51:29 INFO - 'TMOUT': '86400', 16:51:29 INFO - 'USER': 'cltbld', 16:51:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', 16:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:29 INFO - '_': '/tools/buildbot/bin/python'} 16:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:29 INFO - Running setup.py (path:/tmp/pip-zyuimE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:29 INFO - Running setup.py (path:/tmp/pip-27itHQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:29 INFO - Running setup.py (path:/tmp/pip-KNccZe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:30 INFO - Running setup.py (path:/tmp/pip-Nd_IMe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:30 INFO - Running setup.py (path:/tmp/pip-5MDthb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:30 INFO - Running setup.py (path:/tmp/pip-DjGWM2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:30 INFO - Running setup.py (path:/tmp/pip-ANcGFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:30 INFO - Running setup.py (path:/tmp/pip-HycRAs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:30 INFO - Running setup.py (path:/tmp/pip-fz906R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:30 INFO - Running setup.py (path:/tmp/pip-kzHlQ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:30 INFO - Running setup.py (path:/tmp/pip-LWIFYU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:30 INFO - Running setup.py (path:/tmp/pip-gKc02g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:30 INFO - Running setup.py (path:/tmp/pip-wgKGrR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:30 INFO - Running setup.py (path:/tmp/pip-4lO3qy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:30 INFO - Running setup.py (path:/tmp/pip-KFZMeF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:30 INFO - Running setup.py (path:/tmp/pip-gyRppB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:30 INFO - Running setup.py (path:/tmp/pip-wmiKYr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:51:31 INFO - Running setup.py install for manifestparser 16:51:31 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:51:31 INFO - Running setup.py install for mozcrash 16:51:31 INFO - Running setup.py install for mozdebug 16:51:31 INFO - Running setup.py install for mozdevice 16:51:31 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:51:31 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:51:31 INFO - Running setup.py install for mozfile 16:51:31 INFO - Running setup.py install for mozhttpd 16:51:31 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:51:31 INFO - Running setup.py install for mozinfo 16:51:31 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:51:31 INFO - Running setup.py install for mozInstall 16:51:31 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:51:31 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:51:31 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:51:31 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:51:31 INFO - Running setup.py install for mozleak 16:51:31 INFO - Running setup.py install for mozlog 16:51:32 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:51:32 INFO - Running setup.py install for moznetwork 16:51:32 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:51:32 INFO - Running setup.py install for mozprocess 16:51:32 INFO - Running setup.py install for mozprofile 16:51:32 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:51:32 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:51:32 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:51:32 INFO - Running setup.py install for mozrunner 16:51:32 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:51:32 INFO - Running setup.py install for mozscreenshot 16:51:32 INFO - Running setup.py install for moztest 16:51:32 INFO - Running setup.py install for mozversion 16:51:32 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:51:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:51:32 INFO - Cleaning up... 16:51:32 INFO - Return code: 0 16:51:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51:32 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')]} 16:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:32 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')]} 16:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74f30b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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 0x14666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1466b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', '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 16:51:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:51:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:51:32 INFO - Using env: {'DISPLAY': ':0', 16:51:32 INFO - 'HOME': '/home/cltbld', 16:51:32 INFO - 'LANG': 'en_US.UTF-8', 16:51:32 INFO - 'LANGUAGE': 'en_US:en', 16:51:32 INFO - 'LOGNAME': 'cltbld', 16:51:32 INFO - 'MAIL': '/var/mail/cltbld', 16:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:32 INFO - 'MOZ_NO_REMOTE': '1', 16:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:32 INFO - 'NO_EM_RESTART': '1', 16:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:32 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:32 INFO - 'SHELL': '/bin/bash', 16:51:32 INFO - 'SHLVL': '1', 16:51:32 INFO - 'TERM': 'linux', 16:51:32 INFO - 'TMOUT': '86400', 16:51:32 INFO - 'USER': 'cltbld', 16:51:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', 16:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:32 INFO - '_': '/tools/buildbot/bin/python'} 16:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:33 INFO - Running setup.py (path:/tmp/pip-qTD7fC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:33 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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:33 INFO - Running setup.py (path:/tmp/pip-x6XPpP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:33 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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:33 INFO - Running setup.py (path:/tmp/pip-X4Q6_x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:33 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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:33 INFO - Running setup.py (path:/tmp/pip-ddVfpi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:33 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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:33 INFO - Running setup.py (path:/tmp/pip-aKTIBJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:33 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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:33 INFO - Running setup.py (path:/tmp/pip-5gCKvv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:33 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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:33 INFO - Running setup.py (path:/tmp/pip-oY2ALb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:33 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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:33 INFO - Running setup.py (path:/tmp/pip-lBl9Hf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:33 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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:33 INFO - Running setup.py (path:/tmp/pip-kQmXvc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:33 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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:33 INFO - Running setup.py (path:/tmp/pip-dCH9YW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:33 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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:33 INFO - Running setup.py (path:/tmp/pip-UBLP1T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:33 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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:33 INFO - Running setup.py (path:/tmp/pip-JgyRf4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51: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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:33 INFO - Running setup.py (path:/tmp/pip-GI50dr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51: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)) 16:51:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:34 INFO - Running setup.py (path:/tmp/pip-CS7rPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:34 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)) 16:51:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:34 INFO - Running setup.py (path:/tmp/pip-M5KXwQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:34 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)) 16:51:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:34 INFO - Running setup.py (path:/tmp/pip-msLKsE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:34 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)) 16:51:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:34 INFO - Running setup.py (path:/tmp/pip-DcAkog-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:34 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)) 16:51:34 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)) 16:51:34 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)) 16:51:34 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)) 16:51:34 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)) 16:51:34 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)) 16:51:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:51:34 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 16:51:34 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 16:51:34 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 16:51:34 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 16:51:34 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 16:51:34 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 16:51:35 INFO - Downloading blessings-1.5.1.tar.gz 16:51:35 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:51:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:51:36 INFO - Installing collected packages: blessings 16:51:36 INFO - Running setup.py install for blessings 16:51:36 INFO - Successfully installed blessings 16:51:36 INFO - Cleaning up... 16:51:36 INFO - Return code: 0 16:51:36 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:51:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:51:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:51:36 INFO - Reading from file tmpfile_stdout 16:51:36 INFO - Current package versions: 16:51:36 INFO - argparse == 1.2.1 16:51:36 INFO - blessings == 1.5.1 16:51:36 INFO - blobuploader == 1.2.4 16:51:36 INFO - docopt == 0.6.1 16:51:36 INFO - manifestparser == 1.1 16:51:36 INFO - mozInstall == 1.12 16:51:36 INFO - mozcrash == 0.16 16:51:36 INFO - mozdebug == 0.1 16:51:36 INFO - mozdevice == 0.48 16:51:36 INFO - mozfile == 1.2 16:51:36 INFO - mozhttpd == 0.7 16:51:36 INFO - mozinfo == 0.9 16:51:36 INFO - mozleak == 0.1 16:51:36 INFO - mozlog == 3.1 16:51:36 INFO - moznetwork == 0.27 16:51:36 INFO - mozprocess == 0.22 16:51:36 INFO - mozprofile == 0.28 16:51:36 INFO - mozrunner == 6.11 16:51:36 INFO - mozscreenshot == 0.1 16:51:36 INFO - mozsystemmonitor == 0.0 16:51:36 INFO - moztest == 0.7 16:51:36 INFO - mozversion == 1.4 16:51:36 INFO - psutil == 3.1.1 16:51:36 INFO - requests == 1.2.3 16:51:36 INFO - wsgiref == 0.1.2 16:51:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74f30b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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 0x14666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1466b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', '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 16:51:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:51:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:51:36 INFO - Using env: {'DISPLAY': ':0', 16:51:36 INFO - 'HOME': '/home/cltbld', 16:51:36 INFO - 'LANG': 'en_US.UTF-8', 16:51:36 INFO - 'LANGUAGE': 'en_US:en', 16:51:36 INFO - 'LOGNAME': 'cltbld', 16:51:36 INFO - 'MAIL': '/var/mail/cltbld', 16:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:36 INFO - 'MOZ_NO_REMOTE': '1', 16:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:36 INFO - 'NO_EM_RESTART': '1', 16:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:36 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:36 INFO - 'SHELL': '/bin/bash', 16:51:36 INFO - 'SHLVL': '1', 16:51:36 INFO - 'TERM': 'linux', 16:51:36 INFO - 'TMOUT': '86400', 16:51:36 INFO - 'USER': 'cltbld', 16:51:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', 16:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:36 INFO - '_': '/tools/buildbot/bin/python'} 16:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:36 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)) 16:51:36 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)) 16:51:36 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)) 16:51:36 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)) 16:51:36 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)) 16:51:36 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)) 16:51:36 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)) 16:51:36 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)) 16:51:36 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)) 16:51:36 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)) 16:51:36 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)) 16:51:36 INFO - Cleaning up... 16:51:36 INFO - Return code: 0 16:51:36 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74f30b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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 0x14666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1466b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', '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 16:51:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:51:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:51:36 INFO - Using env: {'DISPLAY': ':0', 16:51:36 INFO - 'HOME': '/home/cltbld', 16:51:36 INFO - 'LANG': 'en_US.UTF-8', 16:51:36 INFO - 'LANGUAGE': 'en_US:en', 16:51:36 INFO - 'LOGNAME': 'cltbld', 16:51:36 INFO - 'MAIL': '/var/mail/cltbld', 16:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:36 INFO - 'MOZ_NO_REMOTE': '1', 16:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:36 INFO - 'NO_EM_RESTART': '1', 16:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:36 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:36 INFO - 'SHELL': '/bin/bash', 16:51:36 INFO - 'SHLVL': '1', 16:51:36 INFO - 'TERM': 'linux', 16:51:36 INFO - 'TMOUT': '86400', 16:51:36 INFO - 'USER': 'cltbld', 16:51:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', 16:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:36 INFO - '_': '/tools/buildbot/bin/python'} 16:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:36 INFO - Downloading/unpacking jsonschema 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:51:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 16:51:38 INFO - Downloading/unpacking functools32 (from jsonschema) 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:38 INFO - Downloading functools32-3.2.3-2.tar.gz 16:51:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:51:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:51:38 INFO - warning: no files found matching '*.txt' 16:51:38 INFO - no previously-included directories found matching 'build' 16:51:38 INFO - no previously-included directories found matching 'dist' 16:51:38 INFO - no previously-included directories found matching '.git*' 16:51:38 INFO - Installing collected packages: jsonschema, functools32 16:51:38 INFO - Running setup.py install for functools32 16:51:38 INFO - warning: no files found matching '*.txt' 16:51:38 INFO - no previously-included directories found matching 'build' 16:51:38 INFO - no previously-included directories found matching 'dist' 16:51:38 INFO - no previously-included directories found matching '.git*' 16:51:39 INFO - Successfully installed jsonschema functools32 16:51:39 INFO - Cleaning up... 16:51:39 INFO - Return code: 0 16:51:39 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:51:39 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')]} 16:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:39 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')]} 16:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74f30b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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 0x14666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1466b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', '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 16:51:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:51:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:51:39 INFO - Using env: {'DISPLAY': ':0', 16:51:39 INFO - 'HOME': '/home/cltbld', 16:51:39 INFO - 'LANG': 'en_US.UTF-8', 16:51:39 INFO - 'LANGUAGE': 'en_US:en', 16:51:39 INFO - 'LOGNAME': 'cltbld', 16:51:39 INFO - 'MAIL': '/var/mail/cltbld', 16:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:39 INFO - 'MOZ_NO_REMOTE': '1', 16:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:39 INFO - 'NO_EM_RESTART': '1', 16:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:39 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:39 INFO - 'SHELL': '/bin/bash', 16:51:39 INFO - 'SHLVL': '1', 16:51:39 INFO - 'TERM': 'linux', 16:51:39 INFO - 'TMOUT': '86400', 16:51:39 INFO - 'USER': 'cltbld', 16:51:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', 16:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:39 INFO - '_': '/tools/buildbot/bin/python'} 16:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:39 INFO - Downloading/unpacking flake8 16:51:39 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 16:51:39 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 16:51:39 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 16:51:39 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 16:51:39 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 16:51:39 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 16:51:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:51:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:51:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:51:41 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 16:51:41 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 16:51:41 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 16:51:41 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 16:51:41 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 16:51:41 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 16:51:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:51:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:51:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:51:41 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 16:51:41 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 16:51:41 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 16:51:41 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 16:51:41 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 16:51:41 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 16:51:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 16:51:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:51:41 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 16:51:41 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 16:51:41 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 16:51:41 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 16:51:41 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 16:51:41 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 16:51:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:51:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:51:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:51:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:51:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:51:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:51:41 INFO - no previously-included directories found matching 'docs/_build' 16:51:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:51:41 INFO - Running setup.py install for pep8 16:51:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:51:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:51:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:51:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:51:41 INFO - no previously-included directories found matching 'docs/_build' 16:51:41 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:51:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:51:41 INFO - Cleaning up... 16:51:41 INFO - Return code: 0 16:51:41 INFO - Running post-action listener: _resource_record_post_action 16:51:41 INFO - Running post-action listener: _start_resource_monitoring 16:51:41 INFO - Starting resource monitoring. 16:51:41 INFO - ##### 16:51:41 INFO - ##### Running install step. 16:51:41 INFO - ##### 16:51:41 INFO - Running pre-action listener: _resource_record_pre_action 16:51:41 INFO - Running main action method: install 16:51:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:51:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:51:42 INFO - Reading from file tmpfile_stdout 16:51:42 INFO - Detecting whether we're running mozinstall >=1.0... 16:51:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:51:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:51:42 INFO - Reading from file tmpfile_stdout 16:51:42 INFO - Output received: 16:51:42 INFO - Usage: mozinstall [options] installer 16:51:42 INFO - Options: 16:51:42 INFO - -h, --help show this help message and exit 16:51:42 INFO - -d DEST, --destination=DEST 16:51:42 INFO - Directory to install application into. [default: 16:51:42 INFO - "/builds/slave/test-pgo"] 16:51:42 INFO - --app=APP Application being installed. [default: firefox] 16:51:42 INFO - mkdir: /builds/slave/test-pgo/build/application 16:51:42 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'] 16:51:42 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 16:51:58 INFO - Reading from file tmpfile_stdout 16:51:58 INFO - Output received: 16:51:58 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:51:58 INFO - Running post-action listener: _resource_record_post_action 16:51:58 INFO - ##### 16:51:58 INFO - ##### Running run-tests step. 16:51:58 INFO - ##### 16:51:58 INFO - Running pre-action listener: _resource_record_pre_action 16:51:58 INFO - Running main action method: run_tests 16:51:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:51:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:51:58 INFO - Python 2.7.3 16:51:58 INFO - Return code: 0 16:51:58 INFO - grabbing minidump binary from tooltool 16:51:58 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')]} 16:51:58 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 0x14f9840>, '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 0x14666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1466b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:51:58 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 16:51:58 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 16:51:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:51:58 INFO - Return code: 0 16:51:58 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:51:58 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:51:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:51:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:51:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:51:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:51:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:51:59 INFO - Return code: 0 16:51:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 16:51:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 16:51:59 INFO - Using env: {'DISPLAY': ':0', 16:51:59 INFO - 'HOME': '/home/cltbld', 16:51:59 INFO - 'LANG': 'en_US.UTF-8', 16:51:59 INFO - 'LANGUAGE': 'en_US:en', 16:51:59 INFO - 'LOGNAME': 'cltbld', 16:51:59 INFO - 'MAIL': '/var/mail/cltbld', 16:51:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:51:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:59 INFO - 'MOZ_NO_REMOTE': '1', 16:51:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:59 INFO - 'NO_EM_RESTART': '1', 16:51:59 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:59 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:59 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:51:59 INFO - 'SHELL': '/bin/bash', 16:51:59 INFO - 'SHLVL': '1', 16:51:59 INFO - 'TERM': 'linux', 16:51:59 INFO - 'TMOUT': '86400', 16:51:59 INFO - 'USER': 'cltbld', 16:51:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386', 16:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:59 INFO - '_': '/tools/buildbot/bin/python'} 16:51:59 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 16:51:59 INFO - mozversion application_buildid: 20160113143020 16:51:59 INFO - mozversion application_changeset: 8d44035ebdd6e764015d668d3e9a7908ff2a5264 16:51:59 INFO - mozversion application_display_name: Nightly 16:51:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:51:59 INFO - mozversion application_name: Firefox 16:51:59 INFO - mozversion application_remotingname: firefox 16:51:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 16:51:59 INFO - mozversion application_vendor: Mozilla 16:51:59 INFO - mozversion application_version: 46.0a1 16:51:59 INFO - mozversion platform_buildid: 20160113143020 16:51:59 INFO - mozversion platform_changeset: 8d44035ebdd6e764015d668d3e9a7908ff2a5264 16:51:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 16:51:59 INFO - mozversion platform_version: 46.0a1 16:51:59 INFO - using testdate: 1452732719 16:51:59 INFO - actual date: 1452732719 16:51:59 INFO - starting webserver on 'localhost:35266' 16:51:59 INFO - SUITE-START | Running 3 tests 16:51:59 INFO - TEST-START | dromaeo_css 16:51:59 INFO - operating with platform_type : linux_ 16:51:59 INFO - Initialising browser for dromaeo_css test... 16:51:59 INFO - TEST-INFO | started process 30630 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC8hLr9/profile http://localhost:35266/getInfo.html) 16:52:04 INFO - PROCESS | 30630 | __metrics Screen width/height:1600/1200 16:52:04 INFO - PROCESS | 30630 | colorDepth:24 16:52:04 INFO - PROCESS | 30630 | Browser inner width/height: 1024/697 16:52:04 INFO - PROCESS | 30630 | __metrics 16:52:05 INFO - PROCESS | 30630 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:52:05 INFO - PROCESS | 30630 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:52:06 INFO - TEST-INFO | 30630: exit 0 16:52:06 INFO - Browser initialized. 16:52:06 INFO - Running cycle 1/1 for dromaeo_css test... 16:52:06 INFO - TEST-INFO | started process 30725 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC8hLr9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:52:18 INFO - PROCESS | 30725 | RSS: Main: 150097920 16:52:18 INFO - PROCESS | 30725 | 16:53:09 INFO - PROCESS | 30725 | 1452732789579 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] 16:55:17 INFO - PROCESS | 30725 | Cycle 1(1): loaded http://localhost:35266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35266/tests/dromaeo/cssquery-ext.html) 16:55:18 INFO - PROCESS | 30725 | RSS: Main: 264998912 16:55:18 INFO - PROCESS | 30725 | 16:58:21 INFO - PROCESS | 30725 | Cycle 1(1): loaded http://localhost:35266/tests/dromaeo/cssquery-ext.html (next: http://localhost:35266/tests/dromaeo/cssquery-jquery.html) 16:58:21 INFO - PROCESS | 30725 | RSS: Main: 236474368 16:58:21 INFO - PROCESS | 30725 | 17:01:23 INFO - PROCESS | 30725 | Cycle 1(1): loaded http://localhost:35266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35266/tests/dromaeo/cssquery-mootools.html) 17:01:24 INFO - PROCESS | 30725 | RSS: Main: 246476800 17:01:24 INFO - PROCESS | 30725 | 17:04:26 INFO - PROCESS | 30725 | Cycle 1(1): loaded http://localhost:35266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35266/tests/dromaeo/cssquery-prototype.html) 17:04:26 INFO - PROCESS | 30725 | RSS: Main: 216244224 17:04:26 INFO - PROCESS | 30725 | 17:07:29 INFO - PROCESS | 30725 | Cycle 1(1): loaded http://localhost:35266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35266/tests/dromaeo/cssquery-yui.html) 17:07:30 INFO - PROCESS | 30725 | RSS: Main: 218910720 17:07:30 INFO - PROCESS | 30725 | 17:10:32 INFO - PROCESS | 30725 | Cycle 1(1): loaded http://localhost:35266/tests/dromaeo/cssquery-yui.html (next: http://localhost:35266/tests/dromaeo/cssquery-dojo.html) 17:10:33 INFO - PROCESS | 30725 | RSS: Main: 259522560 17:10:33 INFO - PROCESS | 30725 | 17:10:33 INFO - PROCESS | 30725 | __start_tp_report 17:10:33 INFO - PROCESS | 30725 | _x_x_mozilla_page_load 17:10:33 INFO - PROCESS | 30725 | _x_x_mozilla_page_load_details 17:10:33 INFO - PROCESS | 30725 | |i|pagename|runs| 17:10:33 INFO - PROCESS | 30725 | |0;dojo.html;3067.6778938211487;3092.4124416360874;3132.0916934089114;3140.9791817659266;3153.416617925684;4973.129702302096;4992.425871024833;5022.472640372758;5039.269305950635;5092;5066.822661206858;5100.081985242655;5122.103631864418;5136.2038883972955;5150.510701483362;4468.843590474334;4656.371389862376;4658.09167212392;4682.508336624665;4737.028909073649;4555.74943378114;4687.0625874825;4710.317004034413;4732.195526760442;4791.041791641668;4624.398828152335;4638.257878739402;4680.508546602592;4681.765911704401;4718.150732868083;4631.143238500888;4633.305004249356;4643.535646435364;4673.299005149221;4686.367340409035;4561.863144105682;4642.419697537808;4651.465081515636;4658.627309815207;4684.36761037259;4853.174960256765;4906.705597664151;4962.87592810179;4976.726280054596;5016.44819069902;5493.23094766733;5511.641743286714;5519.558435325164;5522.30971128609;5523.806666766684;5399.865003374908;5534.972325138388;5543.307086614173;5547.805826796042;5549.916751248735;5080.618953578496;5089.440161582223;5094.541491265803;5132.409772876093;5165.767540460688;5610.046292130266;5646.971765141148;5648.378678345379;5650.124230744241;5663.263775709132;5240.423553409122;5442.455754424605;5472.5348345391085;5476;5481.534069604048;5401.081816091274;5433.891322173614;5436.673799572039;5464.28964234647;5483.396826349099;5288;5341.0653135701095;5344;5346.5455436287575;5363.597730170175;5284.471552844685;5295.285136506599;5342.91985620216;5378.542823859937;5416.647917885325;4232.534421213664;4272.530021697611;4300.225959327288;4320.827166913288;4351.9564804352185;3801.676857467091;3805.6194380561724;3819.102510909934;3841.865534706272;3843.8462461501226;5031.572316353077;5043.87390315245;5048.167052436307;5058.367704036996;5087.211482220262;5409.269748583891;5464.9453505465235;5472.616916815785;5494.5054945055135;5509.256250406224;5065.797368105308;5075.746212689351;5078.7460626968505;5081.314022606901;5100.923486147711;4708.246680531167;4711.0342379812055;4712.882177945578;4735.289706543977;4747.264174053027;5536.833894983157;5628.690422026828;5631.577631677641;5631.662100273997;5634.32388113429;5388.946110538845;5396.217548455374;5407.513323800877;5416.295881535375;5455.454454554671;5583.106702927512;5584.246126772834;5587.44125587438;5591.832245032656;5602.775888964396;5340.732963351739;5361.222622719762;5388.892222155613;5424.783008679608;5477.068898287221;5390.595705322195;5428.294321738149;5430.647007944471;5465.180222966586;5467.316585426822;5298.602604804578;5302.734863256745;5306.363236411656;5313.601479888946;5341.866453338697;5180.171172612364;5241.44964778708;5261.237120617566;5272.103742363884;5322.654027488201;5273.419923808455;5275.788968441219;5276.39321478035;5276.39321478035;5285.814996475105;5374.381946076252;5383;5389.919151212656;5393;5433.918491222714;5152.5877929766275;5199.246109314204;5245.0821106307;5257.605679574123;5291.470852914832 17:10:33 INFO - PROCESS | 30725 | |1;ext.html;486.25845585482114;522.2662159665668;523.7590708274194;524.5986820082636;539.1481459294315;27790;28361.85819070907;28391.14826555204;28404;35640.643593564055;39464;39860.60139398605;39876;39919;40070.39894401579;8432.91567084329;8515.318774498057;8603.56982150893;8610.138986101403;8642.351823613222;8296.792580185484;8421.24208821206;8435.114312997139;8444.746657600283;8452.577371131449;8420.410571260014;8513.702020429286;8517.701880434186;8521.829563408728;8700.216980471756;8625.698100566482;8702.869456958151;8711.912880871174;8714.08502107276;8714.477131372074;8547.059823419419;8673.176048275403;8675.392722509427;8693.217610415093;8700.608472618747;39136.41295380572;39469.40795888064;39629;39641.80179099086;39685.20629587421;2568.447783726489;2641.343813589743;2713.2267303818317;3211.6962672863824;3373.6289008209324;29665.406691866043;31771.364572708648;31878.362432751215;32295;32359.83820080908;3660.780900273564;3661.3317722234838;3689.2990331836863;3772.305513868187;3913.3347330953807;273378;279354;280496;280670;280671;53660.46339536633;54781.178282325796;54997;59941.700291498266;61353.69323153445;66990;67949.3205067953;68260.65869670719;68371;68481.31518684849;13164.539241126515;13257.14399984003;13268.203907765565;13274.800877986838;13286.269255190864;9716.222702183808;9990.750231244132;9993.450360230112;11007.394593297286;11253.718657033476;20197.495062623257;20328.186872524933;20417.183312667625;20440.284590039573;20506.487337816674;7969.760907172794;8150.184981501921;8249.586471237859;8433.28317093054;8509.149085091565;895.7223260789176;975.7609385700407;984.3749219245831;990.1830989433602;1117.284937639911;26606.46787064248;26854.194374168805;27053.32366690809;27311.180664580093;27362.589561156597;941.9858702119474;975.6438899801522;984.4044353166374;1017.1811691588342;1144.7996600594863;14020.369083391271;14421.880232517306;14486.420543178156;14567.41730330775;14581;403060;406448;408420;408917;409102;52635;53058;53198;53209.733951329996;53385.1992220117;1072.8229842076125;1077.283606401734;1144.1190283481671;1279.6672865055152;1407.92960351982;24560.631590525798;26115.738842611332;26275.21174364772;26412.339691507867;26472.602910956735;40516.59483405246;41025;41577.79211103925;41628.16743665049;42522.1495570093;189868;395983;404066;404456;406430;32119.357612847143;32880;32882.34235315232;32930;32956;42637.14725705531;43181.56818431775;43187;43623.56376436322;44106;36051;36083.63916360803;36103.45844812383;36135.45796813103;37418;35906.28187436289;36158.11865398138;36345;36871.26257474889;37233.25533489261;35501.467477988364;36502.08744781402;36593.81703091467;36599.63400365962;36603.26793464062;30256.243593909447;32708.672913270562;33175.33649326952;33629.15927101842;33730;24442;25286.620700689873;26480.205593832216;26730;26807.731922680523 17:10:33 INFO - PROCESS | 30725 | |2;jquery.html;355.11753293066727;358.0815208988945;358.256617518649;360.96209897960716;361.2449979542755;13278.269695166762;13716;16117.758233626504;16208.918955405221;16814.579635509104;14193.71612567748;15206.23968801561;15586.610334741637;15602.843971560282;16713.582160445996;5146.5110814472755;5351.331083614548;5352.464753524655;5355.410904800468;5367.838964831061;3952.2490726761966;4064;5223.764930578133;5328.227407025979;5682.488576028157;5743.971280143614;5825.708714564276;5883.823485295448;5885.823425297248;5888.381719919411;5667.603267771257;5704.201411802351;5742.397048309951;5752.856178595548;5762.798302059428;4958.231474121517;5045.167547354718;5052.191649336089;5151.665141765773;5186.896262074775;19909.9004504978;20132.698009529868;20148.697769533468;20161.294354697515;20447.182112715473;2057.8353731701427;2069.689546568027;2075.2321640992777;2093.2568938027084;2205.900734466953;12428.440720167615;12785.936070319589;12793.55222567215;12954.740905181843;13217.273049982246;1713.9742903856452;1727.6717423689458;1741.1642411642356;1774.5120091974682;1785.1431312969717;54459.72770136163;56714.43285567133;56969.71515142439;57151.57060079286;57244.713776431265;10093.646722364681;10127.696169114939;10162.39025658463;10179.847302290324;10195.439250841127;13249.735005300034;13279.601611951657;13313.600591982256;13324.73350532984;13325.067865159497;7138.214796372498;7145.035420218308;7154.177269614061;7206.675699593531;7258;6710.261871194165;6724.260331363546;6755.358240967199;6776.491763117786;6782.1861376635115;4401.735895846259;4453.866384008485;4469.374287599739;4473.3960915276675;4506.211413002711;1701.174930158872;1743.4420985284587;1766.2934826069418;1820.2809890093604;1836.4123480486116;726.4696771356939;841.8232171244107;858.2361698088706;949.7625593601599;952.9231967876394;15776.447824326093;16101.27544260511;16889.15554222284;16913.408030718867;16999.575010624587;857.691231156783;869.6173683579204;891.6299735609779;920.374145580998;965.9130678238852;7307.981346830513;9480.525973701288;9842.950785246172;9843.75390615226;9889.406635601743;504491;511231;514209;521735;541870;59637;74635.25364746392;76819.16579593418;77809.22190778134;78846;1110.245033377311;1124.578283143821;1126.932384056959;1149.609132894803;1150.2408410449232;14073.225972571607;14319.713605727618;14820.184889831164;14894.851051489346;15013.77479337789;31227.84386078146;31837.36325273528;31863.36273274475;32022.839885800422;33301.66698332986;37258.441123383716;37547.624523755505;37633;38194.618053819104;38488.6151138485;7219.772638651547;7331.74338898136;7343.77968660941;7436.219196984239;7471.252874712485;9174.311926605398;10995.120390368911;11245.550177993116;11351.489182986621;11354.375509347065;9471.289653275893;9737.659181928599;9742.31803773729;9968.152707019695;10177.287589868638;9689.612415503583;9962.651307204213;10209.285350025724;10216.387016779017;10275.948620256851;9847.507624618884;9864.309498335047;10011.449370284414;10067.546960386653;10335.276530642783;7365.226651201547;7520.398368130427;7523;7523.586202758682;7557.584332861526;9884.703458896245;10030.297879148682;10085.69742907714;10111.797764044532;10199.847002294822 17:10:33 INFO - PROCESS | 30725 | |3;mootools.html;1287.0540152987546;1404.0733116143347;1416.8545828261263;1417.5322143692579;1484.3246322923071;6295.559310848243;7016.438684905208;7164.641767911609;7165.104361954755;7176.354128128481;7081.645917704107;7260.96369518153;7265.854682906339;7270.418366530678;7276.1268647762345;1890.2816929566745;1932.8260456558908;2150.3011521255576;2189.8576592521476;2214.579229946305;2185.672149177628;2188.6935828983874;2193.7038499802484;2195.9011844467036;2196.077647388093;2136.7970042845905;2215.6233440315104;2229.643257078868;2233.597952368573;2236.6533187355985;2164.2533326002504;2172.120291282033;2173.0330003148606;2229;2231.2079211879714;2142.2502124256384;2181.6618424144285;2198.043850924837;2198.340497850654;2201.8128459081;7341.486095973284;7424.294692004305;7431.108267007994;7438.628068596603;7445.478816482849;4400.559944005606;4495.527969563182;4497.707649002804;4527.683062185615;4530.75080870552;2777.916662500108;2834.8157369770897;2859.985700071507;2875.1949454152873;2933.838638874861;953.4898829126384;954.6944977607169;963.0610155098793;972.2950860626061;975.9756006099833;10048.246381521416;10048.598056077748;10064.29549931505;10069.546870390777;10069.748256293578;3950.506186726659;3988.960110398917;3999.800059981994;4001.7999100045463;4071.1654110907193;8675.522846243392;8697.956510217535;8707.651693932172;8710.12898710124;8710.433821801562;4459.9331010034875;4499.302608095751;4502.5047244803045;4505.391772110788;4505.504394516601;4134.235166494208;4144.647704945053;4145.984233862723;4149.813258403379;4151.543330233671;3248.7888287261253;3317.834108294576;3390.711789497871;3503;3571.499990001402;1131.6491887514733;1156.7050402147568;1159.0727418065683;1159.5187996981158;1163.209017867858;983.8720966274482;1009.8283291840257;1169.7485040716288;1178.3401295274673;1188.8454500914825;6787.898181527281;6845.589264644137;6874.243833178346;6876.484263680244;6879.208890977602;1018.2617602238317;1030;1067.492940853104;1068.369661899483;1076.8869268726828;5142.177251639794;5231.346081739783;5237.921431178535;5246.973765131226;5253.3958594761325;8504.362172837062;8772.95613521941;8789.912100879037;9061.909380906107;9065.637374505079;8684.044755076937;8747.737567872973;8750.34372422071;8764.780880477912;8764.78088047804;6902.5858448492245;6910.619915904573;7017.438604911595;7035.50751447404;7104.857902841914;6865.41643960269;6918.654067296515;6927.168739751262;6928.618925959121;6936.4797640176175;7824.804379890548;7952.801179970547;7963.761087167394;8165.2243036911395;8169.5098294102545;8110.553919534483;8208.302294305051;8285.627146778288;8367.539785311623;8378.413511054412;6556.246031706415;6573.04690819838;6585.6377899216;6646.867062658816;6650.800475985729;6919.308069193041;6970.581765094111;7002.7899163025195;7029.156501219886;7029.648517574203;6322.465662041742;6593.439557637463;6700.195976482853;6784.7964561063245;6797.864042719217;6554.8361290966195;6615.338466153346;6626.701798419179;6695.09616201826;6734.09089772894;6665.900011499734;6722.6638668065425;6723.966380168068;6726.159230096238;6726.5964042155665;5808.82573522795;5865.94134058671;5880.14737863016;5880.794172204123;5914.497267732291;6078.118672792509;6124.418180272867;6127.662978536223;6141.662208578571;6147.938520614915 17:10:33 INFO - PROCESS | 30725 | |4;prototype.html;328.3990297755108;332.53943288545366;334.46151695769805;337.21765504030645;340.4654692133351;5765.3369862465825;5926.5258779297665;5940.524758019359;5998.400159984005;6012.308584512777;5687.971560142193;5808.448197421249;5835.970820145893;5866.530677545797;5868.591538030874;4565.61192298655;4572.6799124061245;4577.061702351027;4579.7252164870215;4581.862544123682;4397.516273209944;4458;4513.458384993805;4540.77296135192;4586.8394606188795;4526.683132180732;4531.116432295704;4536.160810250114;4536.228841097005;4555.385023021883;4505.707129036635;4536.56902594253;4538.614217791475;4543.159515489629;4555.498895121534;4001.519817621875;4001.639852413297;4003.6396724294955;4004.979975100135;4005.6595189408936;5451.700156491392;5602.411746766572;5612.102063669793;5615.803446879339;5629.183768353607;5207.557357624606;5211.973940130313;5215.426303106655;5218.76515556797;5221.634485586011;5888.499477544414;6210.254769427653;6216.2540495140875;6217.067439884054;6221.222347206599;4168.6665066794585;4226.4716910386205;4326.480822301312;4337.674674399433;4362.149380870732;6414.390632889868;6461;6465.1595292611655;6480.287168411471;6495.415412612888;4461.308497182877;4461.866144015685;4461.888452788707;4466.4640243171025;4466.821327146943;4444.177827101997;4480.977595112004;4518.525554816697;4518.915460289507;4532.818687252539;5212.061828870764;5242.370915490089;5245.632805703564;5246.658967167122;5250.159974404077;6236.282827474808;6239.875202496016;6240.7503699851495;6250.468710159596;6256.217972753406;1580.0598643806916;1594.4419453191522;1595.7367034439187;1596.4651841632951;1597.2173634918806;1058.9727963875182;1063.5958335832333;1077.3643550305358;1077.7090185649831;1092.7705181911888;5890.970545147333;5902.2622172228475;5902.704864756745;5903.881922361615;5904.645721256738;6438.581492202992;6440.452561532228;6441.484681225585;6457.870842583216;6512.153420055362;5897.410258974069;5898.970505147447;5900.852478688067;5901.0558310670085;5901.852453688606;3405.914852128667;3506.4214404623463;3512.4028915084496;3517.9120521986642;3518.3842827505086;6803.591784492946;6806.489513286523;6806.625635589991;6806.897896531556;6837.145356830396;6646.069550262967;6664.133662623828;6668.666566671647;6674.098996635392;6679.966600167065;6624.171978502687;6766.391024807791;6785.1518560179975;6787.728490860409;6805.557638753465;6232.127502149612;6393.2328120625825;6490.870182596227;6494.675266236574;6495.610263384212;6262.185915830913;6380.489560835029;6407.935920640734;6418;6424.421802037652;6765.830854228684;6766.458683305422;6768.796936091925;6782.796516104525;6786.219584747817;4479.350494178391;4481.350204220435;4514.864554063383;4517.209488339593;4517.954820451753;6443.7422503101225;6445.742170313135;6449.774257900951;6465.127207826883;6465.870682586416;6282.591631543935;6283.3402492737605;6295.213098362705;6296.6851657417865;6298.307186209605;6158.661273629993;6170.10533472635;6276.686165691606;6278.215223097113;6284.937150628435;6115.327313995546;6117.021276595723;6142.140100386039;6164.3835616438;6169.136320915165;6283.994560870239;6284.340144284784;6286.591371560834;6288.811335659938;6293.559450838397;6048.60684055535;6102.938970610415;6139.109829074849;6145.938540614716;6154.78458253959 17:10:33 INFO - PROCESS | 30725 | |5;yui.html;628.2774808969688;681.1281559603706;769.734441617642;771.6681826814468;806.0166596751963;13041.152325098861;13189.934050329759;13204.20774753513;13209.20744755314;13227.338633068344;12416.81374779379;12485.812712809293;14103.92948035261;14258.144511329327;14279.357428915699;653.9280679125293;659.5712786688642;782.0966783365222;790.9169537198597;802.2138304461631;797.3382092862939;799.7880561651167;801.6713147609481;803.0483876606211;803.2329125684956;830.4394533689765;831.9126491718373;833.5207255827893;833.6123702478346;834.0241916957144;675.9425448836855;682.556338380052;821.9342452603807;833.5707110837923;835.1106072033265;606.1059936593533;610.7740136149608;611.0711718188329;611.3336463255073;611.4863514647673;13418.865811341859;13428.93285533566;13462.596122116352;13483.797743033861;13485.528006519724;11643.883561164364;11666.766664666658;11852.40737963107;12142.696432589168;12151.513939442411;9317.389385139544;9346.15884570392;9419.62321507139;9444.90555094454;9540.570674319672;3465.792052476834;3480.860765569374;3503.3518799022263;3510.2102027043966;3601.0637234319;45951.31073033907;47512.52487475116;47532.76233618845;47540.28689569659;47609;9141.908580914105;9196.08039196075;9207.928216151313;9245.214156796614;9356.251499879992;17294.654106918042;17314.740278895828;17335.393261235797;17384.217710203073;17403.390881319094;7000.474964377692;7074.92925070753;7209.855802883913;7210.062691850026;7435.665395057235;3986.421968814506;4021.678265738734;4120.21715873983;4142.2543942090115;4178.498580170399;2842.090531030092;2853.5862299966802;2857.5713642953306;2860.156253905103;2869.6412948381453;520.1859090523319;525.0286969107198;531.6491115863512;538.5691446842588;542.2977244468423;484.5033840313707;559.6418292292935;588.8292395205342;593.92575928009;601.8736065426309;7568.735094271784;7795.376369890395;7826.2173782621285;7828.882566761503;7899.723509677134;425.8658522565382;561.7303694226794;575.3038823024104;614.1198028873554;630.334996578614;3695.872758808589;3843.8462461501786;3894.941575876364;3990.8204130814183;4009.959900401017;50719;50935.745321273156;51005.74497127491;51156.23265651018;51203.743981279855;47805.76097119492;49653.50346496561;49965.25052124221;50045;50108.24837627439;20115.19539218444;20276;20285;45159.54840451553;45832.083358333315;8070.677172913252;8336.583170841312;8487.15128487171;8522.147785221428;8567.57162141878;32121.678783211868;32523.18692032718;32744.672553274162;33130.66869331276;33180.1704957378;42743.786281068395;43162.56837431711;43548.56451435445;43707.12585748331;43947.56052439435;9525.857112143462;10126.291159619052;10311.948440257751;10463.319884207502;10666.679999600025;11470.139739519736;11517.884821151682;11645.41772911368;11649.88350116488;11733.530658773554;10862;10935.453227338443;11007.61473348429;11286.717832054264;11568.363739994382;10170.644027459004;10177.949110254698;10679.19906007037;10698.946505267424;10707.89292107069;8091.271785539329;10869.239153259196;11105;11146.144098659872;11286.774264514828;8836.602352894264;9178.504023045489;9305.348625596414;9638;9736.269779766688;8615.396922215385;8996.685116020908;9023.458592484472;9123.726288211365;9212.216961558343 17:10:33 INFO - PROCESS | 30725 | __end_tp_report 17:10:33 INFO - PROCESS | 30725 | __start_cc_report 17:10:33 INFO - PROCESS | 30725 | _x_x_mozilla_cycle_collect,892 17:10:33 INFO - PROCESS | 30725 | __end_cc_report 17:10:33 INFO - PROCESS | 30725 | __startTimestamp1452733833025__endTimestamp 17:10:33 INFO - PROCESS | 30725 | 17:10:33 INFO - PROCESS | 30725 | ------- Summary: start ------- 17:10:33 INFO - PROCESS | 30725 | Number of tests: 6 17:10:33 INFO - PROCESS | 30725 | 17:10:33 INFO - PROCESS | 30725 | [#0] dojo.html Cycles:165 Average:5066.52 Median:5261.24 stddev:538.13 (10.2%) stddev-sans-first:516.43 17:10:33 INFO - PROCESS | 30725 | Values: 3067.7 3092.4 3132.1 3141.0 3153.4 4973.1 4992.4 5022.5 5039.3 5092.0 5066.8 5100.1 5122.1 5136.2 5150.5 4468.8 4656.4 4658.1 4682.5 4737.0 4555.7 4687.1 4710.3 4732.2 4791.0 4624.4 4638.3 4680.5 4681.8 4718.2 4631.1 4633.3 4643.5 4673.3 4686.4 4561.9 4642.4 4651.5 4658.6 4684.4 4853.2 4906.7 4962.9 4976.7 5016.4 5493.2 5511.6 5519.6 5522.3 5523.8 5399.9 5535.0 5543.3 5547.8 5549.9 5080.6 5089.4 5094.5 5132.4 5165.8 5610.0 5647.0 5648.4 5650.1 5663.3 5240.4 5442.5 5472.5 5476.0 5481.5 5401.1 5433.9 5436.7 5464.3 5483.4 5288.0 5341.1 5344.0 5346.5 5363.6 5284.5 5295.3 5342.9 5378.5 5416.6 4232.5 4272.5 4300.2 4320.8 4352.0 3801.7 3805.6 3819.1 3841.9 3843.8 5031.6 5043.9 5048.2 5058.4 5087.2 5409.3 5464.9 5472.6 5494.5 5509.3 5065.8 5075.7 5078.7 5081.3 5100.9 4708.2 4711.0 4712.9 4735.3 4747.3 5536.8 5628.7 5631.6 5631.7 5634.3 5388.9 5396.2 5407.5 5416.3 5455.5 5583.1 5584.2 5587.4 5591.8 5602.8 5340.7 5361.2 5388.9 5424.8 5477.1 5390.6 5428.3 5430.6 5465.2 5467.3 5298.6 5302.7 5306.4 5313.6 5341.9 5180.2 5241.4 5261.2 5272.1 5322.7 5273.4 5275.8 5276.4 5276.4 5285.8 5374.4 5383.0 5389.9 5393.0 5433.9 5152.6 5199.2 5245.1 5257.6 5291.5 17:10:33 INFO - PROCESS | 30725 | 17:10:33 INFO - PROCESS | 30725 | [#1] ext.html Cycles:180 Average:50647.99 Median:21524.87 stddev:94121.18 (437.3%) stddev-sans-first:94309.86 17:10:33 INFO - PROCESS | 30725 | Values: 486.3 522.3 523.8 524.6 539.1 27790.0 28361.9 28391.1 28404.0 35640.6 39464.0 39860.6 39876.0 39919.0 40070.4 8432.9 8515.3 8603.6 8610.1 8642.4 8296.8 8421.2 8435.1 8444.7 8452.6 8420.4 8513.7 8517.7 8521.8 8700.2 8625.7 8702.9 8711.9 8714.1 8714.5 8547.1 8673.2 8675.4 8693.2 8700.6 39136.4 39469.4 39629.0 39641.8 39685.2 2568.4 2641.3 2713.2 3211.7 3373.6 29665.4 31771.4 31878.4 32295.0 32359.8 3660.8 3661.3 3689.3 3772.3 3913.3 273378.0 279354.0 280496.0 280670.0 280671.0 53660.5 54781.2 54997.0 59941.7 61353.7 66990.0 67949.3 68260.7 68371.0 68481.3 13164.5 13257.1 13268.2 13274.8 13286.3 9716.2 9990.8 9993.5 11007.4 11253.7 20197.5 20328.2 20417.2 20440.3 20506.5 7969.8 8150.2 8249.6 8433.3 8509.1 895.7 975.8 984.4 990.2 1117.3 26606.5 26854.2 27053.3 27311.2 27362.6 942.0 975.6 984.4 1017.2 1144.8 14020.4 14421.9 14486.4 14567.4 14581.0 403060.0 406448.0 408420.0 408917.0 409102.0 52635.0 53058.0 53198.0 53209.7 53385.2 1072.8 1077.3 1144.1 1279.7 1407.9 24560.6 26115.7 26275.2 26412.3 26472.6 40516.6 41025.0 41577.8 41628.2 42522.1 189868.0 395983.0 404066.0 404456.0 406430.0 32119.4 32880.0 32882.3 32930.0 32956.0 42637.1 43181.6 43187.0 43623.6 44106.0 36051.0 36083.6 36103.5 36135.5 37418.0 35906.3 36158.1 36345.0 36871.3 37233.3 35501.5 36502.1 36593.8 36599.6 36603.3 30256.2 32708.7 33175.3 33629.2 33730.0 24442.0 25286.6 26480.2 26730.0 26807.7 17:10:33 INFO - PROCESS | 30725 | 17:10:33 INFO - PROCESS | 30725 | [#2] jquery.html Cycles:180 Average:26832.05 Median:4008.12 stddev:84763.76 (2114.8%) stddev-sans-first:84978.23 17:10:33 INFO - PROCESS | 30725 | Values: 355.1 358.1 358.3 361.0 361.2 13278.3 13716.0 16117.8 16208.9 16814.6 14193.7 15206.2 15586.6 15602.8 16713.6 5146.5 5351.3 5352.5 5355.4 5367.8 3952.2 4064.0 5223.8 5328.2 5682.5 5744.0 5825.7 5883.8 5885.8 5888.4 5667.6 5704.2 5742.4 5752.9 5762.8 4958.2 5045.2 5052.2 5151.7 5186.9 19909.9 20132.7 20148.7 20161.3 20447.2 2057.8 2069.7 2075.2 2093.3 2205.9 12428.4 12785.9 12793.6 12954.7 13217.3 1714.0 1727.7 1741.2 1774.5 1785.1 54459.7 56714.4 56969.7 57151.6 57244.7 10093.6 10127.7 10162.4 10179.8 10195.4 13249.7 13279.6 13313.6 13324.7 13325.1 7138.2 7145.0 7154.2 7206.7 7258.0 6710.3 6724.3 6755.4 6776.5 6782.2 4401.7 4453.9 4469.4 4473.4 4506.2 1701.2 1743.4 1766.3 1820.3 1836.4 726.5 841.8 858.2 949.8 952.9 15776.4 16101.3 16889.2 16913.4 16999.6 857.7 869.6 891.6 920.4 965.9 7308.0 9480.5 9843.0 9843.8 9889.4 504491.0 511231.0 514209.0 521735.0 541870.0 59637.0 74635.3 76819.2 77809.2 78846.0 1110.2 1124.6 1126.9 1149.6 1150.2 14073.2 14319.7 14820.2 14894.9 15013.8 31227.8 31837.4 31863.4 32022.8 33301.7 37258.4 37547.6 37633.0 38194.6 38488.6 7219.8 7331.7 7343.8 7436.2 7471.3 9174.3 10995.1 11245.6 11351.5 11354.4 9471.3 9737.7 9742.3 9968.2 10177.3 9689.6 9962.7 10209.3 10216.4 10275.9 9847.5 9864.3 10011.4 10067.5 10335.3 7365.2 7520.4 7523.0 7523.6 7557.6 9884.7 10030.3 10085.7 10111.8 10199.8 17:10:33 INFO - PROCESS | 30725 | 17:10:33 INFO - PROCESS | 30725 | [#3] mootools.html Cycles:180 Average:5159.37 Median:6126.04 stddev:2663.95 (43.5%) stddev-sans-first:2655.52 17:10:33 INFO - PROCESS | 30725 | Values: 1287.1 1404.1 1416.9 1417.5 1484.3 6295.6 7016.4 7164.6 7165.1 7176.4 7081.6 7261.0 7265.9 7270.4 7276.1 1890.3 1932.8 2150.3 2189.9 2214.6 2185.7 2188.7 2193.7 2195.9 2196.1 2136.8 2215.6 2229.6 2233.6 2236.7 2164.3 2172.1 2173.0 2229.0 2231.2 2142.3 2181.7 2198.0 2198.3 2201.8 7341.5 7424.3 7431.1 7438.6 7445.5 4400.6 4495.5 4497.7 4527.7 4530.8 2777.9 2834.8 2860.0 2875.2 2933.8 953.5 954.7 963.1 972.3 976.0 10048.2 10048.6 10064.3 10069.5 10069.7 3950.5 3989.0 3999.8 4001.8 4071.2 8675.5 8698.0 8707.7 8710.1 8710.4 4459.9 4499.3 4502.5 4505.4 4505.5 4134.2 4144.6 4146.0 4149.8 4151.5 3248.8 3317.8 3390.7 3503.0 3571.5 1131.6 1156.7 1159.1 1159.5 1163.2 983.9 1009.8 1169.7 1178.3 1188.8 6787.9 6845.6 6874.2 6876.5 6879.2 1018.3 1030.0 1067.5 1068.4 1076.9 5142.2 5231.3 5237.9 5247.0 5253.4 8504.4 8773.0 8789.9 9061.9 9065.6 8684.0 8747.7 8750.3 8764.8 8764.8 6902.6 6910.6 7017.4 7035.5 7104.9 6865.4 6918.7 6927.2 6928.6 6936.5 7824.8 7952.8 7963.8 8165.2 8169.5 8110.6 8208.3 8285.6 8367.5 8378.4 6556.2 6573.0 6585.6 6646.9 6650.8 6919.3 6970.6 7002.8 7029.2 7029.6 6322.5 6593.4 6700.2 6784.8 6797.9 6554.8 6615.3 6626.7 6695.1 6734.1 6665.9 6722.7 6724.0 6726.2 6726.6 5808.8 5865.9 5880.1 5880.8 5914.5 6078.1 6124.4 6127.7 6141.7 6147.9 17:10:33 INFO - PROCESS | 30725 | 17:10:33 INFO - PROCESS | 30725 | [#4] prototype.html Cycles:180 Average:5239.54 Median:5900.95 stddev:1573.79 (26.7%) stddev-sans-first:1534.43 17:10:33 INFO - PROCESS | 30725 | Values: 328.4 332.5 334.5 337.2 340.5 5765.3 5926.5 5940.5 5998.4 6012.3 5688.0 5808.4 5836.0 5866.5 5868.6 4565.6 4572.7 4577.1 4579.7 4581.9 4397.5 4458.0 4513.5 4540.8 4586.8 4526.7 4531.1 4536.2 4536.2 4555.4 4505.7 4536.6 4538.6 4543.2 4555.5 4001.5 4001.6 4003.6 4005.0 4005.7 5451.7 5602.4 5612.1 5615.8 5629.2 5207.6 5212.0 5215.4 5218.8 5221.6 5888.5 6210.3 6216.3 6217.1 6221.2 4168.7 4226.5 4326.5 4337.7 4362.1 6414.4 6461.0 6465.2 6480.3 6495.4 4461.3 4461.9 4461.9 4466.5 4466.8 4444.2 4481.0 4518.5 4518.9 4532.8 5212.1 5242.4 5245.6 5246.7 5250.2 6236.3 6239.9 6240.8 6250.5 6256.2 1580.1 1594.4 1595.7 1596.5 1597.2 1059.0 1063.6 1077.4 1077.7 1092.8 5891.0 5902.3 5902.7 5903.9 5904.6 6438.6 6440.5 6441.5 6457.9 6512.2 5897.4 5899.0 5900.9 5901.1 5901.9 3405.9 3506.4 3512.4 3517.9 3518.4 6803.6 6806.5 6806.6 6806.9 6837.1 6646.1 6664.1 6668.7 6674.1 6680.0 6624.2 6766.4 6785.2 6787.7 6805.6 6232.1 6393.2 6490.9 6494.7 6495.6 6262.2 6380.5 6407.9 6418.0 6424.4 6765.8 6766.5 6768.8 6782.8 6786.2 4479.4 4481.4 4514.9 4517.2 4518.0 6443.7 6445.7 6449.8 6465.1 6465.9 6282.6 6283.3 6295.2 6296.7 6298.3 6158.7 6170.1 6276.7 6278.2 6284.9 6115.3 6117.0 6142.1 6164.4 6169.1 6284.0 6284.3 6286.6 6288.8 6293.6 6048.6 6102.9 6139.1 6145.9 6154.8 17:10:33 INFO - PROCESS | 30725 | 17:10:33 INFO - PROCESS | 30725 | [#5] yui.html Cycles:180 Average:12733.14 Median:25069.00 stddev:14595.20 (58.2%) stddev-sans-first:14607.83 17:10:33 INFO - PROCESS | 30725 | Values: 628.3 681.1 769.7 771.7 806.0 13041.2 13189.9 13204.2 13209.2 13227.3 12416.8 12485.8 14103.9 14258.1 14279.4 653.9 659.6 782.1 790.9 802.2 797.3 799.8 801.7 803.0 803.2 830.4 831.9 833.5 833.6 834.0 675.9 682.6 821.9 833.6 835.1 606.1 610.8 611.1 611.3 611.5 13418.9 13428.9 13462.6 13483.8 13485.5 11643.9 11666.8 11852.4 12142.7 12151.5 9317.4 9346.2 9419.6 9444.9 9540.6 3465.8 3480.9 3503.4 3510.2 3601.1 45951.3 47512.5 47532.8 47540.3 47609.0 9141.9 9196.1 9207.9 9245.2 9356.3 17294.7 17314.7 17335.4 17384.2 17403.4 7000.5 7074.9 7209.9 7210.1 7435.7 3986.4 4021.7 4120.2 4142.3 4178.5 2842.1 2853.6 2857.6 2860.2 2869.6 520.2 525.0 531.6 538.6 542.3 484.5 559.6 588.8 593.9 601.9 7568.7 7795.4 7826.2 7828.9 7899.7 425.9 561.7 575.3 614.1 630.3 3695.9 3843.8 3894.9 3990.8 4010.0 50719.0 50935.7 51005.7 51156.2 51203.7 47805.8 49653.5 49965.3 50045.0 50108.2 20115.2 20276.0 20285.0 45159.5 45832.1 8070.7 8336.6 8487.2 8522.1 8567.6 32121.7 32523.2 32744.7 33130.7 33180.2 42743.8 43162.6 43548.6 43707.1 43947.6 9525.9 10126.3 10311.9 10463.3 10666.7 11470.1 11517.9 11645.4 11649.9 11733.5 10862.0 10935.5 11007.6 11286.7 11568.4 10170.6 10177.9 10679.2 10698.9 10707.9 8091.3 10869.2 11105.0 11146.1 11286.8 8836.6 9178.5 9305.3 9638.0 9736.3 8615.4 8996.7 9023.5 9123.7 9212.2 17:10:33 INFO - PROCESS | 30725 | -------- Summary: end -------- 17:10:33 INFO - PROCESS | 30725 | 17:10:33 INFO - TEST-INFO | 30725: exit 0 17:10:33 INFO - TEST-OK | dromaeo_css | took 1114297ms 17:10:33 INFO - TEST-START | kraken 17:10:33 INFO - operating with platform_type : linux_ 17:10:33 INFO - Initialising browser for kraken test... 17:10:33 INFO - TEST-INFO | started process 30913 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqymO9d/profile http://localhost:35266/getInfo.html) 17:10:38 INFO - PROCESS | 30913 | __metrics Screen width/height:1600/1200 17:10:38 INFO - PROCESS | 30913 | colorDepth:24 17:10:38 INFO - PROCESS | 30913 | Browser inner width/height: 1024/697 17:10:38 INFO - PROCESS | 30913 | __metrics 17:10:38 INFO - PROCESS | 30913 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:10:38 INFO - PROCESS | 30913 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:10:40 INFO - TEST-INFO | 30913: exit 0 17:10:40 INFO - Browser initialized. 17:10:40 INFO - Running cycle 1/1 for kraken test... 17:10:40 INFO - TEST-INFO | started process 30993 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqymO9d/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:51 INFO - PROCESS | 30993 | RSS: Main: 150990848 17:10:51 INFO - PROCESS | 30993 | 17:10:54 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35266/tests/kraken/driver.html?testName=audio-beat-detection) 17:10:54 INFO - PROCESS | 30993 | RSS: Main: 187707392 17:10:54 INFO - PROCESS | 30993 | 17:10:57 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35266/tests/kraken/driver.html?testName=audio-dft) 17:10:58 INFO - PROCESS | 30993 | RSS: Main: 178155520 17:10:58 INFO - PROCESS | 30993 | 17:11:00 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35266/tests/kraken/driver.html?testName=audio-fft) 17:11:01 INFO - PROCESS | 30993 | RSS: Main: 161660928 17:11:01 INFO - PROCESS | 30993 | 17:11:03 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35266/tests/kraken/driver.html?testName=audio-oscillator) 17:11:04 INFO - PROCESS | 30993 | RSS: Main: 162721792 17:11:04 INFO - PROCESS | 30993 | 17:11:06 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:11:06 INFO - PROCESS | 30993 | RSS: Main: 165896192 17:11:06 INFO - PROCESS | 30993 | 17:11:09 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35266/tests/kraken/driver.html?testName=imaging-darkroom) 17:11:10 INFO - PROCESS | 30993 | RSS: Main: 167460864 17:11:10 INFO - PROCESS | 30993 | 17:11:13 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35266/tests/kraken/driver.html?testName=imaging-desaturate) 17:11:14 INFO - PROCESS | 30993 | RSS: Main: 166662144 17:11:14 INFO - PROCESS | 30993 | 17:11:17 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35266/tests/kraken/driver.html?testName=json-parse-financial) 17:11:17 INFO - PROCESS | 30993 | RSS: Main: 165859328 17:11:17 INFO - PROCESS | 30993 | 17:11:19 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:11:19 INFO - PROCESS | 30993 | RSS: Main: 178507776 17:11:19 INFO - PROCESS | 30993 | 17:11:21 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35266/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:11:22 INFO - PROCESS | 30993 | RSS: Main: 175656960 17:11:22 INFO - PROCESS | 30993 | 17:11:24 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:11:24 INFO - PROCESS | 30993 | RSS: Main: 182403072 17:11:24 INFO - PROCESS | 30993 | 17:11:27 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:11:27 INFO - PROCESS | 30993 | RSS: Main: 191070208 17:11:27 INFO - PROCESS | 30993 | 17:11:30 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:11:30 INFO - PROCESS | 30993 | RSS: Main: 189759488 17:11:30 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | Cycle 1(1): loaded http://localhost:35266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35266/tests/kraken/driver.html?testName=ai-astar) 17:11:32 INFO - PROCESS | 30993 | RSS: Main: 248074240 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | __start_tp_report 17:11:32 INFO - PROCESS | 30993 | _x_x_mozilla_page_load 17:11:32 INFO - PROCESS | 30993 | _x_x_mozilla_page_load_details 17:11:32 INFO - PROCESS | 30993 | |i|pagename|runs| 17:11:32 INFO - PROCESS | 30993 | |0;ai-astar;109;110;105;110;111;110;99;110;111;111 17:11:32 INFO - PROCESS | 30993 | |1;audio-beat-detection;154;127;150;162;126;150;149;133;170;130 17:11:32 INFO - PROCESS | 30993 | |2;audio-dft;160;160;161;160;160;161;160;164;161;162 17:11:32 INFO - PROCESS | 30993 | |3;audio-fft;72;74;99;96;71;75;75;111;97;72 17:11:32 INFO - PROCESS | 30993 | |4;audio-oscillator;97;96;137;96;96;95;141;95;96;142 17:11:32 INFO - PROCESS | 30993 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 17:11:32 INFO - PROCESS | 30993 | |6;imaging-darkroom;146;145;146;145;145;145;145;146;146;145 17:11:32 INFO - PROCESS | 30993 | |7;imaging-desaturate;97;96;96;96;97;97;95;95;95;96 17:11:32 INFO - PROCESS | 30993 | |8;json-parse-financial;54;57;55;55;55;56;55;64;52;55 17:11:32 INFO - PROCESS | 30993 | |9;json-stringify-tinderbox;67;68;68;68;68;68;67;68;67;68 17:11:32 INFO - PROCESS | 30993 | |10;stanford-crypto-aes;80;79;81;81;80;89;81;82;82;80 17:11:32 INFO - PROCESS | 30993 | |11;stanford-crypto-ccm;119;124;118;114;111;118;119;117;112;113 17:11:32 INFO - PROCESS | 30993 | |12;stanford-crypto-pbkdf2;142;143;141;143;143;142;141;142;140;134 17:11:32 INFO - PROCESS | 30993 | |13;stanford-crypto-sha256-iterative;66;66;66;66;66;65;66;68;66;69 17:11:32 INFO - PROCESS | 30993 | __end_tp_report 17:11:32 INFO - PROCESS | 30993 | __start_cc_report 17:11:32 INFO - PROCESS | 30993 | _x_x_mozilla_cycle_collect,968 17:11:32 INFO - PROCESS | 30993 | __end_cc_report 17:11:32 INFO - PROCESS | 30993 | __startTimestamp1452733892622__endTimestamp 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | ------- Summary: start ------- 17:11:32 INFO - PROCESS | 30993 | Number of tests: 14 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:3.81 (3.4%) stddev-sans-first:4.03 17:11:32 INFO - PROCESS | 30993 | Values: 109.0 110.0 105.0 110.0 111.0 110.0 99.0 110.0 111.0 111.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:150.00 stddev:15.33 (10.2%) stddev-sans-first:15.92 17:11:32 INFO - PROCESS | 30993 | Values: 154.0 127.0 150.0 162.0 126.0 150.0 149.0 133.0 170.0 130.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 17:11:32 INFO - PROCESS | 30993 | Values: 160.0 160.0 161.0 160.0 160.0 161.0 160.0 164.0 161.0 162.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#3] audio-fft Cycles:10 Average:84.20 Median:75.00 stddev:14.85 (19.8%) stddev-sans-first:15.08 17:11:32 INFO - PROCESS | 30993 | Values: 72.0 74.0 99.0 96.0 71.0 75.0 75.0 111.0 97.0 72.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:96.00 stddev:21.37 (22.3%) stddev-sans-first:22.21 17:11:32 INFO - PROCESS | 30993 | Values: 97.0 96.0 137.0 96.0 96.0 95.0 141.0 95.0 96.0 142.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:11:32 INFO - PROCESS | 30993 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:11:32 INFO - PROCESS | 30993 | Values: 146.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 17:11:32 INFO - PROCESS | 30993 | Values: 97.0 96.0 96.0 96.0 97.0 97.0 95.0 95.0 95.0 96.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:3.16 (5.7%) stddev-sans-first:3.28 17:11:32 INFO - PROCESS | 30993 | Values: 54.0 57.0 55.0 55.0 55.0 56.0 55.0 64.0 52.0 55.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 17:11:32 INFO - PROCESS | 30993 | Values: 67.0 68.0 68.0 68.0 68.0 68.0 67.0 68.0 67.0 68.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:2.80 (3.5%) stddev-sans-first:2.92 17:11:32 INFO - PROCESS | 30993 | Values: 80.0 79.0 81.0 81.0 80.0 89.0 81.0 82.0 82.0 80.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#11] stanford-crypto-ccm Cycles:10 Average:116.50 Median:118.00 stddev:3.98 (3.4%) stddev-sans-first:4.12 17:11:32 INFO - PROCESS | 30993 | Values: 119.0 124.0 118.0 114.0 111.0 118.0 119.0 117.0 112.0 113.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:142.00 stddev:2.69 (1.9%) stddev-sans-first:2.83 17:11:32 INFO - PROCESS | 30993 | Values: 142.0 143.0 141.0 143.0 143.0 142.0 141.0 142.0 140.0 134.0 17:11:32 INFO - PROCESS | 30993 | 17:11:32 INFO - PROCESS | 30993 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 17:11:32 INFO - PROCESS | 30993 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 66.0 68.0 66.0 69.0 17:11:32 INFO - PROCESS | 30993 | -------- Summary: end -------- 17:11:32 INFO - PROCESS | 30993 | 17:11:33 INFO - TEST-INFO | 30993: exit 0 17:11:33 INFO - TEST-OK | kraken | took 60030ms 17:11:33 INFO - TEST-START | v8_7 17:11:33 INFO - operating with platform_type : linux_ 17:11:33 INFO - Initialising browser for v8_7 test... 17:11:33 INFO - TEST-INFO | started process 31243 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5KFeyA/profile http://localhost:35266/getInfo.html) 17:11:38 INFO - PROCESS | 31243 | __metrics Screen width/height:1600/1200 17:11:38 INFO - PROCESS | 31243 | colorDepth:24 17:11:38 INFO - PROCESS | 31243 | Browser inner width/height: 1024/697 17:11:38 INFO - PROCESS | 31243 | __metrics 17:11:39 INFO - PROCESS | 31243 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:11:39 INFO - PROCESS | 31243 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:11:40 INFO - TEST-INFO | 31243: exit 0 17:11:40 INFO - Browser initialized. 17:11:40 INFO - Running cycle 1/1 for v8_7 test... 17:11:40 INFO - TEST-INFO | started process 31326 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5KFeyA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:52 INFO - PROCESS | 31326 | RSS: Main: 150515712 17:11:52 INFO - PROCESS | 31326 | 17:12:14 INFO - PROCESS | 31326 | Cycle 1(1): loaded http://localhost:35266/tests/v8_7/run.html (next: http://localhost:35266/tests/v8_7/run.html) 17:12:15 INFO - PROCESS | 31326 | RSS: Main: 583290880 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - PROCESS | 31326 | __start_tp_report 17:12:15 INFO - PROCESS | 31326 | _x_x_mozilla_page_load 17:12:15 INFO - PROCESS | 31326 | _x_x_mozilla_page_load_details 17:12:15 INFO - PROCESS | 31326 | |i|pagename|runs| 17:12:15 INFO - PROCESS | 31326 | |0;Richards;167.64459346186086 17:12:15 INFO - PROCESS | 31326 | |1;DeltaBlue;189.8614011771407 17:12:15 INFO - PROCESS | 31326 | |2;Encrypt;279.4076557697681 17:12:15 INFO - PROCESS | 31326 | |3;Decrypt;5251.308900523561 17:12:15 INFO - PROCESS | 31326 | |4;RayTrace;1956.9471624266146 17:12:15 INFO - PROCESS | 31326 | |5;Earley;768.6395080707148 17:12:15 INFO - PROCESS | 31326 | |6;Boyer;12550 17:12:15 INFO - PROCESS | 31326 | |7;RegExp;41918.36734693877 17:12:15 INFO - PROCESS | 31326 | |8;Splay;630.9148264984227 17:12:15 INFO - PROCESS | 31326 | |9;NavierStokes;4830.917874396136 17:12:15 INFO - PROCESS | 31326 | __end_tp_report 17:12:15 INFO - PROCESS | 31326 | __startTimestamp1452733935095__endTimestamp 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - PROCESS | 31326 | ------- Summary: start ------- 17:12:15 INFO - PROCESS | 31326 | Number of tests: 10 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - PROCESS | 31326 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 17:12:15 INFO - PROCESS | 31326 | Values: 167.6 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - PROCESS | 31326 | [#1] DeltaBlue Cycles:1 Average:189.86 Median:189.86 stddev:0.00 (0.0%) 17:12:15 INFO - PROCESS | 31326 | Values: 189.9 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - PROCESS | 31326 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 17:12:15 INFO - PROCESS | 31326 | Values: 279.4 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - PROCESS | 31326 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 17:12:15 INFO - PROCESS | 31326 | Values: 5251.3 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - PROCESS | 31326 | [#4] RayTrace Cycles:1 Average:1956.95 Median:1956.95 stddev:0.00 (0.0%) 17:12:15 INFO - PROCESS | 31326 | Values: 1956.9 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - PROCESS | 31326 | [#5] Earley Cycles:1 Average:768.64 Median:768.64 stddev:0.00 (0.0%) 17:12:15 INFO - PROCESS | 31326 | Values: 768.6 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - PROCESS | 31326 | [#6] Boyer Cycles:1 Average:12550.00 Median:12550.00 stddev:0.00 (0.0%) 17:12:15 INFO - PROCESS | 31326 | Values: 12550.0 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - PROCESS | 31326 | [#7] RegExp Cycles:1 Average:41918.37 Median:41918.37 stddev:0.00 (0.0%) 17:12:15 INFO - PROCESS | 31326 | Values: 41918.4 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - PROCESS | 31326 | [#8] Splay Cycles:1 Average:630.91 Median:630.91 stddev:0.00 (0.0%) 17:12:15 INFO - PROCESS | 31326 | Values: 630.9 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - PROCESS | 31326 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:12:15 INFO - PROCESS | 31326 | Values: 4830.9 17:12:15 INFO - PROCESS | 31326 | -------- Summary: end -------- 17:12:15 INFO - PROCESS | 31326 | 17:12:15 INFO - TEST-INFO | 31326: exit 0 17:12:15 INFO - TEST-OK | v8_7 | took 42156ms 17:12:15 INFO - SUITE-END | took 1216s 17:12:16 INFO - Completed test suite (00:20:16) 17:12:16 INFO - Working with test: dromaeo_css 17:12:16 INFO - Generating results file: dromaeo_css 17:12:16 INFO - Working with test: kraken 17:12:16 INFO - Generating results file: kraken 17:12:16 INFO - javascript benchmark 17:12:16 INFO - Working with test: v8_7 17:12:16 INFO - Generating results file: v8_7 17:12:16 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:12:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 17:12:16 INFO - process_Request line: dromaeo_css 6671.64 graph.html#tests=[[72,201,35]] 17:12:16 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:12:16 INFO - process_Request line: kraken 1487.30 graph.html#tests=[[232,201,35]] 17:12:16 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:12:16 INFO - process_Request line: v8_7 18831.78 graph.html#tests=[[230,201,35]] 17:12:16 INFO - RETURN: dromaeo_css: 6671.64 17:12:16 INFO - RETURN: kraken: 1487.30 17:12:16 INFO - RETURN: v8_7: 18831.78 17:12:16 INFO - javascript benchmark 17:12:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3067.6778938211487, 3092.4124416360874, 3132.0916934089114, 3140.9791817659266, 3153.416617925684, 4973.129702302096, 4992.425871024833, 5022.472640372758, 5039.269305950635, 5092.0, 5066.822661206858, 5100.081985242655, 5122.103631864418, 5136.2038883972955, 5150.510701483362, 4468.843590474334, 4656.371389862376, 4658.09167212392, 4682.508336624665, 4737.028909073649, 4555.74943378114, 4687.0625874825, 4710.317004034413, 4732.195526760442, 4791.041791641668, 4624.398828152335, 4638.257878739402, 4680.508546602592, 4681.765911704401, 4718.150732868083, 4631.143238500888, 4633.305004249356, 4643.535646435364, 4673.299005149221, 4686.367340409035, 4561.863144105682, 4642.419697537808, 4651.465081515636, 4658.627309815207, 4684.36761037259, 4853.174960256765, 4906.705597664151, 4962.87592810179, 4976.726280054596, 5016.44819069902, 5493.23094766733, 5511.641743286714, 5519.558435325164, 5522.30971128609, 5523.806666766684, 5399.865003374908, 5534.972325138388, 5543.307086614173, 5547.805826796042, 5549.916751248735, 5080.618953578496, 5089.440161582223, 5094.541491265803, 5132.409772876093, 5165.767540460688, 5610.046292130266, 5646.971765141148, 5648.378678345379, 5650.124230744241, 5663.263775709132, 5240.423553409122, 5442.455754424605, 5472.5348345391085, 5476.0, 5481.534069604048, 5401.081816091274, 5433.891322173614, 5436.673799572039, 5464.28964234647, 5483.396826349099, 5288.0, 5341.0653135701095, 5344.0, 5346.5455436287575, 5363.597730170175, 5284.471552844685, 5295.285136506599, 5342.91985620216, 5378.542823859937, 5416.647917885325, 4232.534421213664, 4272.530021697611, 4300.225959327288, 4320.827166913288, 4351.9564804352185, 3801.676857467091, 3805.6194380561724, 3819.102510909934, 3841.865534706272, 3843.8462461501226, 5031.572316353077, 5043.87390315245, 5048.167052436307, 5058.367704036996, 5087.211482220262, 5409.269748583891, 5464.9453505465235, 5472.616916815785, 5494.5054945055135, 5509.256250406224, 5065.797368105308, 5075.746212689351, 5078.7460626968505, 5081.314022606901, 5100.923486147711, 4708.246680531167, 4711.0342379812055, 4712.882177945578, 4735.289706543977, 4747.264174053027, 5536.833894983157, 5628.690422026828, 5631.577631677641, 5631.662100273997, 5634.32388113429, 5388.946110538845, 5396.217548455374, 5407.513323800877, 5416.295881535375, 5455.454454554671, 5583.106702927512, 5584.246126772834, 5587.44125587438, 5591.832245032656, 5602.775888964396, 5340.732963351739, 5361.222622719762, 5388.892222155613, 5424.783008679608, 5477.068898287221, 5390.595705322195, 5428.294321738149, 5430.647007944471, 5465.180222966586, 5467.316585426822, 5298.602604804578, 5302.734863256745, 5306.363236411656, 5313.601479888946, 5341.866453338697, 5180.171172612364, 5241.44964778708, 5261.237120617566, 5272.103742363884, 5322.654027488201, 5273.419923808455, 5275.788968441219, 5276.39321478035, 5276.39321478035, 5285.814996475105, 5374.381946076252, 5383.0, 5389.919151212656, 5393.0, 5433.918491222714, 5152.5877929766275, 5199.246109314204, 5245.0821106307, 5257.605679574123, 5291.470852914832], "unit": "score", "name": "dojo.html", "value": 5033.361420003633}, {"lowerIsBetter": false, "replicates": [486.25845585482114, 522.2662159665668, 523.7590708274194, 524.5986820082636, 539.1481459294315, 27790.0, 28361.85819070907, 28391.14826555204, 28404.0, 35640.643593564055, 39464.0, 39860.60139398605, 39876.0, 39919.0, 40070.39894401579, 8432.91567084329, 8515.318774498057, 8603.56982150893, 8610.138986101403, 8642.351823613222, 8296.792580185484, 8421.24208821206, 8435.114312997139, 8444.746657600283, 8452.577371131449, 8420.410571260014, 8513.702020429286, 8517.701880434186, 8521.829563408728, 8700.216980471756, 8625.698100566482, 8702.869456958151, 8711.912880871174, 8714.08502107276, 8714.477131372074, 8547.059823419419, 8673.176048275403, 8675.392722509427, 8693.217610415093, 8700.608472618747, 39136.41295380572, 39469.40795888064, 39629.0, 39641.80179099086, 39685.20629587421, 2568.447783726489, 2641.343813589743, 2713.2267303818317, 3211.6962672863824, 3373.6289008209324, 29665.406691866043, 31771.364572708648, 31878.362432751215, 32295.0, 32359.83820080908, 3660.780900273564, 3661.3317722234838, 3689.2990331836863, 3772.305513868187, 3913.3347330953807, 273378.0, 279354.0, 280496.0, 280670.0, 280671.0, 53660.46339536633, 54781.178282325796, 54997.0, 59941.700291498266, 61353.69323153445, 66990.0, 67949.3205067953, 68260.65869670719, 68371.0, 68481.31518684849, 13164.539241126515, 13257.14399984003, 13268.203907765565, 13274.800877986838, 13286.269255190864, 9716.222702183808, 9990.750231244132, 9993.450360230112, 11007.394593297286, 11253.718657033476, 20197.495062623257, 20328.186872524933, 20417.183312667625, 20440.284590039573, 20506.487337816674, 7969.760907172794, 8150.184981501921, 8249.586471237859, 8433.28317093054, 8509.149085091565, 895.7223260789176, 975.7609385700407, 984.3749219245831, 990.1830989433602, 1117.284937639911, 26606.46787064248, 26854.194374168805, 27053.32366690809, 27311.180664580093, 27362.589561156597, 941.9858702119474, 975.6438899801522, 984.4044353166374, 1017.1811691588342, 1144.7996600594863, 14020.369083391271, 14421.880232517306, 14486.420543178156, 14567.41730330775, 14581.0, 403060.0, 406448.0, 408420.0, 408917.0, 409102.0, 52635.0, 53058.0, 53198.0, 53209.733951329996, 53385.1992220117, 1072.8229842076125, 1077.283606401734, 1144.1190283481671, 1279.6672865055152, 1407.92960351982, 24560.631590525798, 26115.738842611332, 26275.21174364772, 26412.339691507867, 26472.602910956735, 40516.59483405246, 41025.0, 41577.79211103925, 41628.16743665049, 42522.1495570093, 189868.0, 395983.0, 404066.0, 404456.0, 406430.0, 32119.357612847143, 32880.0, 32882.34235315232, 32930.0, 32956.0, 42637.14725705531, 43181.56818431775, 43187.0, 43623.56376436322, 44106.0, 36051.0, 36083.63916360803, 36103.45844812383, 36135.45796813103, 37418.0, 35906.28187436289, 36158.11865398138, 36345.0, 36871.26257474889, 37233.25533489261, 35501.467477988364, 36502.08744781402, 36593.81703091467, 36599.63400365962, 36603.26793464062, 30256.243593909447, 32708.672913270562, 33175.33649326952, 33629.15927101842, 33730.0, 24442.0, 25286.620700689873, 26480.205593832216, 26730.0, 26807.731922680523], "unit": "score", "name": "ext.html", "value": 18179.772006861785}, {"lowerIsBetter": false, "replicates": [355.11753293066727, 358.0815208988945, 358.256617518649, 360.96209897960716, 361.2449979542755, 13278.269695166762, 13716.0, 16117.758233626504, 16208.918955405221, 16814.579635509104, 14193.71612567748, 15206.23968801561, 15586.610334741637, 15602.843971560282, 16713.582160445996, 5146.5110814472755, 5351.331083614548, 5352.464753524655, 5355.410904800468, 5367.838964831061, 3952.2490726761966, 4064.0, 5223.764930578133, 5328.227407025979, 5682.488576028157, 5743.971280143614, 5825.708714564276, 5883.823485295448, 5885.823425297248, 5888.381719919411, 5667.603267771257, 5704.201411802351, 5742.397048309951, 5752.856178595548, 5762.798302059428, 4958.231474121517, 5045.167547354718, 5052.191649336089, 5151.665141765773, 5186.896262074775, 19909.9004504978, 20132.698009529868, 20148.697769533468, 20161.294354697515, 20447.182112715473, 2057.8353731701427, 2069.689546568027, 2075.2321640992777, 2093.2568938027084, 2205.900734466953, 12428.440720167615, 12785.936070319589, 12793.55222567215, 12954.740905181843, 13217.273049982246, 1713.9742903856452, 1727.6717423689458, 1741.1642411642356, 1774.5120091974682, 1785.1431312969717, 54459.72770136163, 56714.43285567133, 56969.71515142439, 57151.57060079286, 57244.713776431265, 10093.646722364681, 10127.696169114939, 10162.39025658463, 10179.847302290324, 10195.439250841127, 13249.735005300034, 13279.601611951657, 13313.600591982256, 13324.73350532984, 13325.067865159497, 7138.214796372498, 7145.035420218308, 7154.177269614061, 7206.675699593531, 7258.0, 6710.261871194165, 6724.260331363546, 6755.358240967199, 6776.491763117786, 6782.1861376635115, 4401.735895846259, 4453.866384008485, 4469.374287599739, 4473.3960915276675, 4506.211413002711, 1701.174930158872, 1743.4420985284587, 1766.2934826069418, 1820.2809890093604, 1836.4123480486116, 726.4696771356939, 841.8232171244107, 858.2361698088706, 949.7625593601599, 952.9231967876394, 15776.447824326093, 16101.27544260511, 16889.15554222284, 16913.408030718867, 16999.575010624587, 857.691231156783, 869.6173683579204, 891.6299735609779, 920.374145580998, 965.9130678238852, 7307.981346830513, 9480.525973701288, 9842.950785246172, 9843.75390615226, 9889.406635601743, 504491.0, 511231.0, 514209.0, 521735.0, 541870.0, 59637.0, 74635.25364746392, 76819.16579593418, 77809.22190778134, 78846.0, 1110.245033377311, 1124.578283143821, 1126.932384056959, 1149.609132894803, 1150.2408410449232, 14073.225972571607, 14319.713605727618, 14820.184889831164, 14894.851051489346, 15013.77479337789, 31227.84386078146, 31837.36325273528, 31863.36273274475, 32022.839885800422, 33301.66698332986, 37258.441123383716, 37547.624523755505, 37633.0, 38194.618053819104, 38488.6151138485, 7219.772638651547, 7331.74338898136, 7343.77968660941, 7436.219196984239, 7471.252874712485, 9174.311926605398, 10995.120390368911, 11245.550177993116, 11351.489182986621, 11354.375509347065, 9471.289653275893, 9737.659181928599, 9742.31803773729, 9968.152707019695, 10177.287589868638, 9689.612415503583, 9962.651307204213, 10209.285350025724, 10216.387016779017, 10275.948620256851, 9847.507624618884, 9864.309498335047, 10011.449370284414, 10067.546960386653, 10335.276530642783, 7365.226651201547, 7520.398368130427, 7523.0, 7523.586202758682, 7557.584332861526, 9884.703458896245, 10030.297879148682, 10085.69742907714, 10111.797764044532, 10199.847002294822], "unit": "score", "name": "jquery.html", "value": 8124.2206833121145}, {"lowerIsBetter": false, "replicates": [1287.0540152987546, 1404.0733116143347, 1416.8545828261263, 1417.5322143692579, 1484.3246322923071, 6295.559310848243, 7016.438684905208, 7164.641767911609, 7165.104361954755, 7176.354128128481, 7081.645917704107, 7260.96369518153, 7265.854682906339, 7270.418366530678, 7276.1268647762345, 1890.2816929566745, 1932.8260456558908, 2150.3011521255576, 2189.8576592521476, 2214.579229946305, 2185.672149177628, 2188.6935828983874, 2193.7038499802484, 2195.9011844467036, 2196.077647388093, 2136.7970042845905, 2215.6233440315104, 2229.643257078868, 2233.597952368573, 2236.6533187355985, 2164.2533326002504, 2172.120291282033, 2173.0330003148606, 2229.0, 2231.2079211879714, 2142.2502124256384, 2181.6618424144285, 2198.043850924837, 2198.340497850654, 2201.8128459081, 7341.486095973284, 7424.294692004305, 7431.108267007994, 7438.628068596603, 7445.478816482849, 4400.559944005606, 4495.527969563182, 4497.707649002804, 4527.683062185615, 4530.75080870552, 2777.916662500108, 2834.8157369770897, 2859.985700071507, 2875.1949454152873, 2933.838638874861, 953.4898829126384, 954.6944977607169, 963.0610155098793, 972.2950860626061, 975.9756006099833, 10048.246381521416, 10048.598056077748, 10064.29549931505, 10069.546870390777, 10069.748256293578, 3950.506186726659, 3988.960110398917, 3999.800059981994, 4001.7999100045463, 4071.1654110907193, 8675.522846243392, 8697.956510217535, 8707.651693932172, 8710.12898710124, 8710.433821801562, 4459.9331010034875, 4499.302608095751, 4502.5047244803045, 4505.391772110788, 4505.504394516601, 4134.235166494208, 4144.647704945053, 4145.984233862723, 4149.813258403379, 4151.543330233671, 3248.7888287261253, 3317.834108294576, 3390.711789497871, 3503.0, 3571.499990001402, 1131.6491887514733, 1156.7050402147568, 1159.0727418065683, 1159.5187996981158, 1163.209017867858, 983.8720966274482, 1009.8283291840257, 1169.7485040716288, 1178.3401295274673, 1188.8454500914825, 6787.898181527281, 6845.589264644137, 6874.243833178346, 6876.484263680244, 6879.208890977602, 1018.2617602238317, 1030.0, 1067.492940853104, 1068.369661899483, 1076.8869268726828, 5142.177251639794, 5231.346081739783, 5237.921431178535, 5246.973765131226, 5253.3958594761325, 8504.362172837062, 8772.95613521941, 8789.912100879037, 9061.909380906107, 9065.637374505079, 8684.044755076937, 8747.737567872973, 8750.34372422071, 8764.780880477912, 8764.78088047804, 6902.5858448492245, 6910.619915904573, 7017.438604911595, 7035.50751447404, 7104.857902841914, 6865.41643960269, 6918.654067296515, 6927.168739751262, 6928.618925959121, 6936.4797640176175, 7824.804379890548, 7952.801179970547, 7963.761087167394, 8165.2243036911395, 8169.5098294102545, 8110.553919534483, 8208.302294305051, 8285.627146778288, 8367.539785311623, 8378.413511054412, 6556.246031706415, 6573.04690819838, 6585.6377899216, 6646.867062658816, 6650.800475985729, 6919.308069193041, 6970.581765094111, 7002.7899163025195, 7029.156501219886, 7029.648517574203, 6322.465662041742, 6593.439557637463, 6700.195976482853, 6784.7964561063245, 6797.864042719217, 6554.8361290966195, 6615.338466153346, 6626.701798419179, 6695.09616201826, 6734.09089772894, 6665.900011499734, 6722.6638668065425, 6723.966380168068, 6726.159230096238, 6726.5964042155665, 5808.82573522795, 5865.94134058671, 5880.14737863016, 5880.794172204123, 5914.497267732291, 6078.118672792509, 6124.418180272867, 6127.662978536223, 6141.662208578571, 6147.938520614915], "unit": "score", "name": "mootools.html", "value": 4246.622960964446}, {"lowerIsBetter": false, "replicates": [328.3990297755108, 332.53943288545366, 334.46151695769805, 337.21765504030645, 340.4654692133351, 5765.3369862465825, 5926.5258779297665, 5940.524758019359, 5998.400159984005, 6012.308584512777, 5687.971560142193, 5808.448197421249, 5835.970820145893, 5866.530677545797, 5868.591538030874, 4565.61192298655, 4572.6799124061245, 4577.061702351027, 4579.7252164870215, 4581.862544123682, 4397.516273209944, 4458.0, 4513.458384993805, 4540.77296135192, 4586.8394606188795, 4526.683132180732, 4531.116432295704, 4536.160810250114, 4536.228841097005, 4555.385023021883, 4505.707129036635, 4536.56902594253, 4538.614217791475, 4543.159515489629, 4555.498895121534, 4001.519817621875, 4001.639852413297, 4003.6396724294955, 4004.979975100135, 4005.6595189408936, 5451.700156491392, 5602.411746766572, 5612.102063669793, 5615.803446879339, 5629.183768353607, 5207.557357624606, 5211.973940130313, 5215.426303106655, 5218.76515556797, 5221.634485586011, 5888.499477544414, 6210.254769427653, 6216.2540495140875, 6217.067439884054, 6221.222347206599, 4168.6665066794585, 4226.4716910386205, 4326.480822301312, 4337.674674399433, 4362.149380870732, 6414.390632889868, 6461.0, 6465.1595292611655, 6480.287168411471, 6495.415412612888, 4461.308497182877, 4461.866144015685, 4461.888452788707, 4466.4640243171025, 4466.821327146943, 4444.177827101997, 4480.977595112004, 4518.525554816697, 4518.915460289507, 4532.818687252539, 5212.061828870764, 5242.370915490089, 5245.632805703564, 5246.658967167122, 5250.159974404077, 6236.282827474808, 6239.875202496016, 6240.7503699851495, 6250.468710159596, 6256.217972753406, 1580.0598643806916, 1594.4419453191522, 1595.7367034439187, 1596.4651841632951, 1597.2173634918806, 1058.9727963875182, 1063.5958335832333, 1077.3643550305358, 1077.7090185649831, 1092.7705181911888, 5890.970545147333, 5902.2622172228475, 5902.704864756745, 5903.881922361615, 5904.645721256738, 6438.581492202992, 6440.452561532228, 6441.484681225585, 6457.870842583216, 6512.153420055362, 5897.410258974069, 5898.970505147447, 5900.852478688067, 5901.0558310670085, 5901.852453688606, 3405.914852128667, 3506.4214404623463, 3512.4028915084496, 3517.9120521986642, 3518.3842827505086, 6803.591784492946, 6806.489513286523, 6806.625635589991, 6806.897896531556, 6837.145356830396, 6646.069550262967, 6664.133662623828, 6668.666566671647, 6674.098996635392, 6679.966600167065, 6624.171978502687, 6766.391024807791, 6785.1518560179975, 6787.728490860409, 6805.557638753465, 6232.127502149612, 6393.2328120625825, 6490.870182596227, 6494.675266236574, 6495.610263384212, 6262.185915830913, 6380.489560835029, 6407.935920640734, 6418.0, 6424.421802037652, 6765.830854228684, 6766.458683305422, 6768.796936091925, 6782.796516104525, 6786.219584747817, 4479.350494178391, 4481.350204220435, 4514.864554063383, 4517.209488339593, 4517.954820451753, 6443.7422503101225, 6445.742170313135, 6449.774257900951, 6465.127207826883, 6465.870682586416, 6282.591631543935, 6283.3402492737605, 6295.213098362705, 6296.6851657417865, 6298.307186209605, 6158.661273629993, 6170.10533472635, 6276.686165691606, 6278.215223097113, 6284.937150628435, 6115.327313995546, 6117.021276595723, 6142.140100386039, 6164.3835616438, 6169.136320915165, 6283.994560870239, 6284.340144284784, 6286.591371560834, 6288.811335659938, 6293.559450838397, 6048.60684055535, 6102.938970610415, 6139.109829074849, 6145.938540614716, 6154.78458253959], "unit": "score", "name": "prototype.html", "value": 4729.650839962981}, {"lowerIsBetter": false, "replicates": [628.2774808969688, 681.1281559603706, 769.734441617642, 771.6681826814468, 806.0166596751963, 13041.152325098861, 13189.934050329759, 13204.20774753513, 13209.20744755314, 13227.338633068344, 12416.81374779379, 12485.812712809293, 14103.92948035261, 14258.144511329327, 14279.357428915699, 653.9280679125293, 659.5712786688642, 782.0966783365222, 790.9169537198597, 802.2138304461631, 797.3382092862939, 799.7880561651167, 801.6713147609481, 803.0483876606211, 803.2329125684956, 830.4394533689765, 831.9126491718373, 833.5207255827893, 833.6123702478346, 834.0241916957144, 675.9425448836855, 682.556338380052, 821.9342452603807, 833.5707110837923, 835.1106072033265, 606.1059936593533, 610.7740136149608, 611.0711718188329, 611.3336463255073, 611.4863514647673, 13418.865811341859, 13428.93285533566, 13462.596122116352, 13483.797743033861, 13485.528006519724, 11643.883561164364, 11666.766664666658, 11852.40737963107, 12142.696432589168, 12151.513939442411, 9317.389385139544, 9346.15884570392, 9419.62321507139, 9444.90555094454, 9540.570674319672, 3465.792052476834, 3480.860765569374, 3503.3518799022263, 3510.2102027043966, 3601.0637234319, 45951.31073033907, 47512.52487475116, 47532.76233618845, 47540.28689569659, 47609.0, 9141.908580914105, 9196.08039196075, 9207.928216151313, 9245.214156796614, 9356.251499879992, 17294.654106918042, 17314.740278895828, 17335.393261235797, 17384.217710203073, 17403.390881319094, 7000.474964377692, 7074.92925070753, 7209.855802883913, 7210.062691850026, 7435.665395057235, 3986.421968814506, 4021.678265738734, 4120.21715873983, 4142.2543942090115, 4178.498580170399, 2842.090531030092, 2853.5862299966802, 2857.5713642953306, 2860.156253905103, 2869.6412948381453, 520.1859090523319, 525.0286969107198, 531.6491115863512, 538.5691446842588, 542.2977244468423, 484.5033840313707, 559.6418292292935, 588.8292395205342, 593.92575928009, 601.8736065426309, 7568.735094271784, 7795.376369890395, 7826.2173782621285, 7828.882566761503, 7899.723509677134, 425.8658522565382, 561.7303694226794, 575.3038823024104, 614.1198028873554, 630.334996578614, 3695.872758808589, 3843.8462461501786, 3894.941575876364, 3990.8204130814183, 4009.959900401017, 50719.0, 50935.745321273156, 51005.74497127491, 51156.23265651018, 51203.743981279855, 47805.76097119492, 49653.50346496561, 49965.25052124221, 50045.0, 50108.24837627439, 20115.19539218444, 20276.0, 20285.0, 45159.54840451553, 45832.083358333315, 8070.677172913252, 8336.583170841312, 8487.15128487171, 8522.147785221428, 8567.57162141878, 32121.678783211868, 32523.18692032718, 32744.672553274162, 33130.66869331276, 33180.1704957378, 42743.786281068395, 43162.56837431711, 43548.56451435445, 43707.12585748331, 43947.56052439435, 9525.857112143462, 10126.291159619052, 10311.948440257751, 10463.319884207502, 10666.679999600025, 11470.139739519736, 11517.884821151682, 11645.41772911368, 11649.88350116488, 11733.530658773554, 10862.0, 10935.453227338443, 11007.61473348429, 11286.717832054264, 11568.363739994382, 10170.644027459004, 10177.949110254698, 10679.19906007037, 10698.946505267424, 10707.89292107069, 8091.271785539329, 10869.239153259196, 11105.0, 11146.144098659872, 11286.774264514828, 8836.602352894264, 9178.504023045489, 9305.348625596414, 9638.0, 9736.269779766688, 8615.396922215385, 8996.685116020908, 9023.458592484472, 9123.726288211365, 9212.216961558343], "unit": "score", "name": "yui.html", "value": 5905.460341578897}], "name": "dromaeo_css", "value": 6671.6396313155265}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 110.0, 111.0, 110.0, 99.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 150.0, 162.0, 126.0, 150.0, 149.0, 133.0, 170.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 164.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 99.0, 96.0, 71.0, 75.0, 75.0, 111.0, 97.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 137.0, 96.0, 96.0, 95.0, 141.0, 95.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 97.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 55.0, 55.0, 55.0, 56.0, 55.0, 64.0, 52.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [80.0, 79.0, 81.0, 81.0, 80.0, 89.0, 81.0, 82.0, 82.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [119.0, 124.0, 118.0, 114.0, 111.0, 118.0, 119.0, 117.0, 112.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.5}, {"lowerIsBetter": true, "replicates": [142.0, 143.0, 141.0, 143.0, 143.0, 142.0, 141.0, 142.0, 140.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 68.0, 66.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1487.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [189.8614011771407], "unit": "score", "name": "DeltaBlue", "value": 348.24350599999997}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1956.9471624266146], "unit": "score", "name": "RayTrace", "value": 378.13437900000014}, {"lowerIsBetter": false, "replicates": [768.6395080707148], "unit": "score", "name": "Earley", "value": 867.068363}, {"lowerIsBetter": false, "replicates": [12550.0], "unit": "score", "name": "Boyer", "value": 53.10462151394425}, {"lowerIsBetter": false, "replicates": [41918.36734693877], "unit": "score", "name": "RegExp", "value": 21.732358812074008}, {"lowerIsBetter": false, "replicates": [630.9148264984227], "unit": "score", "name": "Splay", "value": 129.16323500000001}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18831.77788564739}]} 17:12:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18831.78"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1487.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6671.64"}}} 17:12:16 INFO - Return code: 0 17:12:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:12:16 INFO - # TBPL SUCCESS # 17:12:16 INFO - Running post-action listener: _resource_record_post_action 17:12:16 INFO - Running post-run listener: _resource_record_post_run 17:12:17 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 550293504; Read time: 0; Write time: 832664 17:12:17 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 212283392; Read time: 0; Write time: 362176 17:12:17 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 310857728; Read time: 0; Write time: 441124 17:12:17 INFO - Running post-run listener: _upload_blobber_files 17:12:17 INFO - Blob upload gear active. 17:12:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:12:17 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 17:12:17 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:12:17 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:12:17 INFO - (blobuploader) - INFO - Open directory for files ... 17:12:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:12:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:12:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:18 INFO - (blobuploader) - INFO - Done attempting. 17:12:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:12:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:12:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:19 INFO - (blobuploader) - INFO - Done attempting. 17:12:19 INFO - (blobuploader) - INFO - Iteration through files over. 17:12:19 INFO - Return code: 0 17:12:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:12:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:12:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/fa8e2345b0744824d4481655f0e403279f9ba21c8475f77d6fbdaceca8d0471e572d0f196ae66e6d7026b5d803e1585c78f3d5641784e4a5e0e2cb5e6a0afd0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/882495d0e79f5fd5b4cc1644accaac567e5a2e60d203648a2d44df22aad37926da6bcceaf1cc4bbc45543487f89f67b15123aac54ef9fa87b6d50be680236c36"} 17:12:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:12:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:12:19 INFO - Contents: 17:12:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/fa8e2345b0744824d4481655f0e403279f9ba21c8475f77d6fbdaceca8d0471e572d0f196ae66e6d7026b5d803e1585c78f3d5641784e4a5e0e2cb5e6a0afd0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/882495d0e79f5fd5b4cc1644accaac567e5a2e60d203648a2d44df22aad37926da6bcceaf1cc4bbc45543487f89f67b15123aac54ef9fa87b6d50be680236c36"} 17:12:19 INFO - Copying logs to upload dir... 17:12:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1286.362698 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-13 17:12:18.801492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 17:12:18.804841) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/fa8e2345b0744824d4481655f0e403279f9ba21c8475f77d6fbdaceca8d0471e572d0f196ae66e6d7026b5d803e1585c78f3d5641784e4a5e0e2cb5e6a0afd0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/882495d0e79f5fd5b4cc1644accaac567e5a2e60d203648a2d44df22aad37926da6bcceaf1cc4bbc45543487f89f67b15123aac54ef9fa87b6d50be680236c36"} build_url:https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/cTGycgKkQCuIAuqMtscXng/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/B2G-Inbound/sha512/fa8e2345b0744824d4481655f0e403279f9ba21c8475f77d6fbdaceca8d0471e572d0f196ae66e6d7026b5d803e1585c78f3d5641784e4a5e0e2cb5e6a0afd0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/882495d0e79f5fd5b4cc1644accaac567e5a2e60d203648a2d44df22aad37926da6bcceaf1cc4bbc45543487f89f67b15123aac54ef9fa87b6d50be680236c36"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 17:12:18.830096) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 17:12:18.830387) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452732257.862685-1946834386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 17:12:18.915116) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 17:12:18.915422) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 17:12:18.915714) ========= ========= Total master_lag: 0.26 =========