builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1452009209.23 results: success (0) buildid: 20160105053003 builduid: 90f4ad82abb64e3fb59e1e9b35009c3a revision: 434ba9fba9514e36804d0c2041a882951d13075e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.230929) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.231391) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.231692) ========= 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=df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006367 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.302992) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.303402) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.351084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.351448) ========= 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=df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.472711) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.473028) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.473446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.473737) ========= 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=df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 07:53:29-- 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% 219M=0s 2016-01-05 07:53:29 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101848 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.600748) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.601156) ========= 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=df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015674 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:29.651513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 07:53:29.651864) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 434ba9fba9514e36804d0c2041a882951d13075e --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 434ba9fba9514e36804d0c2041a882951d13075e --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=df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 07:53:30,040 truncating revision to first 12 chars 2016-01-05 07:53:30,040 Setting DEBUG logging. 2016-01-05 07:53:30,040 attempt 1/10 2016-01-05 07:53:30,040 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/434ba9fba951?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 07:53:31,362 unpacking tar archive at: b2g-inbound-434ba9fba951/testing/mozharness/ program finished with exit code 0 elapsedTime=1.603298 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 07:53:31.271141) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:31.274498) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:31.286360) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:31.286761) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 07:53:31.287216) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-05 07:53:31.287531) ========= /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=df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:53:31 INFO - MultiFileLogger online at 20160105 07:53:31 in /builds/slave/test-pgo 07:53:31 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 07:53:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:53:31 INFO - {'append_to_log': False, 07:53:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:53:31 INFO - 'blob_upload_branch': 'B2G-Inbound', 07:53:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:53:31 INFO - 'branch': 'B2G-Inbound', 07:53:31 INFO - 'buildbot_json_path': 'buildprops.json', 07:53:31 INFO - 'config_files': ('talos/linux_config.py',), 07:53:31 INFO - 'default_actions': ('clobber', 07:53:31 INFO - 'read-buildbot-config', 07:53:31 INFO - 'download-and-extract', 07:53:31 INFO - 'populate-webroot', 07:53:31 INFO - 'create-virtualenv', 07:53:31 INFO - 'install', 07:53:31 INFO - 'run-tests'), 07:53:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:53:31 INFO - 'download_minidump_stackwalk': True, 07:53:31 INFO - 'download_symbols': 'ondemand', 07:53:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:53:31 INFO - 'tooltool.py': '/tools/tooltool.py', 07:53:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:53:31 INFO - '/tools/misc-python/virtualenv.py')}, 07:53:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:53:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:53:31 INFO - 'installer_path': 'installer.exe', 07:53:31 INFO - 'log_level': 'info', 07:53:31 INFO - 'log_name': 'talos', 07:53:31 INFO - 'log_to_console': True, 07:53:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:53:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:53:31 INFO - 'opt_config_files': (), 07:53:31 INFO - 'pip_index': False, 07:53:31 INFO - 'sps_profile': False, 07:53:31 INFO - 'sps_profile_interval': 0, 07:53:31 INFO - 'suite': 'dromaeojs', 07:53:31 INFO - 'system_bits': '32', 07:53:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:53:31 INFO - 'title': 'talos-linux64-ix-021', 07:53:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:53:31 INFO - 'use_talos_json': True, 07:53:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:53:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:53:31 INFO - 'work_dir': 'build'} 07:53:31 INFO - ##### 07:53:31 INFO - ##### Running clobber step. 07:53:31 INFO - ##### 07:53:31 INFO - Running pre-action listener: _resource_record_pre_action 07:53:31 INFO - Running main action method: clobber 07:53:31 INFO - rmtree: /builds/slave/test-pgo/build 07:53:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:53:32 INFO - Running post-action listener: _resource_record_post_action 07:53:32 INFO - ##### 07:53:32 INFO - ##### Running read-buildbot-config step. 07:53:32 INFO - ##### 07:53:32 INFO - Running pre-action listener: _resource_record_pre_action 07:53:32 INFO - Running main action method: read_buildbot_config 07:53:32 INFO - Using buildbot properties: 07:53:32 INFO - { 07:53:32 INFO - "project": "", 07:53:32 INFO - "product": "firefox", 07:53:32 INFO - "script_repo_revision": "production", 07:53:32 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 07:53:32 INFO - "repository": "", 07:53:32 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 07:53:32 INFO - "buildid": "20160105053003", 07:53:32 INFO - "pgo_build": "True", 07:53:32 INFO - "basedir": "/builds/slave/test-pgo", 07:53:32 INFO - "buildnumber": 182, 07:53:32 INFO - "slavename": "talos-linux64-ix-021", 07:53:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:53:32 INFO - "platform": "ubuntu64_hw", 07:53:32 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 07:53:32 INFO - "branch": "b2g-inbound", 07:53:32 INFO - "repo_path": "integration/b2g-inbound", 07:53:32 INFO - "revision": "434ba9fba9514e36804d0c2041a882951d13075e", 07:53:32 INFO - "stage_platform": "linux64-pgo", 07:53:32 INFO - "builduid": "90f4ad82abb64e3fb59e1e9b35009c3a", 07:53:32 INFO - "slavebuilddir": "test" 07:53:32 INFO - } 07:53:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:53:32 INFO - Running post-action listener: _resource_record_post_action 07:53:32 INFO - ##### 07:53:32 INFO - ##### Running download-and-extract step. 07:53:32 INFO - ##### 07:53:32 INFO - Running pre-action listener: _resource_record_pre_action 07:53:32 INFO - Running main action method: download_and_extract 07:53:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:53: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')]} 07:53:32 INFO - https://queue.taskcluster.net/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:53:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/test_packages.json 07:53:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/test_packages.json 07:53:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:53:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:53:33 INFO - Downloaded 1302 bytes. 07:53:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:53:33 INFO - Using the following test package requirements: 07:53:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:53:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:33 INFO - u'jsshell-linux-x86_64.zip'], 07:53:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:53:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:53:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:53:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:53:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:53:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:33 INFO - https://queue.taskcluster.net/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:53:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/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 07:53:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/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 07:53:34 INFO - Downloaded 24051236 bytes. 07:53:34 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 07:53:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:34 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 07:53:35 INFO - Return code: 0 07:53:35 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 07:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:35 INFO - https://queue.taskcluster.net/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/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 07:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/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 07:53:38 INFO - Downloaded 24051236 bytes. 07:53:38 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 07:53:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:38 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 07:53:39 INFO - Return code: 0 07:53: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')]} 07:53:39 INFO - https://queue.taskcluster.net/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:53:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/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 07:53:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/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 07:53:40 INFO - Downloaded 11132285 bytes. 07:53:40 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 07:53:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:40 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 07:53:41 INFO - Return code: 0 07:53:41 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')]} 07:53:41 INFO - https://queue.taskcluster.net/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:53:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/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 07:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxvaM2sjSYuRDCeRO7OSqg/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 07:53:44 INFO - Downloaded 54992138 bytes. 07:53:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:44 INFO - mkdir: /builds/slave/test-pgo/properties 07:53:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:53:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:53:44 INFO - Contents: 07:53:44 INFO - build_url:https://queue.taskcluster.net/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:44 INFO - Running post-action listener: _resource_record_post_action 07:53:44 INFO - Running post-action listener: set_extra_try_arguments 07:53:44 INFO - ##### 07:53:44 INFO - ##### Running populate-webroot step. 07:53:44 INFO - ##### 07:53:44 INFO - Running pre-action listener: _resource_record_pre_action 07:53:44 INFO - Running main action method: populate_webroot 07:53:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:53:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:53:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:53:44 INFO - '--tppagecycles', 07:53:44 INFO - '7'], 07:53:44 INFO - 'tests': ['tsvgm']}}, 07:53:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:53:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:53:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:53:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:53:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:53:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:53:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:44 INFO - 'talos_options': ['--e10s'], 07:53:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:44 INFO - 'tests': ['damp', 'tps']}, 07:53:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:44 INFO - 'talos_options': ['--e10s'], 07:53:44 INFO - 'tests': ['damp', 'tps']}, 07:53:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:53:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:53:44 INFO - 'other': {'tests': ['a11yr', 07:53:44 INFO - 'ts_paint', 07:53:44 INFO - 'tpaint', 07:53:44 INFO - 'sessionrestore', 07:53:44 INFO - 'sessionrestore_no_auto_restore']}, 07:53:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:53:44 INFO - 'tests': ['a11yr', 07:53:44 INFO - 'ts_paint', 07:53:44 INFO - 'tpaint', 07:53:44 INFO - 'sessionrestore', 07:53:44 INFO - 'sessionrestore_no_auto_restore']}, 07:53:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:53:44 INFO - 'tests': ['a11yr', 07:53:44 INFO - 'ts_paint', 07:53:44 INFO - 'tpaint', 07:53:44 INFO - 'sessionrestore', 07:53:44 INFO - 'sessionrestore_no_auto_restore']}, 07:53:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:53:44 INFO - 'tests': ['a11yr', 07:53:44 INFO - 'ts_paint', 07:53:44 INFO - 'tpaint', 07:53:44 INFO - 'sessionrestore', 07:53:44 INFO - 'sessionrestore_no_auto_restore']}, 07:53:44 INFO - 'other_l64': {'tests': ['a11yr', 07:53:44 INFO - 'ts_paint', 07:53:44 INFO - 'tpaint', 07:53:44 INFO - 'sessionrestore', 07:53:44 INFO - 'sessionrestore_no_auto_restore']}, 07:53:44 INFO - 'other_nol64': {'tests': ['a11yr', 07:53:44 INFO - 'ts_paint', 07:53:44 INFO - 'tpaint', 07:53:44 INFO - 'sessionrestore', 07:53:44 INFO - 'sessionrestore_no_auto_restore']}, 07:53:44 INFO - 'svgr': {'tests': ['tsvgx', 07:53:44 INFO - 'tsvgr_opacity', 07:53:44 INFO - 'tart', 07:53:44 INFO - 'tscrollx', 07:53:44 INFO - 'cart']}, 07:53:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:53:44 INFO - 'tests': ['tsvgx', 07:53:44 INFO - 'tsvgr_opacity', 07:53:44 INFO - 'tart', 07:53:44 INFO - 'tscrollx', 07:53:44 INFO - 'cart']}, 07:53:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:44 INFO - 'tests': ['tp5o']}, 07:53:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:44 INFO - 'talos_options': ['--e10s'], 07:53:44 INFO - 'tests': ['tp5o']}, 07:53:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:44 INFO - 'talos_options': ['--xperf_path', 07:53:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:44 INFO - 'tests': ['tp5n']}, 07:53:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:44 INFO - 'talos_options': ['--e10s', 07:53:44 INFO - '--xperf_path', 07:53:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:44 INFO - 'tests': ['tp5n']}}, 07:53:44 INFO - 'talos.zip': {'path': '', 07:53:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:53:44 INFO - Running post-action listener: _resource_record_post_action 07:53:44 INFO - ##### 07:53:44 INFO - ##### Running create-virtualenv step. 07:53:44 INFO - ##### 07:53:44 INFO - Running pre-action listener: _resource_record_pre_action 07:53:44 INFO - Running main action method: create_virtualenv 07:53:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:53:44 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 07:53:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:53:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:53:44 INFO - Using real prefix '/usr' 07:53:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:53:45 INFO - Installing distribute.............................................................................................................................................................................................done. 07:53:47 INFO - Installing pip.................done. 07:53:47 INFO - Return code: 0 07:53:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:47 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 0x7f7ee38fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2309630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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 0x23076b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2307b60>, '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': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', '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 07:53:47 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 07:53:47 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 07:53:47 INFO - Using env: {'DISPLAY': ':0', 07:53:47 INFO - 'HOME': '/home/cltbld', 07:53:47 INFO - 'LANG': 'en_US.UTF-8', 07:53:47 INFO - 'LANGUAGE': 'en_US:en', 07:53:47 INFO - 'LOGNAME': 'cltbld', 07:53:47 INFO - 'MAIL': '/var/mail/cltbld', 07:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:47 INFO - 'MOZ_NO_REMOTE': '1', 07:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:47 INFO - 'NO_EM_RESTART': '1', 07:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:47 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:47 INFO - 'SHELL': '/bin/bash', 07:53:47 INFO - 'SHLVL': '1', 07:53:47 INFO - 'TERM': 'linux', 07:53:47 INFO - 'TMOUT': '86400', 07:53:47 INFO - 'USER': 'cltbld', 07:53:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', 07:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:47 INFO - '_': '/tools/buildbot/bin/python'} 07:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:47 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 07:53:47 INFO - Cleaning up... 07:53:47 INFO - Return code: 0 07:53:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:47 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 0x7f7ee38fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2309630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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 0x23076b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2307b60>, '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': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', '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 07:53:47 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 07:53:47 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 07:53:47 INFO - Using env: {'DISPLAY': ':0', 07:53:47 INFO - 'HOME': '/home/cltbld', 07:53:47 INFO - 'LANG': 'en_US.UTF-8', 07:53:47 INFO - 'LANGUAGE': 'en_US:en', 07:53:47 INFO - 'LOGNAME': 'cltbld', 07:53:47 INFO - 'MAIL': '/var/mail/cltbld', 07:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:47 INFO - 'MOZ_NO_REMOTE': '1', 07:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:47 INFO - 'NO_EM_RESTART': '1', 07:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:47 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:47 INFO - 'SHELL': '/bin/bash', 07:53:47 INFO - 'SHLVL': '1', 07:53:47 INFO - 'TERM': 'linux', 07:53:47 INFO - 'TMOUT': '86400', 07:53:47 INFO - 'USER': 'cltbld', 07:53:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', 07:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:47 INFO - '_': '/tools/buildbot/bin/python'} 07:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:47 INFO - Downloading/unpacking psutil>=0.7.1 07:53:47 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 07:53:47 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 07:53:47 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 07:53:47 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 07:53:47 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 07:53:47 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 07:53:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:53:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:53:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:53:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:49 INFO - Installing collected packages: psutil 07:53:49 INFO - Running setup.py install for psutil 07:53:49 INFO - building 'psutil._psutil_linux' extension 07:53:49 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 07:53:49 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 07:53:49 INFO - building 'psutil._psutil_posix' extension 07:53:49 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 07:53:49 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 07:53:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:49 INFO - Successfully installed psutil 07:53:49 INFO - Cleaning up... 07:53:49 INFO - Return code: 0 07:53:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:53:49 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')]} 07:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:49 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')]} 07:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:49 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 0x7f7ee38fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2309630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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 0x23076b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2307b60>, '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': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', '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 07:53:49 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 07:53:49 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 07:53:49 INFO - Using env: {'DISPLAY': ':0', 07:53:49 INFO - 'HOME': '/home/cltbld', 07:53:49 INFO - 'LANG': 'en_US.UTF-8', 07:53:49 INFO - 'LANGUAGE': 'en_US:en', 07:53:49 INFO - 'LOGNAME': 'cltbld', 07:53:49 INFO - 'MAIL': '/var/mail/cltbld', 07:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:49 INFO - 'MOZ_NO_REMOTE': '1', 07:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:49 INFO - 'NO_EM_RESTART': '1', 07:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:49 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:49 INFO - 'SHELL': '/bin/bash', 07:53:49 INFO - 'SHLVL': '1', 07:53:49 INFO - 'TERM': 'linux', 07:53:49 INFO - 'TMOUT': '86400', 07:53:49 INFO - 'USER': 'cltbld', 07:53:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', 07:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:49 INFO - '_': '/tools/buildbot/bin/python'} 07:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:53:50 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 07:53:50 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 07:53:50 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 07:53:50 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 07:53:50 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 07:53:50 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 07:53:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:53:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:53:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:53:51 INFO - Installing collected packages: mozsystemmonitor 07:53:51 INFO - Running setup.py install for mozsystemmonitor 07:53:51 INFO - Successfully installed mozsystemmonitor 07:53:51 INFO - Cleaning up... 07:53:51 INFO - Return code: 0 07:53:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:51 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 0x7f7ee38fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2309630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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 0x23076b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2307b60>, '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': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', '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 07:53:51 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 07:53:51 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 07:53:51 INFO - Using env: {'DISPLAY': ':0', 07:53:51 INFO - 'HOME': '/home/cltbld', 07:53:51 INFO - 'LANG': 'en_US.UTF-8', 07:53:51 INFO - 'LANGUAGE': 'en_US:en', 07:53:51 INFO - 'LOGNAME': 'cltbld', 07:53:51 INFO - 'MAIL': '/var/mail/cltbld', 07:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:51 INFO - 'MOZ_NO_REMOTE': '1', 07:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:51 INFO - 'NO_EM_RESTART': '1', 07:53:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:51 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:51 INFO - 'SHELL': '/bin/bash', 07:53:51 INFO - 'SHLVL': '1', 07:53:51 INFO - 'TERM': 'linux', 07:53:51 INFO - 'TMOUT': '86400', 07:53:51 INFO - 'USER': 'cltbld', 07:53:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', 07:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:51 INFO - '_': '/tools/buildbot/bin/python'} 07:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:52 INFO - Downloading/unpacking blobuploader==1.2.4 07:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:53 INFO - Downloading blobuploader-1.2.4.tar.gz 07:53:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:53:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:53:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:53:53 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 07:53:53 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 07:53:53 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 07:53:53 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 07:53:53 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 07:53:53 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 07:53:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:53:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:53:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:53:54 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 07:53:54 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 07:53:54 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 07:53:54 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 07:53:54 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 07:53:54 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 07:53:54 INFO - Downloading docopt-0.6.1.tar.gz 07:53:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:53:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:53:54 INFO - Installing collected packages: blobuploader, requests, docopt 07:53:54 INFO - Running setup.py install for blobuploader 07:53:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:53:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:53:54 INFO - Running setup.py install for requests 07:53:54 INFO - Running setup.py install for docopt 07:53:55 INFO - Successfully installed blobuploader requests docopt 07:53:55 INFO - Cleaning up... 07:53:55 INFO - Return code: 0 07:53:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:53: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')]} 07:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:55 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 0x7f7ee38fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2309630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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 0x23076b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2307b60>, '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': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', '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 07:53:55 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 07:53:55 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 07:53:55 INFO - Using env: {'DISPLAY': ':0', 07:53:55 INFO - 'HOME': '/home/cltbld', 07:53:55 INFO - 'LANG': 'en_US.UTF-8', 07:53:55 INFO - 'LANGUAGE': 'en_US:en', 07:53:55 INFO - 'LOGNAME': 'cltbld', 07:53:55 INFO - 'MAIL': '/var/mail/cltbld', 07:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:55 INFO - 'MOZ_NO_REMOTE': '1', 07:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:55 INFO - 'NO_EM_RESTART': '1', 07:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:55 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:55 INFO - 'SHELL': '/bin/bash', 07:53:55 INFO - 'SHLVL': '1', 07:53:55 INFO - 'TERM': 'linux', 07:53:55 INFO - 'TMOUT': '86400', 07:53:55 INFO - 'USER': 'cltbld', 07:53:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', 07:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:55 INFO - '_': '/tools/buildbot/bin/python'} 07:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:55 INFO - Running setup.py (path:/tmp/pip-GgAALK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:55 INFO - Running setup.py (path:/tmp/pip-6daYGf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:55 INFO - Running setup.py (path:/tmp/pip-CdKuDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:55 INFO - Running setup.py (path:/tmp/pip-Wnbigw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:55 INFO - Running setup.py (path:/tmp/pip-twFbeT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:55 INFO - Running setup.py (path:/tmp/pip-T0hjNf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:55 INFO - Running setup.py (path:/tmp/pip-HPe8pL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:55 INFO - Running setup.py (path:/tmp/pip-dn4HG3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:55 INFO - Running setup.py (path:/tmp/pip-3TqAEs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:56 INFO - Running setup.py (path:/tmp/pip-GREGwC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:56 INFO - Running setup.py (path:/tmp/pip-3ZSeS4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:56 INFO - Running setup.py (path:/tmp/pip-s05FtS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:56 INFO - Running setup.py (path:/tmp/pip-3FMwlt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:56 INFO - Running setup.py (path:/tmp/pip-Xx_qO_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:56 INFO - Running setup.py (path:/tmp/pip-0nGkmc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:56 INFO - Running setup.py (path:/tmp/pip-dvkonJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:56 INFO - Running setup.py (path:/tmp/pip-yHsD_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:53:56 INFO - Running setup.py install for manifestparser 07:53:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:53:56 INFO - Running setup.py install for mozcrash 07:53:56 INFO - Running setup.py install for mozdebug 07:53:56 INFO - Running setup.py install for mozdevice 07:53:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Running setup.py install for mozfile 07:53:57 INFO - Running setup.py install for mozhttpd 07:53:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Running setup.py install for mozinfo 07:53:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Running setup.py install for mozInstall 07:53:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Running setup.py install for mozleak 07:53:57 INFO - Running setup.py install for mozlog 07:53:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Running setup.py install for moznetwork 07:53:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Running setup.py install for mozprocess 07:53:57 INFO - Running setup.py install for mozprofile 07:53:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:53:57 INFO - Running setup.py install for mozrunner 07:53:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:53:58 INFO - Running setup.py install for mozscreenshot 07:53:58 INFO - Running setup.py install for moztest 07:53:58 INFO - Running setup.py install for mozversion 07:53:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:53:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:53:58 INFO - Cleaning up... 07:53:58 INFO - Return code: 0 07:53:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:53: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')]} 07:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:58 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 0x7f7ee38fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2309630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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 0x23076b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2307b60>, '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': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', '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 07:53:58 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 07:53:58 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 07:53:58 INFO - Using env: {'DISPLAY': ':0', 07:53:58 INFO - 'HOME': '/home/cltbld', 07:53:58 INFO - 'LANG': 'en_US.UTF-8', 07:53:58 INFO - 'LANGUAGE': 'en_US:en', 07:53:58 INFO - 'LOGNAME': 'cltbld', 07:53:58 INFO - 'MAIL': '/var/mail/cltbld', 07:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:58 INFO - 'MOZ_NO_REMOTE': '1', 07:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:58 INFO - 'NO_EM_RESTART': '1', 07:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:58 INFO - 'SHELL': '/bin/bash', 07:53:58 INFO - 'SHLVL': '1', 07:53:58 INFO - 'TERM': 'linux', 07:53:58 INFO - 'TMOUT': '86400', 07:53:58 INFO - 'USER': 'cltbld', 07:53:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', 07:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:58 INFO - '_': '/tools/buildbot/bin/python'} 07:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:58 INFO - Running setup.py (path:/tmp/pip-DRK2x6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:58 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)) 07:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:58 INFO - Running setup.py (path:/tmp/pip-5XHkC2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:58 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)) 07:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:58 INFO - Running setup.py (path:/tmp/pip-MuI9lS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:58 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)) 07:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:58 INFO - Running setup.py (path:/tmp/pip-IRgHQy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 07:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:58 INFO - Running setup.py (path:/tmp/pip-R2Tdic-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:58 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)) 07:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:58 INFO - Running setup.py (path:/tmp/pip-0gLu0L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:59 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)) 07:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:59 INFO - Running setup.py (path:/tmp/pip-Oe2WPG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:59 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)) 07:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:59 INFO - Running setup.py (path:/tmp/pip-zMcufg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:59 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)) 07:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:59 INFO - Running setup.py (path:/tmp/pip-_L7E30-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:59 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)) 07:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:59 INFO - Running setup.py (path:/tmp/pip-wXPO9N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:59 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)) 07:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:59 INFO - Running setup.py (path:/tmp/pip-8y1ceh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:59 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)) 07:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:59 INFO - Running setup.py (path:/tmp/pip-boawu2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:59 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)) 07:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:59 INFO - Running setup.py (path:/tmp/pip-knAapn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:59 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)) 07:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:59 INFO - Running setup.py (path:/tmp/pip-qmHHwU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:59 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)) 07:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:59 INFO - Running setup.py (path:/tmp/pip-Bi4VZM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:59 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)) 07:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:59 INFO - Running setup.py (path:/tmp/pip-Wht8BQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:59 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)) 07:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:59 INFO - Running setup.py (path:/tmp/pip-djzNfn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:59 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)) 07:53:59 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)) 07:53:59 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)) 07:53:59 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)) 07:53:59 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:53:59 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:53:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:01 INFO - Downloading blessings-1.5.1.tar.gz 07:54:01 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 07:54:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:54:01 INFO - Installing collected packages: blessings 07:54:01 INFO - Running setup.py install for blessings 07:54:01 INFO - Successfully installed blessings 07:54:01 INFO - Cleaning up... 07:54:01 INFO - Return code: 0 07:54:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:54:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:54:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:54:01 INFO - Reading from file tmpfile_stdout 07:54:01 INFO - Current package versions: 07:54:01 INFO - argparse == 1.2.1 07:54:01 INFO - blessings == 1.5.1 07:54:01 INFO - blobuploader == 1.2.4 07:54:01 INFO - docopt == 0.6.1 07:54:01 INFO - manifestparser == 1.1 07:54:01 INFO - mozInstall == 1.12 07:54:01 INFO - mozcrash == 0.16 07:54:01 INFO - mozdebug == 0.1 07:54:01 INFO - mozdevice == 0.47 07:54:01 INFO - mozfile == 1.2 07:54:01 INFO - mozhttpd == 0.7 07:54:01 INFO - mozinfo == 0.9 07:54:01 INFO - mozleak == 0.1 07:54:01 INFO - mozlog == 3.1 07:54:01 INFO - moznetwork == 0.27 07:54:01 INFO - mozprocess == 0.22 07:54:01 INFO - mozprofile == 0.28 07:54:01 INFO - mozrunner == 6.11 07:54:01 INFO - mozscreenshot == 0.1 07:54:01 INFO - mozsystemmonitor == 0.0 07:54:01 INFO - moztest == 0.7 07:54:01 INFO - mozversion == 1.4 07:54:01 INFO - psutil == 3.1.1 07:54:01 INFO - requests == 1.2.3 07:54:01 INFO - wsgiref == 0.1.2 07:54:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:54:01 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')]} 07:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:01 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')]} 07:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:01 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 0x7f7ee38fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2309630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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 0x23076b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2307b60>, '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': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', '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 07:54:01 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 07:54:01 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 07:54:01 INFO - Using env: {'DISPLAY': ':0', 07:54:01 INFO - 'HOME': '/home/cltbld', 07:54:01 INFO - 'LANG': 'en_US.UTF-8', 07:54:01 INFO - 'LANGUAGE': 'en_US:en', 07:54:01 INFO - 'LOGNAME': 'cltbld', 07:54:01 INFO - 'MAIL': '/var/mail/cltbld', 07:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:01 INFO - 'MOZ_NO_REMOTE': '1', 07:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:01 INFO - 'NO_EM_RESTART': '1', 07:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 07:54:01 INFO - 'SHELL': '/bin/bash', 07:54:01 INFO - 'SHLVL': '1', 07:54:01 INFO - 'TERM': 'linux', 07:54:01 INFO - 'TMOUT': '86400', 07:54:01 INFO - 'USER': 'cltbld', 07:54:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', 07:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:01 INFO - '_': '/tools/buildbot/bin/python'} 07:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:02 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)) 07:54:02 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)) 07:54:02 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)) 07:54:02 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)) 07:54:02 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)) 07:54:02 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)) 07:54:02 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)) 07:54:02 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)) 07:54:02 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)) 07:54:02 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)) 07:54:02 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)) 07:54:02 INFO - Cleaning up... 07:54:02 INFO - Return code: 0 07:54:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:02 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 0x7f7ee38fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2309630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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 0x23076b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2307b60>, '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': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', '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 07:54:02 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 07:54:02 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 07:54:02 INFO - Using env: {'DISPLAY': ':0', 07:54:02 INFO - 'HOME': '/home/cltbld', 07:54:02 INFO - 'LANG': 'en_US.UTF-8', 07:54:02 INFO - 'LANGUAGE': 'en_US:en', 07:54:02 INFO - 'LOGNAME': 'cltbld', 07:54:02 INFO - 'MAIL': '/var/mail/cltbld', 07:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:02 INFO - 'MOZ_NO_REMOTE': '1', 07:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:02 INFO - 'NO_EM_RESTART': '1', 07:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:54:02 INFO - 'PWD': '/builds/slave/test-pgo', 07:54:02 INFO - 'SHELL': '/bin/bash', 07:54:02 INFO - 'SHLVL': '1', 07:54:02 INFO - 'TERM': 'linux', 07:54:02 INFO - 'TMOUT': '86400', 07:54:02 INFO - 'USER': 'cltbld', 07:54:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', 07:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:02 INFO - '_': '/tools/buildbot/bin/python'} 07:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:02 INFO - Downloading/unpacking jsonschema 07:54:02 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 07:54:02 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 07:54:02 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 07:54:02 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 07:54:02 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 07:54:02 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 07:54:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:54:04 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 07:54:04 INFO - Downloading/unpacking functools32 (from jsonschema) 07:54:04 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 07:54:04 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 07:54:04 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 07:54:04 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 07:54:04 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 07:54:04 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 07:54:04 INFO - Downloading functools32-3.2.3-2.tar.gz 07:54:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:54:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:54:04 INFO - warning: no files found matching '*.txt' 07:54:04 INFO - no previously-included directories found matching 'build' 07:54:04 INFO - no previously-included directories found matching 'dist' 07:54:04 INFO - no previously-included directories found matching '.git*' 07:54:04 INFO - Installing collected packages: jsonschema, functools32 07:54:04 INFO - Running setup.py install for functools32 07:54:04 INFO - warning: no files found matching '*.txt' 07:54:04 INFO - no previously-included directories found matching 'build' 07:54:04 INFO - no previously-included directories found matching 'dist' 07:54:04 INFO - no previously-included directories found matching '.git*' 07:54:04 INFO - Successfully installed jsonschema functools32 07:54:04 INFO - Cleaning up... 07:54:04 INFO - Return code: 0 07:54:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:54:04 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')]} 07:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:04 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')]} 07:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:04 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 0x7f7ee38fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2309630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a840>, '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 0x23076b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2307b60>, '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': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', '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 07:54:04 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 07:54:04 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 07:54:04 INFO - Using env: {'DISPLAY': ':0', 07:54:04 INFO - 'HOME': '/home/cltbld', 07:54:04 INFO - 'LANG': 'en_US.UTF-8', 07:54:04 INFO - 'LANGUAGE': 'en_US:en', 07:54:04 INFO - 'LOGNAME': 'cltbld', 07:54:04 INFO - 'MAIL': '/var/mail/cltbld', 07:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:04 INFO - 'MOZ_NO_REMOTE': '1', 07:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:04 INFO - 'NO_EM_RESTART': '1', 07:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:54:04 INFO - 'PWD': '/builds/slave/test-pgo', 07:54:04 INFO - 'SHELL': '/bin/bash', 07:54:04 INFO - 'SHLVL': '1', 07:54:04 INFO - 'TERM': 'linux', 07:54:04 INFO - 'TMOUT': '86400', 07:54:04 INFO - 'USER': 'cltbld', 07:54:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', 07:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:04 INFO - '_': '/tools/buildbot/bin/python'} 07:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:04 INFO - Downloading/unpacking flake8 07:54:04 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 07:54:04 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 07:54:04 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 07:54:04 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 07:54:04 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 07:54:04 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 07:54:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:54:06 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 07:54:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:54:06 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 07:54:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:06 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 07:54:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:54:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:54:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:54:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:54:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:54:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:54:07 INFO - no previously-included directories found matching 'docs/_build' 07:54:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:54:07 INFO - Running setup.py install for pep8 07:54:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:54:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:54:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:54:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:54:07 INFO - no previously-included directories found matching 'docs/_build' 07:54:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:54:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:54:07 INFO - Cleaning up... 07:54:07 INFO - Return code: 0 07:54:07 INFO - Running post-action listener: _resource_record_post_action 07:54:07 INFO - Running post-action listener: _start_resource_monitoring 07:54:07 INFO - Starting resource monitoring. 07:54:07 INFO - ##### 07:54:07 INFO - ##### Running install step. 07:54:07 INFO - ##### 07:54:07 INFO - Running pre-action listener: _resource_record_pre_action 07:54:07 INFO - Running main action method: install 07:54:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:54:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:54:07 INFO - Reading from file tmpfile_stdout 07:54:07 INFO - Detecting whether we're running mozinstall >=1.0... 07:54:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:54:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:54:07 INFO - Reading from file tmpfile_stdout 07:54:07 INFO - Output received: 07:54:07 INFO - Usage: mozinstall [options] installer 07:54:07 INFO - Options: 07:54:07 INFO - -h, --help show this help message and exit 07:54:07 INFO - -d DEST, --destination=DEST 07:54:07 INFO - Directory to install application into. [default: 07:54:07 INFO - "/builds/slave/test-pgo"] 07:54:07 INFO - --app=APP Application being installed. [default: firefox] 07:54:07 INFO - mkdir: /builds/slave/test-pgo/build/application 07:54:07 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'] 07:54:07 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 07:54:23 INFO - Reading from file tmpfile_stdout 07:54:23 INFO - Output received: 07:54:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:54:23 INFO - Running post-action listener: _resource_record_post_action 07:54:23 INFO - ##### 07:54:23 INFO - ##### Running run-tests step. 07:54:23 INFO - ##### 07:54:23 INFO - Running pre-action listener: _resource_record_pre_action 07:54:23 INFO - Running main action method: run_tests 07:54:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:54:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:54:23 INFO - Python 2.7.3 07:54:23 INFO - Return code: 0 07:54:23 INFO - grabbing minidump binary from tooltool 07:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:23 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 0x239a840>, '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 0x23076b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2307b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:54:23 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 07:54:23 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 07:54:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:54:23 INFO - Return code: 0 07:54:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:54:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:54:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:54:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:54:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:54:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:54:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:54:24 INFO - Return code: 0 07:54:24 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/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 07:54:24 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/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 07:54:24 INFO - Using env: {'DISPLAY': ':0', 07:54:24 INFO - 'HOME': '/home/cltbld', 07:54:24 INFO - 'LANG': 'en_US.UTF-8', 07:54:24 INFO - 'LANGUAGE': 'en_US:en', 07:54:24 INFO - 'LOGNAME': 'cltbld', 07:54:24 INFO - 'MAIL': '/var/mail/cltbld', 07:54:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:54:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:24 INFO - 'MOZ_NO_REMOTE': '1', 07:54:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:24 INFO - 'NO_EM_RESTART': '1', 07:54:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:54:24 INFO - 'PWD': '/builds/slave/test-pgo', 07:54:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:54:24 INFO - 'SHELL': '/bin/bash', 07:54:24 INFO - 'SHLVL': '1', 07:54:24 INFO - 'TERM': 'linux', 07:54:24 INFO - 'TMOUT': '86400', 07:54:24 INFO - 'USER': 'cltbld', 07:54:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378', 07:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:24 INFO - '_': '/tools/buildbot/bin/python'} 07:54:24 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/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 07:54:24 INFO - mozversion application_buildid: 20160105053003 07:54:24 INFO - mozversion application_changeset: 434ba9fba9514e36804d0c2041a882951d13075e 07:54:24 INFO - mozversion application_display_name: Nightly 07:54:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:54:24 INFO - mozversion application_name: Firefox 07:54:24 INFO - mozversion application_remotingname: firefox 07:54:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 07:54:24 INFO - mozversion application_vendor: Mozilla 07:54:24 INFO - mozversion application_version: 46.0a1 07:54:24 INFO - mozversion platform_buildid: 20160105053003 07:54:24 INFO - mozversion platform_changeset: 434ba9fba9514e36804d0c2041a882951d13075e 07:54:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 07:54:24 INFO - mozversion platform_version: 46.0a1 07:54:24 INFO - using testdate: 1452009264 07:54:24 INFO - actual date: 1452009264 07:54:24 INFO - starting webserver on 'localhost:41540' 07:54:24 INFO - SUITE-START | Running 3 tests 07:54:24 INFO - TEST-START | dromaeo_css 07:54:24 INFO - operating with platform_type : linux_ 07:54:24 INFO - Initialising browser for dromaeo_css test... 07:54:24 INFO - TEST-INFO | started process 30887 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2l7OHP/profile http://localhost:41540/getInfo.html) 07:54:29 INFO - PROCESS | 30887 | __metrics Screen width/height:1600/1200 07:54:29 INFO - PROCESS | 30887 | colorDepth:24 07:54:29 INFO - PROCESS | 30887 | Browser inner width/height: 1024/697 07:54:29 INFO - PROCESS | 30887 | __metrics 07:54:29 INFO - PROCESS | 30887 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:54:29 INFO - PROCESS | 30887 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:30 INFO - TEST-INFO | 30887: exit 0 07:54:30 INFO - Browser initialized. 07:54:30 INFO - Running cycle 1/1 for dromaeo_css test... 07:54:30 INFO - TEST-INFO | started process 30980 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2l7OHP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:42 INFO - PROCESS | 30980 | RSS: Main: 149606400 07:54:42 INFO - PROCESS | 30980 | 07:55:34 INFO - PROCESS | 30980 | 1452009334011 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] 07:57:42 INFO - PROCESS | 30980 | Cycle 1(1): loaded http://localhost:41540/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41540/tests/dromaeo/cssquery-ext.html) 07:57:43 INFO - PROCESS | 30980 | RSS: Main: 239767552 07:57:43 INFO - PROCESS | 30980 | 08:00:45 INFO - PROCESS | 30980 | Cycle 1(1): loaded http://localhost:41540/tests/dromaeo/cssquery-ext.html (next: http://localhost:41540/tests/dromaeo/cssquery-jquery.html) 08:00:46 INFO - PROCESS | 30980 | RSS: Main: 239456256 08:00:46 INFO - PROCESS | 30980 | 08:03:48 INFO - PROCESS | 30980 | Cycle 1(1): loaded http://localhost:41540/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41540/tests/dromaeo/cssquery-mootools.html) 08:03:48 INFO - PROCESS | 30980 | RSS: Main: 225189888 08:03:48 INFO - PROCESS | 30980 | 08:06:50 INFO - PROCESS | 30980 | Cycle 1(1): loaded http://localhost:41540/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41540/tests/dromaeo/cssquery-prototype.html) 08:06:51 INFO - PROCESS | 30980 | RSS: Main: 217366528 08:06:51 INFO - PROCESS | 30980 | 08:09:53 INFO - PROCESS | 30980 | Cycle 1(1): loaded http://localhost:41540/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41540/tests/dromaeo/cssquery-yui.html) 08:09:54 INFO - PROCESS | 30980 | RSS: Main: 220721152 08:09:54 INFO - PROCESS | 30980 | 08:12:56 INFO - PROCESS | 30980 | Cycle 1(1): loaded http://localhost:41540/tests/dromaeo/cssquery-yui.html (next: http://localhost:41540/tests/dromaeo/cssquery-dojo.html) 08:12:57 INFO - PROCESS | 30980 | RSS: Main: 287703040 08:12:57 INFO - PROCESS | 30980 | 08:12:57 INFO - PROCESS | 30980 | __start_tp_report 08:12:57 INFO - PROCESS | 30980 | _x_x_mozilla_page_load 08:12:57 INFO - PROCESS | 30980 | _x_x_mozilla_page_load_details 08:12:57 INFO - PROCESS | 30980 | |i|pagename|runs| 08:12:57 INFO - PROCESS | 30980 | |0;dojo.html;3059.770517211209;3121.282105115825;3161.130689060508;3172.0959526534944;3188.1551388881935;4993.525615066572;5062.392512898448;5116.079105760961;5125.333706618135;5125.513076257755;5059.747012649362;5134.537891589756;5141.537261646451;5194.065068287707;5211.687298762067;4695.788689508971;4713;4718.952810471903;4780.3307536944685;4788.377510923575;4583.793729282191;4776.379070720802;4783.61731061516;4799.760011999386;4856.878578035542;4706.858794236178;4709.458412282597;4778.37881075458;4781.832635857728;4809.398825146856;4733.905321893543;4735.95264047362;4741.502142275081;4753.144434001878;4778.522147785228;4636.142313671948;4735.644826637981;4739;4742.359781429497;4794.232922732346;4973.825916092919;5003.2995380646735;5054.772535235923;5061.342025536694;5070.771815268285;5541.085720856054;5548.9722551386985;5558.277423934863;5558.583106267046;5578.414266501999;5360.437154098802;5447.046766815792;5590.329160500725;5608.046632072516;5659;5184.403793563751;5217.139172036609;5233.790648374023;5235.58115350771;5290.497402746733;5614.522765564972;5654.717264136777;5657.858553536194;5667.121596152603;5669.744861481243;5290.814821481306;5387.407385187705;5393.4336894626285;5465.945340546623;5469.863253418617;5470.316210473691;5547.528460080857;5551.500364967092;5552.888942221133;5569.582281328835;5508.283923090053;5518.91721624176;5521.4478552145265;5521.779128834802;5525.585581081355;5338.46615338463;5511.917321240105;5521.282233309644;5524.66851988882;5528.889422211533;4227.682923780729;4288.48538175421;4290.914181716348;4308.67684923632;4324.221640104748;3858.7105967052585;3861.304965106308;3866.420036994417;3899.5710471848074;3899.6490315871706;5167.948320516822;5169.974150129226;5170;5171.01750667372;5171.870703232449;5356.116240820299;5415.6479828811;5425.565954723613;5507.807226747124;5535.125222989586;5187.922181167285;5214.243934629458;5221.503957124067;5221.738913054332;5224.947750522522;4800.039992001613;4809.735464549483;4811.4707382187935;4815.085133824562;4856.028794241166;5478.260434841325;5524.696141712164;5584.804531841366;5629.324481062299;5695.658260504383;5550.333959924835;5558.249636299048;5558.861028474321;5577.3028371453565;5595.384507704068;5640.4077571856005;5646.124850648156;5649.830505084854;5650.350209725934;5651.265335506358;5355.946440535545;5450.046241907571;5450.1007333789485;5455.0726376515295;5488.945110549003;5512.062949298549;5546.889062218814;5570.331560212639;5571.832845014656;5576.275084239023;5334.866628334323;5381.13901775714;5385.757640906247;5446.400895901527;5454.563634909277;5392.838214853561;5400.2439658447065;5402.270693456333;5402.891942161214;5405.5135037846785;5279.736013199402;5323.148296272578;5328.520433161034;5338.172583249602;5377.27406800077;5307.389650190277;5412.079946409041;5415.106507426231;5459.017376872042;5459.2902922619805;5340.759665815125;5343.62594618373;5382.919256211082;5384.380796208487;5385.192221166856 08:12:57 INFO - PROCESS | 30980 | |1;ext.html;529.9735013249341;531.4234056049187;545.8853640735446;553.6290685240886;556.9665820050798;28746.28134296641;36437.271254574895;36949.26101477969;37014.629853701525;37091;39665.40501892474;40000.599994000055;40085;40090.79954600223;40100;7287.963560182192;8472.322214222848;8579.742607721779;8615.698450554231;8620.956895215515;7381;10116.19070474364;10307.63923262686;10323.896761032369;10331.690049298495;9994.9500252499;10060.849087263698;10117.544710488046;10118.089371956523;10119.241056920724;7545.69817207311;7661.387089032864;9963.45201013944;10060.295779295453;10113.292069555135;9835.754106147331;9873.90126098737;9976.650817221362;9985.650502232387;9990.050945160197;36089.63910360889;36475.81762091199;36694.449583256275;36717.63282367169;36919;3165.7467402607735;3189.61724593048;3300.3399320135827;3493.7205023598053;3526.3299973005046;28275.57586636202;28879.422411551863;30504.694953050628;30745.385092298027;31669.683303166905;3952.9011774705573;3961.1681546875193;3996.660283875874;4021.6727337740126;4056.533498647634;259823;261095.9999999981;261244;262197;264277;52003;52912;55245.89508209813;60414;62091.37908620856;54941.1758823618;54988.72505637446;55179.44820551743;55247.447525525036;55303.17045244244;15067.397304107932;15195.62010949713;15197.924010380098;15253.313600887986;15293.005954612914;10945.124390048777;10996.175286853519;11075.280106793032;11088.33469991803;11183.161262905152;19965.900170499055;20670;20686.79313206879;20715.585688286148;20733.481662958548;7842.372610191171;7938.444308898437;8005.599720014093;8012.719554815553;8079.353651707849;951.3293128344501;975.2831668723483;990.4453506036499;998.7836595037767;1067.926733632694;27982.300442488693;28267.71732282692;28380;28589.85705071503;28602.28494287618;1030.7268573827942;1036.3315661398506;1045.2996492350144;1073.951672174754;1119.3228097001197;13878.375473103735;14053.086549374259;14608.34262458192;14634.926825365805;14965.476208332657;348209;353614;354594;354770;355102;51238;51824.74087629538;51836.149011804715;51892.48107518952;51936;1395.0583356234501;1399.2024546008881;1411.9082259653296;1412.8445870954188;1418.8155539779968;25620.487590247718;26555;27318.453630926873;27599;27629.171124866287;46219;46814.531854681016;46845.53154468412;46924;46927.765361174344;294054;295218;296791;297149;297471;28193.43613127685;28930.566041509814;32232.35535289234;32740.508892366157;33215.83392083121;38994.61005390023;39548;47556.52443475521;48456.48177749259;48907.75546122246;34529.65470345365;34570.30859382748;34607.30785384329;35160.47259291164;35923.82038089793;34993.47509787406;34999;35165.82417087898;35432;35589.46615800713;33183;37232.627673724;37964.2407151861;37974;38067.23865522619;28879;31007.449627518083;33726;34005.65994340025;34020.31959360749;24117.91469383917;24392.75607243976;24669.876650616632;24843;25104.246872593852 08:12:57 INFO - PROCESS | 30980 | |2;jquery.html;352.8958957107653;359.6762913377961;361.4650317530055;363.4439307858975;367.18301778542747;14188.787168192459;14242.430302787876;15847;16597.33610655574;18190.181441835117;15962.201889905487;16307.103109328982;16634.83365166351;16710.498685039438;16727.665446691088;5151.69089854609;5406.513413792758;5415.702136382497;5415.783368665248;5422.647527910693;4037.454943582623;4128.401381799637;5390.865228369283;5419.593530485229;5837.649741015532;5888.499477544414;5917.171595976567;5934.258217722785;5942.970285148568;5943.64338139713;5739.053056245714;5854.18041474194;5884.941150588482;5901.4098590141075;5902.8819423611285;5219.373675159005;5232.895342093137;5237.921431178535;5238.188080847437;5238.423773384925;19434.416967490997;19999.800002000084;20039.398818035483;21174.894125529427;21194.788052119435;2025.8581899267058;2059.3204242600054;2111.567128738605;2155;2195.067096483988;9243.214326782232;9366.53167341637;9595.13643772064;11689.357085360301;11791.528338866436;1751.9299228030864;1784.3308759215295;1786.6158775863253;1815.7730283714536;1830.6979348407497;52506.47493525054;61473.07790383103;62620.37379626191;62789;62823;9509.381890177254;9628.037196280316;9647.13175814166;9662.516874156405;9725.319227654138;12815;12878.227306361461;12925.54760583375;12945.805812912813;13020.283884386261;6996.055532503149;7072.328128827753;7187.7843664690145;7217.639118044077;7229.349358557755;7015.052967849275;7021.262767409451;7037.155541334971;7050.92949070513;7126.144862616519;4061.7766022868436;4323.78381080951;4368.388425620416;4439.711418757771;4480.843170489017;1646.209819286749;1675.4471024561865;1688.763573099767;1691.9407820726215;1704.4545745361613;837.8952630921135;911.129870973219;968.8256113899565;982.1419668763863;1046.9371837689764;15594.688106237812;16567.00597964126;17396;17419.12904354777;17829.821701783076;828.9690258865803;847.894013248344;920.1442658327686;943.4527973775193;1011.1556850030307;8657;9020.233280171127;9071.591778369857;9104.180623743763;9170.266378689688;516002;519000;520775;533931;535194;42341.36487952683;76693;79713;80448.59775701202;80932;1120.3389999900098;1134.2967360236541;1136.63059505661;1151.1193936638479;1151.1999160583314;15168.24158792078;15358;15382.461613843461;15553.68892622164;15661;19161;19448;31190.688093118777;35714.821425892704;35756;44519.777401112784;46138.769306153255;47370.289445657654;47688.2846757292;49363;8800.823983520422;9168.258030974093;9473;9606.567704453177;9629.903700963181;16528.504144875675;16757.32970681159;16999.49001529956;17160;17230.396936107176;10911.890881091405;13335.733285334432;13438.731225375243;13682.794758078438;14154.292285385483;13842.639568535878;14133.505327313494;14719;14872.33074511628;15028.474003409829;9586.568604412958;9799.902000980184;9943.502824858873;9950.950245248727;14299.928500357431;14503.274836258355;14545.563633091024;14778.704425911206;15051.924740376666;15087.54737357837;14522.128672279698;14582.85417145815;14695.412183512968;14734.410623575366;15738 08:12:57 INFO - PROCESS | 30980 | |3;mootools.html;1299.6555912683148;1408.3240044778506;1434.1538492289546;1533.93097310621;1755.56110972257;6614.371634694702;7304.671289791959;7404.703811847527;7409.036825212715;7423.331900128987;7114.359707626312;7279.381252593523;7311.086114235721;7318.670659820307;7321.3410793028615;1919.4721451600783;1950.4441234248243;1955.5208973801439;2218.7004754358195;2248.898799554024;2211.657193135067;2251.324602619216;2251.7748225177515;2254.5716313900307;2256.8307376946714;2163.610550100981;2204.603171429142;2212.4911270407815;2220.433789383705;2224.2993457061057;2176.227439259056;2205.0738689750265;2221.133757834446;2223.43302457873;2244.371575958734;2227.376334626291;2236.6421372580307;2257.9661305080435;2259.5254996450767;2265.1958554713005;7581.507202031906;7660.923390766076;7676.846463070708;7677.923220767777;7681.193474685134;4487.596116349544;4526.705764125321;4529.2526733089;4537.183307004738;4544.931826022612;2957.763378929702;2965.733084022448;2992.970070299291;2997.775166862494;3097.7831551791382;935.1536859142487;937.8030613571158;945.9337846350758;1007.0885848307221;1012.9797404051951;10241.436720980342;10267.589296428134;10331.638392656221;10358.326708763907;10392.532336044897;3812.1994381179707;3859.112404147062;3862.9806850965565;3895.7662540247675;3918.921621567553;8937.776555586162;8944.552772361356;8946.239569636524;8965.596548155218;8983.55082245885;4456.77716114193;4458.576435238647;4460.197164510354;4460.888477788017;4463.352813841975;4013.1171142348635;4040.1919616076902;4049.190161967618;4068.959310406917;4078.4290199372113;3319.0706602151436;3396.269801992534;3473.14907847579;3485.6165821759587;3555.982220088883;1134.6709454258173;1136.3125309187988;1137.7041969088098;1140.646399616105;1147.862256529222;1023.8976102389702;1033.4832583708146;1093.557109370706;1150.2753265442718;1279.7632437999;6828.556143850634;6875.759348422881;6908;6932.930670693329;6938;1086.4187659602076;1097.6706987903756;1100.4937728644752;1113.0483436661539;1118.5302173087323;5576.693281869455;5686.3744988051285;5690.6870122142855;5698.031334673115;5698.202251684767;8935.776605584912;8989.741436198938;9134.725958221265;9249;9306.348555601044;9166.54167291646;9188.8621670675;9213.447193168431;9218.723438296862;9225.031371706009;6944.687489063004;7111.146662400545;7133.536320139175;7144.035555200086;7161.319674630901;6919.515633905578;6934.7226110955;6950.895736563854;6961.269066748121;6969.58182509051;7794.113243704497;8168.795780105307;8172.7956801080445;8191.13993030747;8354.498730076215;8308.5430301334;8415.621297041525;8539.274161696325;8567.186117318844;8593.484390936565;6750.6624668767345;6769.898451523132;6926.619035952869;6931.896021559782;6942.132233470817;6432.678366081584;6555.967220163869;7072.115985501812;7167.498275120692;7426.702931882664;6689.698963546554;6781.321867813179;6825.146856642919;6902.551334163263;7055.400290975119;6702.095217145623;6724.73101075971;6738.2587915328295;6811.761588344384;6836;6826.795196143925;6864.656767161722;6872.278410766798;6872.62200578973;6881.552699074544;6044.516438684983;6154.599951003171;6293.811185664437;6311.084892690626;6315.5894866833505;6174.351693072163;6187.010078387617;6210.4100110489435;6212.596181248205;6220.160278362363 08:12:57 INFO - PROCESS | 30980 | |4;prototype.html;325.62553063976424;340.6151049314275;343.80231366964;344.76900476680623;355.5839667588921;5813.941860581393;5849.766009359631;5919.319278282998;5923.022701254288;5929.555283353744;5535.778568857241;5680.0627896397045;5703.657780533171;5705.657660540371;5775.249217601717;4426.136903303857;4431.26884064129;4493.101379724052;4504.076664283831;4519.5932366087045;4526.6831321807485;4532.682712210147;4537.364768932335;4552.772361381918;4556.407667003285;4236.173946080516;4359.738415695053;4510.684252102355;4511.120331535352;4514.232580461329;4374.956250437503;4464.419625448703;4467.374567560544;4484.977575112103;4489.932651010205;3961.623645753649;3965.8810235692977;3966.484357033596;3980.4626375439234;3981.303271927401;5484.643498172606;5496.80761173357;5502.8349149525575;5505.504504594565;5570.944290557123;4990.775415106329;5151.227315902607;5234.555062819665;5250.553702935255;5252.921206181873;6091.817245482643;6128.111423843562;6140.171076904606;6152.87694246117;6157.507399408037;4333.501647310568;4334.501532323791;4335.588119128678;4336.457942757155;4339.500957389878;6359.713812878385;6426.485881129498;6430.485561155097;6440.25937017249;6441.677916104176;4279.893002674958;4422.71252368595;4422.933655995098;4428.490723566831;4443.844465443694;4476;4479.328100784843;4482.910341793146;4483.977580112079;4487.416635837386;5156.458571849977;5162.74186290684;5170.8190213343105;5170.8965820684125;5178.97410512945;6194.194754681863;6197.504199664107;6208;6208.875822483525;6209.410106039919;1531.8468153184592;1583.0185285123298;1586.912719800422;1587.8491543303367;1590.300267882128;1050.3540322701483;1065.7761870007384;1078.449990504848;1086.3916206923989;1090.1224514265934;5834.387389324144;5873.119032145127;5882.088276317178;5888.322842873039;5891.970540147272;6347.714352854133;6348.492120630339;6352.396522330371;6361.968190159112;6369.33122022181;5713.885722285531;5788.739506722208;5855.770288239432;5872.471477567039;5880.617759845596;3395.1342407686375;3455.2398472336045;3471.149568355769;3475.1138459692615;3480.7911525308564;6601;6605.636689982001;6612.471002319803;6614.10709554204;6614.206295244601;6446.806595802133;6509.609423434609;6564.704588293538;6574;6574.474042076622;6504.317046710027;6523.282438931714;6527.02094685801;6529.771457998947;6570.737170513126;6368.140301059298;6379.266384365672;6382.5851319665935;6383.96808015957;6390.360963903759;6159.322474527888;6321.747130114744;6348.428641422294;6363.745450181941;6371.936280637135;6532.8366790830605;6543.476521878143;6577.572457790228;6614.669266536558;6615.900761488678;4446.488653804725;4487.259602165606;4488.079943611617;4488.708233964782;4495.977520112378;6425.325340839145;6445.742170313135;6452.451541619015;6457.4511166551365;6464.353564643686;6059.757609695739;6220.595661282002;6238.875222495615;6285.685715714288;6291.213598300213;6249.718762655601;6257.78097766576;6263.1857858479925;6269.905951410824;6275.592086514362;6057.1519987200945;6168.290646575701;6175.96912015437;6177.84555386119;6178.41305076017;6246.156768836149;6273.811785646438;6287.842803929939;6291.685415729286;6293.276273228455;6131.693415329305;6140.785072522441;6141.201643786279;6142.385761423822;6146.78486252979 08:12:57 INFO - PROCESS | 30980 | |5;yui.html;828.4946182828477;848.5036253791532;850.8808766772653;863.6631713631683;863.9654413823447;13159.07886447949;13394.999999999987;13400.932995335033;13415.396307166176;13436.932815335935;12681.239125652444;12734.490620375196;12748.2988435636;12751.617451476448;12767;801.459015164763;830.0413022958493;836.067784420373;837.4891316297054;837.5519097282925;690.5960013392172;694.9061876646664;830.2610676497922;844.3625063077368;846.1834329871673;858.4634603372892;864.5072308783996;869.5347988825979;869.613022205119;869.7129947117436;858.1161403754144;858.2576071697998;858.7509622209552;858.9699360522383;859.2481578618708;517.4308260913003;526.0215998243265;633.3381616211025;640.3788325324474;648.8702259548062;13206.933965330112;13256.86743132566;13268.867311326956;13334.066615336931;13352.666183345495;10744.086752626035;11276.548938042468;11379.601713939972;11970.461329240117;12404.069694772928;10170.237232207613;10174.135198508136;10194.388336699822;10330.845037324447;10592.841107383396;3560.9109772255642;3605.405108157151;3607.621199774012;3645.6172101929446;3673.742838001341;47523.762381188215;47890;47960.760196199146;47987.280190797166;48105.51894481081;9603.711888643353;9740.220782337537;9754.365966212174;9775.315727898978;10039.04629060238;17462.388816391365;17654.470365889043;17678.204480798395;17696.203670834842;17725.911370443064;7521.285477879593;7553.244675532403;7623.275788800055;7851.646675899598;7862.2923936845955;4338.436003319548;4367.67242456817;4369.191699535596;4380.802863871133;4417.226985277628;3032.499637559778;3100.5194194899827;3105.9223519412194;3114.065780265911;3116.6883311668653;560.842963970089;561.1890817768367;569.8917205730897;574.0241589298209;585.5930128560694;592.62960649594;634.6223996721943;640.9743610255538;641.6855740687123;644.5810223354763;7859.449838511364;7949.960250198712;8070.445327952272;8083.878741818878;8512;441.24547024587673;483.9395075615548;524.1001370033628;550.6365798572923;631.7125707802938;3527;3754.342989976798;3984.242993831163;4042.939355909664;4061.817218225187;52415.21377179345;52602;53617;53779.731101344245;54597.1810422844;49130.75434622804;50346.496535034916;50612;50955.745221274396;51040.489595104315;44681;45207.54792452099;45667.314990275176;46765.29852052222;46950.53049469461;7940.404469664682;7994.960025199837;8159.918400815915;8216.424850260664;8261.1325810789;33357.66642333643;33712.66287337095;34040.31919361549;34202.48696269508;34929.825350873085;42458.57541424546;42818;43128.78435607802;43307.56692433036;43327.566724332355;10463.21525885577;10919.181061420266;11121.332720036824;11212.719682008015;11311.886881131084;10204.4387558685;10447.477626118512;10543.630972915911;10833.729156771144;10858.34849909008;10826.296290741077;10832.079273261861;11162.720931976766;11196.944015280198;11199.552017919192;11199.72000699989;11294.887051129384;11657.591984280849;11862.347570883685;12031.63905082849;11356.54573817038;11384.48769805344;11428.542858285575;11457.167971871557;11791.115666325231;8742.635550726187;8839.646414143619;8900.198982091642;8955.149260820212;9103.271738261055;8283.58582070906;8681.826363472821;9105.317101217302;9166.266698664223;9287.210587100171 08:12:57 INFO - PROCESS | 30980 | __end_tp_report 08:12:57 INFO - PROCESS | 30980 | __start_cc_report 08:12:57 INFO - PROCESS | 30980 | _x_x_mozilla_cycle_collect,1098 08:12:57 INFO - PROCESS | 30980 | __end_cc_report 08:12:57 INFO - PROCESS | 30980 | __startTimestamp1452010377235__endTimestamp 08:12:57 INFO - PROCESS | 30980 | 08:12:57 INFO - PROCESS | 30980 | ------- Summary: start ------- 08:12:57 INFO - PROCESS | 30980 | Number of tests: 6 08:12:57 INFO - PROCESS | 30980 | 08:12:57 INFO - PROCESS | 30980 | [#0] dojo.html Cycles:165 Average:5138.73 Median:5338.47 stddev:542.89 (10.2%) stddev-sans-first:519.48 08:12:57 INFO - PROCESS | 30980 | Values: 3059.8 3121.3 3161.1 3172.1 3188.2 4993.5 5062.4 5116.1 5125.3 5125.5 5059.7 5134.5 5141.5 5194.1 5211.7 4695.8 4713.0 4719.0 4780.3 4788.4 4583.8 4776.4 4783.6 4799.8 4856.9 4706.9 4709.5 4778.4 4781.8 4809.4 4733.9 4736.0 4741.5 4753.1 4778.5 4636.1 4735.6 4739.0 4742.4 4794.2 4973.8 5003.3 5054.8 5061.3 5070.8 5541.1 5549.0 5558.3 5558.6 5578.4 5360.4 5447.0 5590.3 5608.0 5659.0 5184.4 5217.1 5233.8 5235.6 5290.5 5614.5 5654.7 5657.9 5667.1 5669.7 5290.8 5387.4 5393.4 5465.9 5469.9 5470.3 5547.5 5551.5 5552.9 5569.6 5508.3 5518.9 5521.4 5521.8 5525.6 5338.5 5511.9 5521.3 5524.7 5528.9 4227.7 4288.5 4290.9 4308.7 4324.2 3858.7 3861.3 3866.4 3899.6 3899.6 5167.9 5170.0 5170.0 5171.0 5171.9 5356.1 5415.6 5425.6 5507.8 5535.1 5187.9 5214.2 5221.5 5221.7 5224.9 4800.0 4809.7 4811.5 4815.1 4856.0 5478.3 5524.7 5584.8 5629.3 5695.7 5550.3 5558.2 5558.9 5577.3 5595.4 5640.4 5646.1 5649.8 5650.4 5651.3 5355.9 5450.0 5450.1 5455.1 5488.9 5512.1 5546.9 5570.3 5571.8 5576.3 5334.9 5381.1 5385.8 5446.4 5454.6 5392.8 5400.2 5402.3 5402.9 5405.5 5279.7 5323.1 5328.5 5338.2 5377.3 5307.4 5412.1 5415.1 5459.0 5459.3 5340.8 5343.6 5382.9 5384.4 5385.2 08:12:57 INFO - PROCESS | 30980 | 08:12:57 INFO - PROCESS | 30980 | [#1] ext.html Cycles:180 Average:46829.30 Median:19243.60 stddev:80116.76 (416.3%) stddev-sans-first:80266.09 08:12:57 INFO - PROCESS | 30980 | Values: 530.0 531.4 545.9 553.6 557.0 28746.3 36437.3 36949.3 37014.6 37091.0 39665.4 40000.6 40085.0 40090.8 40100.0 7288.0 8472.3 8579.7 8615.7 8621.0 7381.0 10116.2 10307.6 10323.9 10331.7 9995.0 10060.8 10117.5 10118.1 10119.2 7545.7 7661.4 9963.5 10060.3 10113.3 9835.8 9873.9 9976.7 9985.7 9990.1 36089.6 36475.8 36694.4 36717.6 36919.0 3165.7 3189.6 3300.3 3493.7 3526.3 28275.6 28879.4 30504.7 30745.4 31669.7 3952.9 3961.2 3996.7 4021.7 4056.5 259823.0 261096.0 261244.0 262197.0 264277.0 52003.0 52912.0 55245.9 60414.0 62091.4 54941.2 54988.7 55179.4 55247.4 55303.2 15067.4 15195.6 15197.9 15253.3 15293.0 10945.1 10996.2 11075.3 11088.3 11183.2 19965.9 20670.0 20686.8 20715.6 20733.5 7842.4 7938.4 8005.6 8012.7 8079.4 951.3 975.3 990.4 998.8 1067.9 27982.3 28267.7 28380.0 28589.9 28602.3 1030.7 1036.3 1045.3 1074.0 1119.3 13878.4 14053.1 14608.3 14634.9 14965.5 348209.0 353614.0 354594.0 354770.0 355102.0 51238.0 51824.7 51836.1 51892.5 51936.0 1395.1 1399.2 1411.9 1412.8 1418.8 25620.5 26555.0 27318.5 27599.0 27629.2 46219.0 46814.5 46845.5 46924.0 46927.8 294054.0 295218.0 296791.0 297149.0 297471.0 28193.4 28930.6 32232.4 32740.5 33215.8 38994.6 39548.0 47556.5 48456.5 48907.8 34529.7 34570.3 34607.3 35160.5 35923.8 34993.5 34999.0 35165.8 35432.0 35589.5 33183.0 37232.6 37964.2 37974.0 38067.2 28879.0 31007.4 33726.0 34005.7 34020.3 24117.9 24392.8 24669.9 24843.0 25104.2 08:12:57 INFO - PROCESS | 30980 | 08:12:57 INFO - PROCESS | 30980 | [#2] jquery.html Cycles:180 Average:28019.91 Median:4049.62 stddev:85721.57 (2116.8%) stddev-sans-first:85936.87 08:12:57 INFO - PROCESS | 30980 | Values: 352.9 359.7 361.5 363.4 367.2 14188.8 14242.4 15847.0 16597.3 18190.2 15962.2 16307.1 16634.8 16710.5 16727.7 5151.7 5406.5 5415.7 5415.8 5422.6 4037.5 4128.4 5390.9 5419.6 5837.6 5888.5 5917.2 5934.3 5943.0 5943.6 5739.1 5854.2 5884.9 5901.4 5902.9 5219.4 5232.9 5237.9 5238.2 5238.4 19434.4 19999.8 20039.4 21174.9 21194.8 2025.9 2059.3 2111.6 2155.0 2195.1 9243.2 9366.5 9595.1 11689.4 11791.5 1751.9 1784.3 1786.6 1815.8 1830.7 52506.5 61473.1 62620.4 62789.0 62823.0 9509.4 9628.0 9647.1 9662.5 9725.3 12815.0 12878.2 12925.5 12945.8 13020.3 6996.1 7072.3 7187.8 7217.6 7229.3 7015.1 7021.3 7037.2 7050.9 7126.1 4061.8 4323.8 4368.4 4439.7 4480.8 1646.2 1675.4 1688.8 1691.9 1704.5 837.9 911.1 968.8 982.1 1046.9 15594.7 16567.0 17396.0 17419.1 17829.8 829.0 847.9 920.1 943.5 1011.2 8657.0 9020.2 9071.6 9104.2 9170.3 516002.0 519000.0 520775.0 533931.0 535194.0 42341.4 76693.0 79713.0 80448.6 80932.0 1120.3 1134.3 1136.6 1151.1 1151.2 15168.2 15358.0 15382.5 15553.7 15661.0 19161.0 19448.0 31190.7 35714.8 35756.0 44519.8 46138.8 47370.3 47688.3 49363.0 8800.8 9168.3 9473.0 9606.6 9629.9 16528.5 16757.3 16999.5 17160.0 17230.4 10911.9 13335.7 13438.7 13682.8 14154.3 13842.6 14133.5 14719.0 14872.3 15028.5 9586.6 9799.9 9943.5 9951.0 14299.9 14503.3 14545.6 14778.7 15051.9 15087.5 14522.1 14582.9 14695.4 14734.4 15738.0 08:12:57 INFO - PROCESS | 30980 | 08:12:57 INFO - PROCESS | 30980 | [#3] mootools.html Cycles:180 Average:5272.91 Median:6198.71 stddev:2747.03 (44.3%) stddev-sans-first:2738.50 08:12:57 INFO - PROCESS | 30980 | Values: 1299.7 1408.3 1434.2 1533.9 1755.6 6614.4 7304.7 7404.7 7409.0 7423.3 7114.4 7279.4 7311.1 7318.7 7321.3 1919.5 1950.4 1955.5 2218.7 2248.9 2211.7 2251.3 2251.8 2254.6 2256.8 2163.6 2204.6 2212.5 2220.4 2224.3 2176.2 2205.1 2221.1 2223.4 2244.4 2227.4 2236.6 2258.0 2259.5 2265.2 7581.5 7660.9 7676.8 7677.9 7681.2 4487.6 4526.7 4529.3 4537.2 4544.9 2957.8 2965.7 2993.0 2997.8 3097.8 935.2 937.8 945.9 1007.1 1013.0 10241.4 10267.6 10331.6 10358.3 10392.5 3812.2 3859.1 3863.0 3895.8 3918.9 8937.8 8944.6 8946.2 8965.6 8983.6 4456.8 4458.6 4460.2 4460.9 4463.4 4013.1 4040.2 4049.2 4069.0 4078.4 3319.1 3396.3 3473.1 3485.6 3556.0 1134.7 1136.3 1137.7 1140.6 1147.9 1023.9 1033.5 1093.6 1150.3 1279.8 6828.6 6875.8 6908.0 6932.9 6938.0 1086.4 1097.7 1100.5 1113.0 1118.5 5576.7 5686.4 5690.7 5698.0 5698.2 8935.8 8989.7 9134.7 9249.0 9306.3 9166.5 9188.9 9213.4 9218.7 9225.0 6944.7 7111.1 7133.5 7144.0 7161.3 6919.5 6934.7 6950.9 6961.3 6969.6 7794.1 8168.8 8172.8 8191.1 8354.5 8308.5 8415.6 8539.3 8567.2 8593.5 6750.7 6769.9 6926.6 6931.9 6942.1 6432.7 6556.0 7072.1 7167.5 7426.7 6689.7 6781.3 6825.1 6902.6 7055.4 6702.1 6724.7 6738.3 6811.8 6836.0 6826.8 6864.7 6872.3 6872.6 6881.6 6044.5 6154.6 6293.8 6311.1 6315.6 6174.4 6187.0 6210.4 6212.6 6220.2 08:12:57 INFO - PROCESS | 30980 | 08:12:57 INFO - PROCESS | 30980 | [#4] prototype.html Cycles:180 Average:5186.02 Median:5864.12 stddev:1549.88 (26.4%) stddev-sans-first:1510.68 08:12:57 INFO - PROCESS | 30980 | Values: 325.6 340.6 343.8 344.8 355.6 5813.9 5849.8 5919.3 5923.0 5929.6 5535.8 5680.1 5703.7 5705.7 5775.2 4426.1 4431.3 4493.1 4504.1 4519.6 4526.7 4532.7 4537.4 4552.8 4556.4 4236.2 4359.7 4510.7 4511.1 4514.2 4375.0 4464.4 4467.4 4485.0 4489.9 3961.6 3965.9 3966.5 3980.5 3981.3 5484.6 5496.8 5502.8 5505.5 5570.9 4990.8 5151.2 5234.6 5250.6 5252.9 6091.8 6128.1 6140.2 6152.9 6157.5 4333.5 4334.5 4335.6 4336.5 4339.5 6359.7 6426.5 6430.5 6440.3 6441.7 4279.9 4422.7 4422.9 4428.5 4443.8 4476.0 4479.3 4482.9 4484.0 4487.4 5156.5 5162.7 5170.8 5170.9 5179.0 6194.2 6197.5 6208.0 6208.9 6209.4 1531.8 1583.0 1586.9 1587.8 1590.3 1050.4 1065.8 1078.4 1086.4 1090.1 5834.4 5873.1 5882.1 5888.3 5892.0 6347.7 6348.5 6352.4 6362.0 6369.3 5713.9 5788.7 5855.8 5872.5 5880.6 3395.1 3455.2 3471.1 3475.1 3480.8 6601.0 6605.6 6612.5 6614.1 6614.2 6446.8 6509.6 6564.7 6574.0 6574.5 6504.3 6523.3 6527.0 6529.8 6570.7 6368.1 6379.3 6382.6 6384.0 6390.4 6159.3 6321.7 6348.4 6363.7 6371.9 6532.8 6543.5 6577.6 6614.7 6615.9 4446.5 4487.3 4488.1 4488.7 4496.0 6425.3 6445.7 6452.5 6457.5 6464.4 6059.8 6220.6 6238.9 6285.7 6291.2 6249.7 6257.8 6263.2 6269.9 6275.6 6057.2 6168.3 6176.0 6177.8 6178.4 6246.2 6273.8 6287.8 6291.7 6293.3 6131.7 6140.8 6141.2 6142.4 6146.8 08:12:57 INFO - PROCESS | 30980 | 08:12:57 INFO - PROCESS | 30980 | [#5] yui.html Cycles:180 Average:13393.66 Median:46857.91 stddev:15445.31 (33.0%) stddev-sans-first:15459.81 08:12:57 INFO - PROCESS | 30980 | Values: 828.5 848.5 850.9 863.7 864.0 13159.1 13395.0 13400.9 13415.4 13436.9 12681.2 12734.5 12748.3 12751.6 12767.0 801.5 830.0 836.1 837.5 837.6 690.6 694.9 830.3 844.4 846.2 858.5 864.5 869.5 869.6 869.7 858.1 858.3 858.8 859.0 859.2 517.4 526.0 633.3 640.4 648.9 13206.9 13256.9 13268.9 13334.1 13352.7 10744.1 11276.5 11379.6 11970.5 12404.1 10170.2 10174.1 10194.4 10330.8 10592.8 3560.9 3605.4 3607.6 3645.6 3673.7 47523.8 47890.0 47960.8 47987.3 48105.5 9603.7 9740.2 9754.4 9775.3 10039.0 17462.4 17654.5 17678.2 17696.2 17725.9 7521.3 7553.2 7623.3 7851.6 7862.3 4338.4 4367.7 4369.2 4380.8 4417.2 3032.5 3100.5 3105.9 3114.1 3116.7 560.8 561.2 569.9 574.0 585.6 592.6 634.6 641.0 641.7 644.6 7859.4 7950.0 8070.4 8083.9 8512.0 441.2 483.9 524.1 550.6 631.7 3527.0 3754.3 3984.2 4042.9 4061.8 52415.2 52602.0 53617.0 53779.7 54597.2 49130.8 50346.5 50612.0 50955.7 51040.5 44681.0 45207.5 45667.3 46765.3 46950.5 7940.4 7995.0 8159.9 8216.4 8261.1 33357.7 33712.7 34040.3 34202.5 34929.8 42458.6 42818.0 43128.8 43307.6 43327.6 10463.2 10919.2 11121.3 11212.7 11311.9 10204.4 10447.5 10543.6 10833.7 10858.3 10826.3 10832.1 11162.7 11196.9 11199.6 11199.7 11294.9 11657.6 11862.3 12031.6 11356.5 11384.5 11428.5 11457.2 11791.1 8742.6 8839.6 8900.2 8955.1 9103.3 8283.6 8681.8 9105.3 9166.3 9287.2 08:12:57 INFO - PROCESS | 30980 | -------- Summary: end -------- 08:12:57 INFO - PROCESS | 30980 | 08:12:57 INFO - TEST-INFO | 30980: exit 0 08:12:57 INFO - TEST-OK | dromaeo_css | took 1113233ms 08:12:57 INFO - TEST-START | kraken 08:12:57 INFO - operating with platform_type : linux_ 08:12:57 INFO - Initialising browser for kraken test... 08:12:57 INFO - TEST-INFO | started process 31170 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7pfXgR/profile http://localhost:41540/getInfo.html) 08:13:02 INFO - PROCESS | 31170 | __metrics Screen width/height:1600/1200 08:13:02 INFO - PROCESS | 31170 | colorDepth:24 08:13:02 INFO - PROCESS | 31170 | Browser inner width/height: 1024/697 08:13:02 INFO - PROCESS | 31170 | __metrics 08:13:02 INFO - PROCESS | 31170 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:13:02 INFO - PROCESS | 31170 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:13:03 INFO - TEST-INFO | 31170: exit 0 08:13:03 INFO - Browser initialized. 08:13:03 INFO - Running cycle 1/1 for kraken test... 08:13:03 INFO - TEST-INFO | started process 31258 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7pfXgR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:15 INFO - PROCESS | 31258 | RSS: Main: 150151168 08:13:15 INFO - PROCESS | 31258 | 08:13:17 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41540/tests/kraken/driver.html?testName=audio-beat-detection) 08:13:18 INFO - PROCESS | 31258 | RSS: Main: 185344000 08:13:18 INFO - PROCESS | 31258 | 08:13:21 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41540/tests/kraken/driver.html?testName=audio-dft) 08:13:21 INFO - PROCESS | 31258 | RSS: Main: 174567424 08:13:21 INFO - PROCESS | 31258 | 08:13:24 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41540/tests/kraken/driver.html?testName=audio-fft) 08:13:25 INFO - PROCESS | 31258 | RSS: Main: 159457280 08:13:25 INFO - PROCESS | 31258 | 08:13:27 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41540/tests/kraken/driver.html?testName=audio-oscillator) 08:13:27 INFO - PROCESS | 31258 | RSS: Main: 163196928 08:13:27 INFO - PROCESS | 31258 | 08:13:29 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41540/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:13:30 INFO - PROCESS | 31258 | RSS: Main: 165376000 08:13:30 INFO - PROCESS | 31258 | 08:13:33 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41540/tests/kraken/driver.html?testName=imaging-darkroom) 08:13:33 INFO - PROCESS | 31258 | RSS: Main: 165646336 08:13:33 INFO - PROCESS | 31258 | 08:13:37 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41540/tests/kraken/driver.html?testName=imaging-desaturate) 08:13:37 INFO - PROCESS | 31258 | RSS: Main: 165634048 08:13:37 INFO - PROCESS | 31258 | 08:13:40 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41540/tests/kraken/driver.html?testName=json-parse-financial) 08:13:41 INFO - PROCESS | 31258 | RSS: Main: 166780928 08:13:41 INFO - PROCESS | 31258 | 08:13:42 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41540/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:13:43 INFO - PROCESS | 31258 | RSS: Main: 174780416 08:13:43 INFO - PROCESS | 31258 | 08:13:45 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41540/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:13:45 INFO - PROCESS | 31258 | RSS: Main: 173654016 08:13:45 INFO - PROCESS | 31258 | 08:13:47 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41540/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:13:48 INFO - PROCESS | 31258 | RSS: Main: 184848384 08:13:48 INFO - PROCESS | 31258 | 08:13:50 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:13:51 INFO - PROCESS | 31258 | RSS: Main: 193134592 08:13:51 INFO - PROCESS | 31258 | 08:13:53 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:13:54 INFO - PROCESS | 31258 | RSS: Main: 189251584 08:13:54 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:41540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41540/tests/kraken/driver.html?testName=ai-astar) 08:13:56 INFO - PROCESS | 31258 | RSS: Main: 247652352 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | __start_tp_report 08:13:56 INFO - PROCESS | 31258 | _x_x_mozilla_page_load 08:13:56 INFO - PROCESS | 31258 | _x_x_mozilla_page_load_details 08:13:56 INFO - PROCESS | 31258 | |i|pagename|runs| 08:13:56 INFO - PROCESS | 31258 | |0;ai-astar;110;112;105;110;110;112;102;111;111;110 08:13:56 INFO - PROCESS | 31258 | |1;audio-beat-detection;149;126;150;164;123;148;151;123;174;125 08:13:56 INFO - PROCESS | 31258 | |2;audio-dft;162;161;161;160;163;161;160;163;161;162 08:13:56 INFO - PROCESS | 31258 | |3;audio-fft;71;73;81;92;72;72;72;100;90;72 08:13:56 INFO - PROCESS | 31258 | |4;audio-oscillator;96;96;154;97;97;96;138;96;97;138 08:13:56 INFO - PROCESS | 31258 | |5;imaging-gaussian-blur;110;109;110;110;109;109;109;109;109;109 08:13:56 INFO - PROCESS | 31258 | |6;imaging-darkroom;145;145;145;145;145;145;145;144;145;145 08:13:56 INFO - PROCESS | 31258 | |7;imaging-desaturate;96;96;96;96;95;95;96;97;96;97 08:13:56 INFO - PROCESS | 31258 | |8;json-parse-financial;57;59;58;56;56;58;57;66;55;54 08:13:56 INFO - PROCESS | 31258 | |9;json-stringify-tinderbox;67;67;68;67;69;68;68;68;69;68 08:13:56 INFO - PROCESS | 31258 | |10;stanford-crypto-aes;87;87;89;86;86;86;94;87;92;87 08:13:56 INFO - PROCESS | 31258 | |11;stanford-crypto-ccm;118;118;118;115;118;130;117;120;126;116 08:13:56 INFO - PROCESS | 31258 | |12;stanford-crypto-pbkdf2;145;159;159;156;154;146;147;155;155;144 08:13:56 INFO - PROCESS | 31258 | |13;stanford-crypto-sha256-iterative;69;69;70;69;68;68;67;68;69;68 08:13:56 INFO - PROCESS | 31258 | __end_tp_report 08:13:56 INFO - PROCESS | 31258 | __start_cc_report 08:13:56 INFO - PROCESS | 31258 | _x_x_mozilla_cycle_collect,957 08:13:56 INFO - PROCESS | 31258 | __end_cc_report 08:13:56 INFO - PROCESS | 31258 | __startTimestamp1452010436485__endTimestamp 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | ------- Summary: start ------- 08:13:56 INFO - PROCESS | 31258 | Number of tests: 14 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:3.23 (2.9%) stddev-sans-first:3.42 08:13:56 INFO - PROCESS | 31258 | Values: 110.0 112.0 105.0 110.0 110.0 112.0 102.0 111.0 111.0 110.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:149.50 stddev:18.22 (12.2%) stddev-sans-first:19.21 08:13:56 INFO - PROCESS | 31258 | Values: 149.0 126.0 150.0 164.0 123.0 148.0 151.0 123.0 174.0 125.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 08:13:56 INFO - PROCESS | 31258 | Values: 162.0 161.0 161.0 160.0 163.0 161.0 160.0 163.0 161.0 162.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#3] audio-fft Cycles:10 Average:79.50 Median:72.50 stddev:10.69 (14.7%) stddev-sans-first:10.89 08:13:56 INFO - PROCESS | 31258 | Values: 71.0 73.0 81.0 92.0 72.0 72.0 72.0 100.0 90.0 72.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.00 stddev:23.08 (24.0%) stddev-sans-first:23.87 08:13:56 INFO - PROCESS | 31258 | Values: 96.0 96.0 154.0 97.0 97.0 96.0 138.0 96.0 97.0 138.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 08:13:56 INFO - PROCESS | 31258 | Values: 110.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:13:56 INFO - PROCESS | 31258 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 144.0 145.0 145.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:13:56 INFO - PROCESS | 31258 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 97.0 96.0 97.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.50 stddev:3.31 (5.8%) stddev-sans-first:3.50 08:13:56 INFO - PROCESS | 31258 | Values: 57.0 59.0 58.0 56.0 56.0 58.0 57.0 66.0 55.0 54.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 08:13:56 INFO - PROCESS | 31258 | Values: 67.0 67.0 68.0 67.0 69.0 68.0 68.0 68.0 69.0 68.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:87.00 stddev:2.77 (3.2%) stddev-sans-first:2.91 08:13:56 INFO - PROCESS | 31258 | Values: 87.0 87.0 89.0 86.0 86.0 86.0 94.0 87.0 92.0 87.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:118.00 stddev:4.72 (4.0%) stddev-sans-first:4.97 08:13:56 INFO - PROCESS | 31258 | Values: 118.0 118.0 118.0 115.0 118.0 130.0 117.0 120.0 126.0 116.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:155.00 stddev:5.87 (3.8%) stddev-sans-first:5.65 08:13:56 INFO - PROCESS | 31258 | Values: 145.0 159.0 159.0 156.0 154.0 146.0 147.0 155.0 155.0 144.0 08:13:56 INFO - PROCESS | 31258 | 08:13:56 INFO - PROCESS | 31258 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 08:13:56 INFO - PROCESS | 31258 | Values: 69.0 69.0 70.0 69.0 68.0 68.0 67.0 68.0 69.0 68.0 08:13:56 INFO - PROCESS | 31258 | -------- Summary: end -------- 08:13:56 INFO - PROCESS | 31258 | 08:13:57 INFO - TEST-INFO | 31258: exit 0 08:13:57 INFO - TEST-OK | kraken | took 59435ms 08:13:57 INFO - TEST-START | v8_7 08:13:57 INFO - operating with platform_type : linux_ 08:13:57 INFO - Initialising browser for v8_7 test... 08:13:57 INFO - TEST-INFO | started process 31508 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSYNQzO/profile http://localhost:41540/getInfo.html) 08:14:01 INFO - PROCESS | 31508 | __metrics Screen width/height:1600/1200 08:14:01 INFO - PROCESS | 31508 | colorDepth:24 08:14:01 INFO - PROCESS | 31508 | Browser inner width/height: 1024/697 08:14:01 INFO - PROCESS | 31508 | __metrics 08:14:02 INFO - PROCESS | 31508 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:14:02 INFO - PROCESS | 31508 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:14:03 INFO - TEST-INFO | 31508: exit 0 08:14:03 INFO - Browser initialized. 08:14:03 INFO - Running cycle 1/1 for v8_7 test... 08:14:03 INFO - TEST-INFO | started process 31590 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSYNQzO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:14 INFO - PROCESS | 31590 | RSS: Main: 149733376 08:14:14 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | Cycle 1(1): loaded http://localhost:41540/tests/v8_7/run.html (next: http://localhost:41540/tests/v8_7/run.html) 08:14:36 INFO - PROCESS | 31590 | RSS: Main: 579035136 08:14:36 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | __start_tp_report 08:14:36 INFO - PROCESS | 31590 | _x_x_mozilla_page_load 08:14:36 INFO - PROCESS | 31590 | _x_x_mozilla_page_load_details 08:14:36 INFO - PROCESS | 31590 | |i|pagename|runs| 08:14:36 INFO - PROCESS | 31590 | |0;Richards;166.19577862722286 08:14:36 INFO - PROCESS | 31590 | |1;DeltaBlue;191.57088122605364 08:14:36 INFO - PROCESS | 31590 | |2;Encrypt;280.42624789680315 08:14:36 INFO - PROCESS | 31590 | |3;Decrypt;5240.837696335078 08:14:36 INFO - PROCESS | 31590 | |4;RayTrace;1972.3865877712033 08:14:36 INFO - PROCESS | 31590 | |5;Earley;798.7220447284345 08:14:36 INFO - PROCESS | 31590 | |6;Boyer;12370.37037037037 08:14:36 INFO - PROCESS | 31590 | |7;RegExp;25325 08:14:36 INFO - PROCESS | 31590 | |8;Splay;609.2995169082126 08:14:36 INFO - PROCESS | 31590 | |9;NavierStokes;4835.748792270531 08:14:36 INFO - PROCESS | 31590 | __end_tp_report 08:14:36 INFO - PROCESS | 31590 | __startTimestamp1452010476582__endTimestamp 08:14:36 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | ------- Summary: start ------- 08:14:36 INFO - PROCESS | 31590 | Number of tests: 10 08:14:36 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | [#0] Richards Cycles:1 Average:166.20 Median:166.20 stddev:0.00 (0.0%) 08:14:36 INFO - PROCESS | 31590 | Values: 166.2 08:14:36 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | [#1] DeltaBlue Cycles:1 Average:191.57 Median:191.57 stddev:0.00 (0.0%) 08:14:36 INFO - PROCESS | 31590 | Values: 191.6 08:14:36 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 08:14:36 INFO - PROCESS | 31590 | Values: 280.4 08:14:36 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 08:14:36 INFO - PROCESS | 31590 | Values: 5240.8 08:14:36 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 08:14:36 INFO - PROCESS | 31590 | Values: 1972.4 08:14:36 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | [#5] Earley Cycles:1 Average:798.72 Median:798.72 stddev:0.00 (0.0%) 08:14:36 INFO - PROCESS | 31590 | Values: 798.7 08:14:36 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 08:14:36 INFO - PROCESS | 31590 | Values: 12370.4 08:14:36 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | [#7] RegExp Cycles:1 Average:25325.00 Median:25325.00 stddev:0.00 (0.0%) 08:14:36 INFO - PROCESS | 31590 | Values: 25325.0 08:14:36 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | [#8] Splay Cycles:1 Average:609.30 Median:609.30 stddev:0.00 (0.0%) 08:14:36 INFO - PROCESS | 31590 | Values: 609.3 08:14:36 INFO - PROCESS | 31590 | 08:14:36 INFO - PROCESS | 31590 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 08:14:36 INFO - PROCESS | 31590 | Values: 4835.7 08:14:36 INFO - PROCESS | 31590 | -------- Summary: end -------- 08:14:36 INFO - PROCESS | 31590 | 08:14:37 INFO - TEST-INFO | 31590: exit 0 08:14:37 INFO - TEST-OK | v8_7 | took 40137ms 08:14:37 INFO - SUITE-END | took 1212s 08:14:38 INFO - Completed test suite (00:20:13) 08:14:38 INFO - Working with test: dromaeo_css 08:14:38 INFO - Generating results file: dromaeo_css 08:14:38 INFO - Working with test: kraken 08:14:38 INFO - Generating results file: kraken 08:14:38 INFO - javascript benchmark 08:14:38 INFO - Working with test: v8_7 08:14:38 INFO - Generating results file: v8_7 08:14:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:14:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 08:14:38 INFO - process_Request line: dromaeo_css 6845.52 graph.html#tests=[[72,201,35]] 08:14:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:14:38 INFO - process_Request line: kraken 1507.90 graph.html#tests=[[232,201,35]] 08:14:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:14:38 INFO - process_Request line: v8_7 19774.50 graph.html#tests=[[230,201,35]] 08:14:38 INFO - RETURN: dromaeo_css: 6845.52 08:14:38 INFO - RETURN: kraken: 1507.90 08:14:38 INFO - RETURN: v8_7: 19774.50 08:14:38 INFO - javascript benchmark 08:14:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3059.770517211209, 3121.282105115825, 3161.130689060508, 3172.0959526534944, 3188.1551388881935, 4993.525615066572, 5062.392512898448, 5116.079105760961, 5125.333706618135, 5125.513076257755, 5059.747012649362, 5134.537891589756, 5141.537261646451, 5194.065068287707, 5211.687298762067, 4695.788689508971, 4713.0, 4718.952810471903, 4780.3307536944685, 4788.377510923575, 4583.793729282191, 4776.379070720802, 4783.61731061516, 4799.760011999386, 4856.878578035542, 4706.858794236178, 4709.458412282597, 4778.37881075458, 4781.832635857728, 4809.398825146856, 4733.905321893543, 4735.95264047362, 4741.502142275081, 4753.144434001878, 4778.522147785228, 4636.142313671948, 4735.644826637981, 4739.0, 4742.359781429497, 4794.232922732346, 4973.825916092919, 5003.2995380646735, 5054.772535235923, 5061.342025536694, 5070.771815268285, 5541.085720856054, 5548.9722551386985, 5558.277423934863, 5558.583106267046, 5578.414266501999, 5360.437154098802, 5447.046766815792, 5590.329160500725, 5608.046632072516, 5659.0, 5184.403793563751, 5217.139172036609, 5233.790648374023, 5235.58115350771, 5290.497402746733, 5614.522765564972, 5654.717264136777, 5657.858553536194, 5667.121596152603, 5669.744861481243, 5290.814821481306, 5387.407385187705, 5393.4336894626285, 5465.945340546623, 5469.863253418617, 5470.316210473691, 5547.528460080857, 5551.500364967092, 5552.888942221133, 5569.582281328835, 5508.283923090053, 5518.91721624176, 5521.4478552145265, 5521.779128834802, 5525.585581081355, 5338.46615338463, 5511.917321240105, 5521.282233309644, 5524.66851988882, 5528.889422211533, 4227.682923780729, 4288.48538175421, 4290.914181716348, 4308.67684923632, 4324.221640104748, 3858.7105967052585, 3861.304965106308, 3866.420036994417, 3899.5710471848074, 3899.6490315871706, 5167.948320516822, 5169.974150129226, 5170.0, 5171.01750667372, 5171.870703232449, 5356.116240820299, 5415.6479828811, 5425.565954723613, 5507.807226747124, 5535.125222989586, 5187.922181167285, 5214.243934629458, 5221.503957124067, 5221.738913054332, 5224.947750522522, 4800.039992001613, 4809.735464549483, 4811.4707382187935, 4815.085133824562, 4856.028794241166, 5478.260434841325, 5524.696141712164, 5584.804531841366, 5629.324481062299, 5695.658260504383, 5550.333959924835, 5558.249636299048, 5558.861028474321, 5577.3028371453565, 5595.384507704068, 5640.4077571856005, 5646.124850648156, 5649.830505084854, 5650.350209725934, 5651.265335506358, 5355.946440535545, 5450.046241907571, 5450.1007333789485, 5455.0726376515295, 5488.945110549003, 5512.062949298549, 5546.889062218814, 5570.331560212639, 5571.832845014656, 5576.275084239023, 5334.866628334323, 5381.13901775714, 5385.757640906247, 5446.400895901527, 5454.563634909277, 5392.838214853561, 5400.2439658447065, 5402.270693456333, 5402.891942161214, 5405.5135037846785, 5279.736013199402, 5323.148296272578, 5328.520433161034, 5338.172583249602, 5377.27406800077, 5307.389650190277, 5412.079946409041, 5415.106507426231, 5459.017376872042, 5459.2902922619805, 5340.759665815125, 5343.62594618373, 5382.919256211082, 5384.380796208487, 5385.192221166856], "unit": "score", "name": "dojo.html", "value": 5105.194339177549}, {"lowerIsBetter": false, "replicates": [529.9735013249341, 531.4234056049187, 545.8853640735446, 553.6290685240886, 556.9665820050798, 28746.28134296641, 36437.271254574895, 36949.26101477969, 37014.629853701525, 37091.0, 39665.40501892474, 40000.599994000055, 40085.0, 40090.79954600223, 40100.0, 7287.963560182192, 8472.322214222848, 8579.742607721779, 8615.698450554231, 8620.956895215515, 7381.0, 10116.19070474364, 10307.63923262686, 10323.896761032369, 10331.690049298495, 9994.9500252499, 10060.849087263698, 10117.544710488046, 10118.089371956523, 10119.241056920724, 7545.69817207311, 7661.387089032864, 9963.45201013944, 10060.295779295453, 10113.292069555135, 9835.754106147331, 9873.90126098737, 9976.650817221362, 9985.650502232387, 9990.050945160197, 36089.63910360889, 36475.81762091199, 36694.449583256275, 36717.63282367169, 36919.0, 3165.7467402607735, 3189.61724593048, 3300.3399320135827, 3493.7205023598053, 3526.3299973005046, 28275.57586636202, 28879.422411551863, 30504.694953050628, 30745.385092298027, 31669.683303166905, 3952.9011774705573, 3961.1681546875193, 3996.660283875874, 4021.6727337740126, 4056.533498647634, 259823.0, 261095.9999999981, 261244.0, 262197.0, 264277.0, 52003.0, 52912.0, 55245.89508209813, 60414.0, 62091.37908620856, 54941.1758823618, 54988.72505637446, 55179.44820551743, 55247.447525525036, 55303.17045244244, 15067.397304107932, 15195.62010949713, 15197.924010380098, 15253.313600887986, 15293.005954612914, 10945.124390048777, 10996.175286853519, 11075.280106793032, 11088.33469991803, 11183.161262905152, 19965.900170499055, 20670.0, 20686.79313206879, 20715.585688286148, 20733.481662958548, 7842.372610191171, 7938.444308898437, 8005.599720014093, 8012.719554815553, 8079.353651707849, 951.3293128344501, 975.2831668723483, 990.4453506036499, 998.7836595037767, 1067.926733632694, 27982.300442488693, 28267.71732282692, 28380.0, 28589.85705071503, 28602.28494287618, 1030.7268573827942, 1036.3315661398506, 1045.2996492350144, 1073.951672174754, 1119.3228097001197, 13878.375473103735, 14053.086549374259, 14608.34262458192, 14634.926825365805, 14965.476208332657, 348209.0, 353614.0, 354594.0, 354770.0, 355102.0, 51238.0, 51824.74087629538, 51836.149011804715, 51892.48107518952, 51936.0, 1395.0583356234501, 1399.2024546008881, 1411.9082259653296, 1412.8445870954188, 1418.8155539779968, 25620.487590247718, 26555.0, 27318.453630926873, 27599.0, 27629.171124866287, 46219.0, 46814.531854681016, 46845.53154468412, 46924.0, 46927.765361174344, 294054.0, 295218.0, 296791.0, 297149.0, 297471.0, 28193.43613127685, 28930.566041509814, 32232.35535289234, 32740.508892366157, 33215.83392083121, 38994.61005390023, 39548.0, 47556.52443475521, 48456.48177749259, 48907.75546122246, 34529.65470345365, 34570.30859382748, 34607.30785384329, 35160.47259291164, 35923.82038089793, 34993.47509787406, 34999.0, 35165.82417087898, 35432.0, 35589.46615800713, 33183.0, 37232.627673724, 37964.2407151861, 37974.0, 38067.23865522619, 28879.0, 31007.449627518083, 33726.0, 34005.65994340025, 34020.31959360749, 24117.91469383917, 24392.75607243976, 24669.876650616632, 24843.0, 25104.246872593852], "unit": "score", "name": "ext.html", "value": 18463.504536638622}, {"lowerIsBetter": false, "replicates": [352.8958957107653, 359.6762913377961, 361.4650317530055, 363.4439307858975, 367.18301778542747, 14188.787168192459, 14242.430302787876, 15847.0, 16597.33610655574, 18190.181441835117, 15962.201889905487, 16307.103109328982, 16634.83365166351, 16710.498685039438, 16727.665446691088, 5151.69089854609, 5406.513413792758, 5415.702136382497, 5415.783368665248, 5422.647527910693, 4037.454943582623, 4128.401381799637, 5390.865228369283, 5419.593530485229, 5837.649741015532, 5888.499477544414, 5917.171595976567, 5934.258217722785, 5942.970285148568, 5943.64338139713, 5739.053056245714, 5854.18041474194, 5884.941150588482, 5901.4098590141075, 5902.8819423611285, 5219.373675159005, 5232.895342093137, 5237.921431178535, 5238.188080847437, 5238.423773384925, 19434.416967490997, 19999.800002000084, 20039.398818035483, 21174.894125529427, 21194.788052119435, 2025.8581899267058, 2059.3204242600054, 2111.567128738605, 2155.0, 2195.067096483988, 9243.214326782232, 9366.53167341637, 9595.13643772064, 11689.357085360301, 11791.528338866436, 1751.9299228030864, 1784.3308759215295, 1786.6158775863253, 1815.7730283714536, 1830.6979348407497, 52506.47493525054, 61473.07790383103, 62620.37379626191, 62789.0, 62823.0, 9509.381890177254, 9628.037196280316, 9647.13175814166, 9662.516874156405, 9725.319227654138, 12815.0, 12878.227306361461, 12925.54760583375, 12945.805812912813, 13020.283884386261, 6996.055532503149, 7072.328128827753, 7187.7843664690145, 7217.639118044077, 7229.349358557755, 7015.052967849275, 7021.262767409451, 7037.155541334971, 7050.92949070513, 7126.144862616519, 4061.7766022868436, 4323.78381080951, 4368.388425620416, 4439.711418757771, 4480.843170489017, 1646.209819286749, 1675.4471024561865, 1688.763573099767, 1691.9407820726215, 1704.4545745361613, 837.8952630921135, 911.129870973219, 968.8256113899565, 982.1419668763863, 1046.9371837689764, 15594.688106237812, 16567.00597964126, 17396.0, 17419.12904354777, 17829.821701783076, 828.9690258865803, 847.894013248344, 920.1442658327686, 943.4527973775193, 1011.1556850030307, 8657.0, 9020.233280171127, 9071.591778369857, 9104.180623743763, 9170.266378689688, 516002.0, 519000.0, 520775.0, 533931.0, 535194.0, 42341.36487952683, 76693.0, 79713.0, 80448.59775701202, 80932.0, 1120.3389999900098, 1134.2967360236541, 1136.63059505661, 1151.1193936638479, 1151.1999160583314, 15168.24158792078, 15358.0, 15382.461613843461, 15553.68892622164, 15661.0, 19161.0, 19448.0, 31190.688093118777, 35714.821425892704, 35756.0, 44519.777401112784, 46138.769306153255, 47370.289445657654, 47688.2846757292, 49363.0, 8800.823983520422, 9168.258030974093, 9473.0, 9606.567704453177, 9629.903700963181, 16528.504144875675, 16757.32970681159, 16999.49001529956, 17160.0, 17230.396936107176, 10911.890881091405, 13335.733285334432, 13438.731225375243, 13682.794758078438, 14154.292285385483, 13842.639568535878, 14133.505327313494, 14719.0, 14872.33074511628, 15028.474003409829, 9586.568604412958, 9799.902000980184, 9943.502824858873, 9950.950245248727, 14299.928500357431, 14503.274836258355, 14545.563633091024, 14778.704425911206, 15051.924740376666, 15087.54737357837, 14522.128672279698, 14582.85417145815, 14695.412183512968, 14734.410623575366, 15738.0], "unit": "score", "name": "jquery.html", "value": 8753.523086654795}, {"lowerIsBetter": false, "replicates": [1299.6555912683148, 1408.3240044778506, 1434.1538492289546, 1533.93097310621, 1755.56110972257, 6614.371634694702, 7304.671289791959, 7404.703811847527, 7409.036825212715, 7423.331900128987, 7114.359707626312, 7279.381252593523, 7311.086114235721, 7318.670659820307, 7321.3410793028615, 1919.4721451600783, 1950.4441234248243, 1955.5208973801439, 2218.7004754358195, 2248.898799554024, 2211.657193135067, 2251.324602619216, 2251.7748225177515, 2254.5716313900307, 2256.8307376946714, 2163.610550100981, 2204.603171429142, 2212.4911270407815, 2220.433789383705, 2224.2993457061057, 2176.227439259056, 2205.0738689750265, 2221.133757834446, 2223.43302457873, 2244.371575958734, 2227.376334626291, 2236.6421372580307, 2257.9661305080435, 2259.5254996450767, 2265.1958554713005, 7581.507202031906, 7660.923390766076, 7676.846463070708, 7677.923220767777, 7681.193474685134, 4487.596116349544, 4526.705764125321, 4529.2526733089, 4537.183307004738, 4544.931826022612, 2957.763378929702, 2965.733084022448, 2992.970070299291, 2997.775166862494, 3097.7831551791382, 935.1536859142487, 937.8030613571158, 945.9337846350758, 1007.0885848307221, 1012.9797404051951, 10241.436720980342, 10267.589296428134, 10331.638392656221, 10358.326708763907, 10392.532336044897, 3812.1994381179707, 3859.112404147062, 3862.9806850965565, 3895.7662540247675, 3918.921621567553, 8937.776555586162, 8944.552772361356, 8946.239569636524, 8965.596548155218, 8983.55082245885, 4456.77716114193, 4458.576435238647, 4460.197164510354, 4460.888477788017, 4463.352813841975, 4013.1171142348635, 4040.1919616076902, 4049.190161967618, 4068.959310406917, 4078.4290199372113, 3319.0706602151436, 3396.269801992534, 3473.14907847579, 3485.6165821759587, 3555.982220088883, 1134.6709454258173, 1136.3125309187988, 1137.7041969088098, 1140.646399616105, 1147.862256529222, 1023.8976102389702, 1033.4832583708146, 1093.557109370706, 1150.2753265442718, 1279.7632437999, 6828.556143850634, 6875.759348422881, 6908.0, 6932.930670693329, 6938.0, 1086.4187659602076, 1097.6706987903756, 1100.4937728644752, 1113.0483436661539, 1118.5302173087323, 5576.693281869455, 5686.3744988051285, 5690.6870122142855, 5698.031334673115, 5698.202251684767, 8935.776605584912, 8989.741436198938, 9134.725958221265, 9249.0, 9306.348555601044, 9166.54167291646, 9188.8621670675, 9213.447193168431, 9218.723438296862, 9225.031371706009, 6944.687489063004, 7111.146662400545, 7133.536320139175, 7144.035555200086, 7161.319674630901, 6919.515633905578, 6934.7226110955, 6950.895736563854, 6961.269066748121, 6969.58182509051, 7794.113243704497, 8168.795780105307, 8172.7956801080445, 8191.13993030747, 8354.498730076215, 8308.5430301334, 8415.621297041525, 8539.274161696325, 8567.186117318844, 8593.484390936565, 6750.6624668767345, 6769.898451523132, 6926.619035952869, 6931.896021559782, 6942.132233470817, 6432.678366081584, 6555.967220163869, 7072.115985501812, 7167.498275120692, 7426.702931882664, 6689.698963546554, 6781.321867813179, 6825.146856642919, 6902.551334163263, 7055.400290975119, 6702.095217145623, 6724.73101075971, 6738.2587915328295, 6811.761588344384, 6836.0, 6826.795196143925, 6864.656767161722, 6872.278410766798, 6872.62200578973, 6881.552699074544, 6044.516438684983, 6154.599951003171, 6293.811185664437, 6311.084892690626, 6315.5894866833505, 6174.351693072163, 6187.010078387617, 6210.4100110489435, 6212.596181248205, 6220.160278362363], "unit": "score", "name": "mootools.html", "value": 4329.44590724336}, {"lowerIsBetter": false, "replicates": [325.62553063976424, 340.6151049314275, 343.80231366964, 344.76900476680623, 355.5839667588921, 5813.941860581393, 5849.766009359631, 5919.319278282998, 5923.022701254288, 5929.555283353744, 5535.778568857241, 5680.0627896397045, 5703.657780533171, 5705.657660540371, 5775.249217601717, 4426.136903303857, 4431.26884064129, 4493.101379724052, 4504.076664283831, 4519.5932366087045, 4526.6831321807485, 4532.682712210147, 4537.364768932335, 4552.772361381918, 4556.407667003285, 4236.173946080516, 4359.738415695053, 4510.684252102355, 4511.120331535352, 4514.232580461329, 4374.956250437503, 4464.419625448703, 4467.374567560544, 4484.977575112103, 4489.932651010205, 3961.623645753649, 3965.8810235692977, 3966.484357033596, 3980.4626375439234, 3981.303271927401, 5484.643498172606, 5496.80761173357, 5502.8349149525575, 5505.504504594565, 5570.944290557123, 4990.775415106329, 5151.227315902607, 5234.555062819665, 5250.553702935255, 5252.921206181873, 6091.817245482643, 6128.111423843562, 6140.171076904606, 6152.87694246117, 6157.507399408037, 4333.501647310568, 4334.501532323791, 4335.588119128678, 4336.457942757155, 4339.500957389878, 6359.713812878385, 6426.485881129498, 6430.485561155097, 6440.25937017249, 6441.677916104176, 4279.893002674958, 4422.71252368595, 4422.933655995098, 4428.490723566831, 4443.844465443694, 4476.0, 4479.328100784843, 4482.910341793146, 4483.977580112079, 4487.416635837386, 5156.458571849977, 5162.74186290684, 5170.8190213343105, 5170.8965820684125, 5178.97410512945, 6194.194754681863, 6197.504199664107, 6208.0, 6208.875822483525, 6209.410106039919, 1531.8468153184592, 1583.0185285123298, 1586.912719800422, 1587.8491543303367, 1590.300267882128, 1050.3540322701483, 1065.7761870007384, 1078.449990504848, 1086.3916206923989, 1090.1224514265934, 5834.387389324144, 5873.119032145127, 5882.088276317178, 5888.322842873039, 5891.970540147272, 6347.714352854133, 6348.492120630339, 6352.396522330371, 6361.968190159112, 6369.33122022181, 5713.885722285531, 5788.739506722208, 5855.770288239432, 5872.471477567039, 5880.617759845596, 3395.1342407686375, 3455.2398472336045, 3471.149568355769, 3475.1138459692615, 3480.7911525308564, 6601.0, 6605.636689982001, 6612.471002319803, 6614.10709554204, 6614.206295244601, 6446.806595802133, 6509.609423434609, 6564.704588293538, 6574.0, 6574.474042076622, 6504.317046710027, 6523.282438931714, 6527.02094685801, 6529.771457998947, 6570.737170513126, 6368.140301059298, 6379.266384365672, 6382.5851319665935, 6383.96808015957, 6390.360963903759, 6159.322474527888, 6321.747130114744, 6348.428641422294, 6363.745450181941, 6371.936280637135, 6532.8366790830605, 6543.476521878143, 6577.572457790228, 6614.669266536558, 6615.900761488678, 4446.488653804725, 4487.259602165606, 4488.079943611617, 4488.708233964782, 4495.977520112378, 6425.325340839145, 6445.742170313135, 6452.451541619015, 6457.4511166551365, 6464.353564643686, 6059.757609695739, 6220.595661282002, 6238.875222495615, 6285.685715714288, 6291.213598300213, 6249.718762655601, 6257.78097766576, 6263.1857858479925, 6269.905951410824, 6275.592086514362, 6057.1519987200945, 6168.290646575701, 6175.96912015437, 6177.84555386119, 6178.41305076017, 6246.156768836149, 6273.811785646438, 6287.842803929939, 6291.685415729286, 6293.276273228455, 6131.693415329305, 6140.785072522441, 6141.201643786279, 6142.385761423822, 6146.78486252979], "unit": "score", "name": "prototype.html", "value": 4687.641382899593}, {"lowerIsBetter": false, "replicates": [828.4946182828477, 848.5036253791532, 850.8808766772653, 863.6631713631683, 863.9654413823447, 13159.07886447949, 13394.999999999987, 13400.932995335033, 13415.396307166176, 13436.932815335935, 12681.239125652444, 12734.490620375196, 12748.2988435636, 12751.617451476448, 12767.0, 801.459015164763, 830.0413022958493, 836.067784420373, 837.4891316297054, 837.5519097282925, 690.5960013392172, 694.9061876646664, 830.2610676497922, 844.3625063077368, 846.1834329871673, 858.4634603372892, 864.5072308783996, 869.5347988825979, 869.613022205119, 869.7129947117436, 858.1161403754144, 858.2576071697998, 858.7509622209552, 858.9699360522383, 859.2481578618708, 517.4308260913003, 526.0215998243265, 633.3381616211025, 640.3788325324474, 648.8702259548062, 13206.933965330112, 13256.86743132566, 13268.867311326956, 13334.066615336931, 13352.666183345495, 10744.086752626035, 11276.548938042468, 11379.601713939972, 11970.461329240117, 12404.069694772928, 10170.237232207613, 10174.135198508136, 10194.388336699822, 10330.845037324447, 10592.841107383396, 3560.9109772255642, 3605.405108157151, 3607.621199774012, 3645.6172101929446, 3673.742838001341, 47523.762381188215, 47890.0, 47960.760196199146, 47987.280190797166, 48105.51894481081, 9603.711888643353, 9740.220782337537, 9754.365966212174, 9775.315727898978, 10039.04629060238, 17462.388816391365, 17654.470365889043, 17678.204480798395, 17696.203670834842, 17725.911370443064, 7521.285477879593, 7553.244675532403, 7623.275788800055, 7851.646675899598, 7862.2923936845955, 4338.436003319548, 4367.67242456817, 4369.191699535596, 4380.802863871133, 4417.226985277628, 3032.499637559778, 3100.5194194899827, 3105.9223519412194, 3114.065780265911, 3116.6883311668653, 560.842963970089, 561.1890817768367, 569.8917205730897, 574.0241589298209, 585.5930128560694, 592.62960649594, 634.6223996721943, 640.9743610255538, 641.6855740687123, 644.5810223354763, 7859.449838511364, 7949.960250198712, 8070.445327952272, 8083.878741818878, 8512.0, 441.24547024587673, 483.9395075615548, 524.1001370033628, 550.6365798572923, 631.7125707802938, 3527.0, 3754.342989976798, 3984.242993831163, 4042.939355909664, 4061.817218225187, 52415.21377179345, 52602.0, 53617.0, 53779.731101344245, 54597.1810422844, 49130.75434622804, 50346.496535034916, 50612.0, 50955.745221274396, 51040.489595104315, 44681.0, 45207.54792452099, 45667.314990275176, 46765.29852052222, 46950.53049469461, 7940.404469664682, 7994.960025199837, 8159.918400815915, 8216.424850260664, 8261.1325810789, 33357.66642333643, 33712.66287337095, 34040.31919361549, 34202.48696269508, 34929.825350873085, 42458.57541424546, 42818.0, 43128.78435607802, 43307.56692433036, 43327.566724332355, 10463.21525885577, 10919.181061420266, 11121.332720036824, 11212.719682008015, 11311.886881131084, 10204.4387558685, 10447.477626118512, 10543.630972915911, 10833.729156771144, 10858.34849909008, 10826.296290741077, 10832.079273261861, 11162.720931976766, 11196.944015280198, 11199.552017919192, 11199.72000699989, 11294.887051129384, 11657.591984280849, 11862.347570883685, 12031.63905082849, 11356.54573817038, 11384.48769805344, 11428.542858285575, 11457.167971871557, 11791.115666325231, 8742.635550726187, 8839.646414143619, 8900.198982091642, 8955.149260820212, 9103.271738261055, 8283.58582070906, 8681.826363472821, 9105.317101217302, 9166.266698664223, 9287.210587100171], "unit": "score", "name": "yui.html", "value": 6144.685306385566}], "name": "dromaeo_css", "value": 6845.515156284876}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 110.0, 110.0, 112.0, 102.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [149.0, 126.0, 150.0, 164.0, 123.0, 148.0, 151.0, 123.0, 174.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 160.0, 163.0, 161.0, 160.0, 163.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 81.0, 92.0, 72.0, 72.0, 72.0, 100.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 154.0, 97.0, 97.0, 96.0, 138.0, 96.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 144.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 58.0, 56.0, 56.0, 58.0, 57.0, 66.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 69.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 89.0, 86.0, 86.0, 86.0, 94.0, 87.0, 92.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.1}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 118.0, 115.0, 118.0, 130.0, 117.0, 120.0, 126.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [145.0, 159.0, 159.0, 156.0, 154.0, 146.0, 147.0, 155.0, 155.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 68.0, 68.0, 67.0, 68.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1507.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.19577862722286], "unit": "score", "name": "Richards", "value": 212.41213400000004}, {"lowerIsBetter": false, "replicates": [191.57088122605364], "unit": "score", "name": "DeltaBlue", "value": 345.13596000000007}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [798.7220447284345], "unit": "score", "name": "Earley", "value": 834.4116759999996}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [25325.0], "unit": "score", "name": "RegExp", "value": 35.97176702862781}, {"lowerIsBetter": false, "replicates": [609.2995169082126], "unit": "score", "name": "Splay", "value": 133.74538751238845}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19774.504272239774}]} 08:14:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19774.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1507.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6845.52"}}} 08:14:38 INFO - Return code: 0 08:14:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:14:38 INFO - # TBPL SUCCESS # 08:14:38 INFO - Running post-action listener: _resource_record_post_action 08:14:38 INFO - Running post-run listener: _resource_record_post_run 08:14:39 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 573054976; Read time: 0; Write time: 1168644 08:14:39 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 251269120; Read time: 0; Write time: 706728 08:14:39 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 320921600; Read time: 0; Write time: 461852 08:14:39 INFO - Running post-run listener: _upload_blobber_files 08:14:39 INFO - Blob upload gear active. 08:14:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:14:39 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 08:14:39 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'] 08:14:39 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 08:14:39 INFO - (blobuploader) - INFO - Open directory for files ... 08:14:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:14:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:14:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:40 INFO - (blobuploader) - INFO - Done attempting. 08:14:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:14:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:14:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:41 INFO - (blobuploader) - INFO - Done attempting. 08:14:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:14:41 INFO - Return code: 0 08:14:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:14:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:14:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f13b5dad0c15edc583e078a62ab5e3cdc85ae238f4490091556178de6abcc5861832bc2f0a52460df4d80257d7bd21871b6dec88a35dd7299c31c32e96f5daf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/fd1abc55fbd6496bd4437b779ae41d5bca9225495718f62c9cbc8497831e931de25b566fc8e6a2b7bb0eae2bfa235a3d9994f07585f49c6dc307d77c1c2e8888"} 08:14:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:14:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:14:41 INFO - Contents: 08:14:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/f13b5dad0c15edc583e078a62ab5e3cdc85ae238f4490091556178de6abcc5861832bc2f0a52460df4d80257d7bd21871b6dec88a35dd7299c31c32e96f5daf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/fd1abc55fbd6496bd4437b779ae41d5bca9225495718f62c9cbc8497831e931de25b566fc8e6a2b7bb0eae2bfa235a3d9994f07585f49c6dc307d77c1c2e8888"} 08:14:41 INFO - Copying logs to upload dir... 08:14:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.814672 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-05 08:14:41.128017) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 08:14:41.131917) ========= 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=df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378 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/f13b5dad0c15edc583e078a62ab5e3cdc85ae238f4490091556178de6abcc5861832bc2f0a52460df4d80257d7bd21871b6dec88a35dd7299c31c32e96f5daf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/fd1abc55fbd6496bd4437b779ae41d5bca9225495718f62c9cbc8497831e931de25b566fc8e6a2b7bb0eae2bfa235a3d9994f07585f49c6dc307d77c1c2e8888"} build_url:https://queue.taskcluster.net/v1/task/IxvaM2sjSYuRDCeRO7OSqg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/IxvaM2sjSYuRDCeRO7OSqg/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/f13b5dad0c15edc583e078a62ab5e3cdc85ae238f4490091556178de6abcc5861832bc2f0a52460df4d80257d7bd21871b6dec88a35dd7299c31c32e96f5daf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/fd1abc55fbd6496bd4437b779ae41d5bca9225495718f62c9cbc8497831e931de25b566fc8e6a2b7bb0eae2bfa235a3d9994f07585f49c6dc307d77c1c2e8888"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 08:14:41.157734) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 08:14:41.158125) ========= 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=df17445c3590ff7897617a0e00000225-1452007045.541356-1923207378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 08:14:41.243502) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 08:14:41.243855) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 08:14:41.244250) ========= ========= Total master_lag: 0.38 =========