builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1452819975.92 results: success (0) buildid: 20160114143022 builduid: abbc0b3110f64323a5dc8c6e01683516 revision: b6ef37a7673e9829de96d0439244343948545955 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:15.923107) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:15.923552) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:15.923837) ========= 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=745a4373a2a16df560f216e000000264-1452819975.856976-1177906198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006257 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:15.945964) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:15.946271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:15.959216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:15.959513) ========= 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=745a4373a2a16df560f216e000000264-1452819975.856976-1177906198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:16.007877) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:16.008186) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:16.008564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:16.008834) ========= 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=745a4373a2a16df560f216e000000264-1452819975.856976-1177906198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 17:06:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|: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-14 17:06:16 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169889 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:16.190913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:16.191238) ========= 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=745a4373a2a16df560f216e000000264-1452819975.856976-1177906198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022112 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:16.240807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 17:06:16.241163) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b6ef37a7673e9829de96d0439244343948545955 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b6ef37a7673e9829de96d0439244343948545955 --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=745a4373a2a16df560f216e000000264-1452819975.856976-1177906198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 17:06:16,959 truncating revision to first 12 chars 2016-01-14 17:06:16,960 Setting DEBUG logging. 2016-01-14 17:06:16,960 attempt 1/10 2016-01-14 17:06:16,960 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b6ef37a7673e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 17:06:17,776 unpacking tar archive at: fx-team-b6ef37a7673e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.147383 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 17:06:17.401265) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:17.401584) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:17.411740) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:17.412009) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 17:06:17.412400) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-14 17:06:17.412683) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1452819975.856976-1177906198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:06:18 INFO - MultiFileLogger online at 20160114 17:06:18 in /builds/slave/test-pgo 17:06:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:06:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:06:18 INFO - {'append_to_log': False, 17:06:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:06:18 INFO - 'blob_upload_branch': 'Fx-Team', 17:06:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:06:18 INFO - 'branch': 'Fx-Team', 17:06:18 INFO - 'buildbot_json_path': 'buildprops.json', 17:06:18 INFO - 'config_files': ('talos/linux_config.py',), 17:06:18 INFO - 'default_actions': ('clobber', 17:06:18 INFO - 'read-buildbot-config', 17:06:18 INFO - 'download-and-extract', 17:06:18 INFO - 'populate-webroot', 17:06:18 INFO - 'create-virtualenv', 17:06:18 INFO - 'install', 17:06:18 INFO - 'run-tests'), 17:06:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:06:18 INFO - 'download_minidump_stackwalk': True, 17:06:18 INFO - 'download_symbols': 'ondemand', 17:06:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:06:18 INFO - 'tooltool.py': '/tools/tooltool.py', 17:06:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:06:18 INFO - '/tools/misc-python/virtualenv.py')}, 17:06:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:06:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:06:18 INFO - 'installer_path': 'installer.exe', 17:06:18 INFO - 'log_level': 'info', 17:06:18 INFO - 'log_name': 'talos', 17:06:18 INFO - 'log_to_console': True, 17:06:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:06:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:06:18 INFO - 'opt_config_files': (), 17:06:18 INFO - 'pip_index': False, 17:06:18 INFO - 'sps_profile': False, 17:06:18 INFO - 'sps_profile_interval': 0, 17:06:18 INFO - 'suite': 'dromaeojs', 17:06:18 INFO - 'system_bits': '32', 17:06:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:06:18 INFO - 'title': 'talos-linux64-ix-032', 17:06:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:06:18 INFO - 'use_talos_json': True, 17:06:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:06:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:06:18 INFO - 'work_dir': 'build'} 17:06:18 INFO - ##### 17:06:18 INFO - ##### Running clobber step. 17:06:18 INFO - ##### 17:06:18 INFO - Running pre-action listener: _resource_record_pre_action 17:06:18 INFO - Running main action method: clobber 17:06:18 INFO - rmtree: /builds/slave/test-pgo/build 17:06:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:06:19 INFO - Running post-action listener: _resource_record_post_action 17:06:19 INFO - ##### 17:06:19 INFO - ##### Running read-buildbot-config step. 17:06:19 INFO - ##### 17:06:19 INFO - Running pre-action listener: _resource_record_pre_action 17:06:19 INFO - Running main action method: read_buildbot_config 17:06:19 INFO - Using buildbot properties: 17:06:19 INFO - { 17:06:19 INFO - "project": "", 17:06:19 INFO - "product": "firefox", 17:06:19 INFO - "script_repo_revision": "production", 17:06:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:06:19 INFO - "repository": "", 17:06:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:06:19 INFO - "buildid": "20160114143022", 17:06:19 INFO - "pgo_build": "True", 17:06:19 INFO - "basedir": "/builds/slave/test-pgo", 17:06:19 INFO - "buildnumber": 897, 17:06:19 INFO - "slavename": "talos-linux64-ix-032", 17:06:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:06:19 INFO - "platform": "ubuntu64_hw", 17:06:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:06:19 INFO - "branch": "fx-team", 17:06:19 INFO - "repo_path": "integration/fx-team", 17:06:19 INFO - "revision": "b6ef37a7673e9829de96d0439244343948545955", 17:06:19 INFO - "stage_platform": "linux64-pgo", 17:06:19 INFO - "builduid": "abbc0b3110f64323a5dc8c6e01683516", 17:06:19 INFO - "slavebuilddir": "test" 17:06:19 INFO - } 17:06:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:06:19 INFO - Running post-action listener: _resource_record_post_action 17:06:19 INFO - ##### 17:06:19 INFO - ##### Running download-and-extract step. 17:06:19 INFO - ##### 17:06:19 INFO - Running pre-action listener: _resource_record_pre_action 17:06:19 INFO - Running main action method: download_and_extract 17:06:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:06:19 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')]} 17:06:19 INFO - https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:06:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/test_packages.json 17:06:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/test_packages.json 17:06:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:06:20 INFO - Downloaded 1448 bytes. 17:06:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:06:20 INFO - Using the following test package requirements: 17:06:20 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:20 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:06:20 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:06:20 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:20 INFO - u'jsshell-linux-x86_64.zip'], 17:06:20 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:06:20 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:20 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:06:20 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:06:20 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:06:20 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:20 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:06:20 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:20 INFO - https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:06:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:06:23 INFO - Downloaded 22439306 bytes. 17:06:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:06:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:06:24 INFO - Return code: 0 17:06:24 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 17:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:24 INFO - https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:06:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:06:27 INFO - Downloaded 22439306 bytes. 17:06:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:06:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:06:28 INFO - Return code: 0 17:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:28 INFO - https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:06:30 INFO - Downloaded 11132144 bytes. 17:06:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:06:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 17:06:30 INFO - Return code: 0 17:06:30 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')]} 17:06:30 INFO - https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTYKSjikTjKKXUQQCQO9YA/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 17:06:37 INFO - Downloaded 55952475 bytes. 17:06:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:37 INFO - mkdir: /builds/slave/test-pgo/properties 17:06:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:06:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:06:37 INFO - Contents: 17:06:37 INFO - build_url:https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:37 INFO - Running post-action listener: _resource_record_post_action 17:06:37 INFO - Running post-action listener: set_extra_try_arguments 17:06:37 INFO - ##### 17:06:37 INFO - ##### Running populate-webroot step. 17:06:37 INFO - ##### 17:06:37 INFO - Running pre-action listener: _resource_record_pre_action 17:06:37 INFO - Running main action method: populate_webroot 17:06:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:06:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:06:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:06:37 INFO - '--tppagecycles', 17:06:37 INFO - '7'], 17:06:37 INFO - 'tests': ['tsvgm']}}, 17:06:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:06:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:06:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:06:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:06:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:06:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:37 INFO - 'talos_options': ['--e10s'], 17:06:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:37 INFO - 'tests': ['damp', 'tps']}, 17:06:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:37 INFO - 'talos_options': ['--e10s'], 17:06:37 INFO - 'tests': ['damp', 'tps']}, 17:06:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:06:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:37 INFO - 'other': {'tests': ['a11yr', 17:06:37 INFO - 'ts_paint', 17:06:37 INFO - 'tpaint', 17:06:37 INFO - 'sessionrestore', 17:06:37 INFO - 'sessionrestore_no_auto_restore']}, 17:06:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:06:37 INFO - 'tests': ['a11yr', 17:06:37 INFO - 'ts_paint', 17:06:37 INFO - 'tpaint', 17:06:37 INFO - 'sessionrestore', 17:06:37 INFO - 'sessionrestore_no_auto_restore']}, 17:06:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:06:37 INFO - 'tests': ['a11yr', 17:06:37 INFO - 'ts_paint', 17:06:37 INFO - 'tpaint', 17:06:37 INFO - 'sessionrestore', 17:06:37 INFO - 'sessionrestore_no_auto_restore']}, 17:06:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:06:37 INFO - 'tests': ['a11yr', 17:06:37 INFO - 'ts_paint', 17:06:37 INFO - 'tpaint', 17:06:37 INFO - 'sessionrestore', 17:06:37 INFO - 'sessionrestore_no_auto_restore']}, 17:06:37 INFO - 'other_l64': {'tests': ['a11yr', 17:06:37 INFO - 'ts_paint', 17:06:37 INFO - 'tpaint', 17:06:37 INFO - 'sessionrestore', 17:06:37 INFO - 'sessionrestore_no_auto_restore']}, 17:06:37 INFO - 'other_nol64': {'tests': ['a11yr', 17:06:37 INFO - 'ts_paint', 17:06:37 INFO - 'tpaint', 17:06:37 INFO - 'sessionrestore', 17:06:37 INFO - 'sessionrestore_no_auto_restore']}, 17:06:37 INFO - 'svgr': {'tests': ['tsvgx', 17:06:37 INFO - 'tsvgr_opacity', 17:06:37 INFO - 'tart', 17:06:37 INFO - 'tscrollx', 17:06:37 INFO - 'cart']}, 17:06:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:06:37 INFO - 'tests': ['tsvgx', 17:06:37 INFO - 'tsvgr_opacity', 17:06:37 INFO - 'tart', 17:06:37 INFO - 'tscrollx', 17:06:37 INFO - 'cart']}, 17:06:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:37 INFO - 'tests': ['tp5o']}, 17:06:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:37 INFO - 'talos_options': ['--e10s'], 17:06:37 INFO - 'tests': ['tp5o']}, 17:06:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:37 INFO - 'talos_options': ['--xperf_path', 17:06:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:37 INFO - 'tests': ['tp5n']}, 17:06:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:37 INFO - 'talos_options': ['--e10s', 17:06:37 INFO - '--xperf_path', 17:06:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:37 INFO - 'tests': ['tp5n']}}, 17:06:37 INFO - 'talos.zip': {'path': '', 17:06:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:06:37 INFO - Running post-action listener: _resource_record_post_action 17:06:37 INFO - ##### 17:06:37 INFO - ##### Running create-virtualenv step. 17:06:37 INFO - ##### 17:06:37 INFO - Running pre-action listener: _resource_record_pre_action 17:06:37 INFO - Running main action method: create_virtualenv 17:06:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:06:37 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 17:06:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:06:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:37 INFO - Using real prefix '/usr' 17:06:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:06:37 INFO - Installing distribute.............................................................................................................................................................................................done. 17:06:39 INFO - Installing pip.................done. 17:06:39 INFO - Return code: 0 17:06:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:06: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')]} 17:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a0362cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2492630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523840>, '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 0x24906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490b60>, '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': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', '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 17:06:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:06:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:06:39 INFO - Using env: {'DISPLAY': ':0', 17:06:39 INFO - 'HOME': '/home/cltbld', 17:06:39 INFO - 'LANG': 'en_US.UTF-8', 17:06:39 INFO - 'LANGUAGE': 'en_US:en', 17:06:39 INFO - 'LOGNAME': 'cltbld', 17:06:39 INFO - 'MAIL': '/var/mail/cltbld', 17:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:39 INFO - 'MOZ_NO_REMOTE': '1', 17:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:39 INFO - 'NO_EM_RESTART': '1', 17:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:39 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:39 INFO - 'SHELL': '/bin/bash', 17:06:39 INFO - 'SHLVL': '1', 17:06:39 INFO - 'TERM': 'linux', 17:06:39 INFO - 'TMOUT': '86400', 17:06:39 INFO - 'USER': 'cltbld', 17:06:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', 17:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:39 INFO - '_': '/tools/buildbot/bin/python'} 17:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:39 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 17:06:39 INFO - Cleaning up... 17:06:39 INFO - Return code: 0 17:06:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:06: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')]} 17:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7a0362cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2492630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523840>, '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 0x24906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490b60>, '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': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', '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 17:06:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:06:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:06:39 INFO - Using env: {'DISPLAY': ':0', 17:06:39 INFO - 'HOME': '/home/cltbld', 17:06:39 INFO - 'LANG': 'en_US.UTF-8', 17:06:39 INFO - 'LANGUAGE': 'en_US:en', 17:06:39 INFO - 'LOGNAME': 'cltbld', 17:06:39 INFO - 'MAIL': '/var/mail/cltbld', 17:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:39 INFO - 'MOZ_NO_REMOTE': '1', 17:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:39 INFO - 'NO_EM_RESTART': '1', 17:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:39 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:39 INFO - 'SHELL': '/bin/bash', 17:06:39 INFO - 'SHLVL': '1', 17:06:39 INFO - 'TERM': 'linux', 17:06:39 INFO - 'TMOUT': '86400', 17:06:39 INFO - 'USER': 'cltbld', 17:06:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', 17:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:39 INFO - '_': '/tools/buildbot/bin/python'} 17:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:40 INFO - Downloading/unpacking psutil>=0.7.1 17:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:41 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:06:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:06:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:06:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:41 INFO - Installing collected packages: psutil 17:06:41 INFO - Running setup.py install for psutil 17:06:41 INFO - building 'psutil._psutil_linux' extension 17:06:41 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 17:06:42 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 17:06:42 INFO - building 'psutil._psutil_posix' extension 17:06:42 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 17:06:42 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 17:06:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:42 INFO - Successfully installed psutil 17:06:42 INFO - Cleaning up... 17:06:42 INFO - Return code: 0 17:06:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:06:42 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')]} 17:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:42 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')]} 17:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:42 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 0x7f7a0362cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2492630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523840>, '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 0x24906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490b60>, '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': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', '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 17:06:42 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 17:06:42 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 17:06:42 INFO - Using env: {'DISPLAY': ':0', 17:06:42 INFO - 'HOME': '/home/cltbld', 17:06:42 INFO - 'LANG': 'en_US.UTF-8', 17:06:42 INFO - 'LANGUAGE': 'en_US:en', 17:06:42 INFO - 'LOGNAME': 'cltbld', 17:06:42 INFO - 'MAIL': '/var/mail/cltbld', 17:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:42 INFO - 'MOZ_NO_REMOTE': '1', 17:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:42 INFO - 'NO_EM_RESTART': '1', 17:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:42 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:42 INFO - 'SHELL': '/bin/bash', 17:06:42 INFO - 'SHLVL': '1', 17:06:42 INFO - 'TERM': 'linux', 17:06:42 INFO - 'TMOUT': '86400', 17:06:42 INFO - 'USER': 'cltbld', 17:06:42 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', 17:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:42 INFO - '_': '/tools/buildbot/bin/python'} 17:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:06:42 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 17:06:42 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 17:06:42 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 17:06:42 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 17:06:42 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 17:06:42 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 17:06:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:06:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:06:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:06:44 INFO - Installing collected packages: mozsystemmonitor 17:06:44 INFO - Running setup.py install for mozsystemmonitor 17:06:44 INFO - Successfully installed mozsystemmonitor 17:06:44 INFO - Cleaning up... 17:06:44 INFO - Return code: 0 17:06:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:06:44 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')]} 17:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:44 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')]} 17:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:44 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 0x7f7a0362cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2492630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523840>, '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 0x24906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490b60>, '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': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', '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 17:06:44 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 17:06:44 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 17:06:44 INFO - Using env: {'DISPLAY': ':0', 17:06:44 INFO - 'HOME': '/home/cltbld', 17:06:44 INFO - 'LANG': 'en_US.UTF-8', 17:06:44 INFO - 'LANGUAGE': 'en_US:en', 17:06:44 INFO - 'LOGNAME': 'cltbld', 17:06:44 INFO - 'MAIL': '/var/mail/cltbld', 17:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:44 INFO - 'MOZ_NO_REMOTE': '1', 17:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:44 INFO - 'NO_EM_RESTART': '1', 17:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:44 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:44 INFO - 'SHELL': '/bin/bash', 17:06:44 INFO - 'SHLVL': '1', 17:06:44 INFO - 'TERM': 'linux', 17:06:44 INFO - 'TMOUT': '86400', 17:06:44 INFO - 'USER': 'cltbld', 17:06:44 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', 17:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:44 INFO - '_': '/tools/buildbot/bin/python'} 17:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:44 INFO - Downloading/unpacking blobuploader==1.2.4 17:06:44 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 17:06:44 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 17:06:44 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 17:06:44 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 17:06:44 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 17:06:44 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 17:06:46 INFO - Downloading blobuploader-1.2.4.tar.gz 17:06:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:06:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:06:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:06:46 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 17:06:46 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 17:06:46 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 17:06:46 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 17:06:46 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 17:06:46 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 17:06:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:06:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:06:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:06:46 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 17:06:46 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 17:06:46 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 17:06:46 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 17:06:46 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 17:06:46 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 17:06:47 INFO - Downloading docopt-0.6.1.tar.gz 17:06:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:06:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:06:47 INFO - Installing collected packages: blobuploader, requests, docopt 17:06:47 INFO - Running setup.py install for blobuploader 17:06:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:06:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:06:47 INFO - Running setup.py install for requests 17:06:47 INFO - Running setup.py install for docopt 17:06:47 INFO - Successfully installed blobuploader requests docopt 17:06:47 INFO - Cleaning up... 17:06:47 INFO - Return code: 0 17:06:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:06: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')]} 17:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:47 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 0x7f7a0362cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2492630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523840>, '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 0x24906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490b60>, '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': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', '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 17:06:47 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 17:06:47 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 17:06:47 INFO - Using env: {'DISPLAY': ':0', 17:06:47 INFO - 'HOME': '/home/cltbld', 17:06:47 INFO - 'LANG': 'en_US.UTF-8', 17:06:47 INFO - 'LANGUAGE': 'en_US:en', 17:06:47 INFO - 'LOGNAME': 'cltbld', 17:06:47 INFO - 'MAIL': '/var/mail/cltbld', 17:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:47 INFO - 'MOZ_NO_REMOTE': '1', 17:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:47 INFO - 'NO_EM_RESTART': '1', 17:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:47 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:47 INFO - 'SHELL': '/bin/bash', 17:06:47 INFO - 'SHLVL': '1', 17:06:47 INFO - 'TERM': 'linux', 17:06:47 INFO - 'TMOUT': '86400', 17:06:47 INFO - 'USER': 'cltbld', 17:06:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', 17:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:47 INFO - '_': '/tools/buildbot/bin/python'} 17:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:06:48 INFO - Running setup.py (path:/tmp/pip-PHkHtg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:06:48 INFO - Running setup.py (path:/tmp/pip-g0UsKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:06:48 INFO - Running setup.py (path:/tmp/pip-sQ1jYt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:06:48 INFO - Running setup.py (path:/tmp/pip-UWtv4r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:06:48 INFO - Running setup.py (path:/tmp/pip-WhI7B3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:06:48 INFO - Running setup.py (path:/tmp/pip-lCBFTH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:06:48 INFO - Running setup.py (path:/tmp/pip-6mgJ5P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:06:48 INFO - Running setup.py (path:/tmp/pip-wUS0g1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:06:48 INFO - Running setup.py (path:/tmp/pip-YnQ3zs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:06:48 INFO - Running setup.py (path:/tmp/pip-YD1V9B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:06:48 INFO - Running setup.py (path:/tmp/pip-a7AjPS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:06:49 INFO - Running setup.py (path:/tmp/pip-GIiCd8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:06:49 INFO - Running setup.py (path:/tmp/pip-C3mPlg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:06:49 INFO - Running setup.py (path:/tmp/pip-eBuZgn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:06:49 INFO - Running setup.py (path:/tmp/pip-XDgO9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:06:49 INFO - Running setup.py (path:/tmp/pip-a7VkVW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:06:49 INFO - Running setup.py (path:/tmp/pip-PcbypJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:06:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:06:49 INFO - Running setup.py install for manifestparser 17:06:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:06:49 INFO - Running setup.py install for mozcrash 17:06:49 INFO - Running setup.py install for mozdebug 17:06:49 INFO - Running setup.py install for mozdevice 17:06:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:06:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:06:49 INFO - Running setup.py install for mozfile 17:06:50 INFO - Running setup.py install for mozhttpd 17:06:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:06:50 INFO - Running setup.py install for mozinfo 17:06:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:06:50 INFO - Running setup.py install for mozInstall 17:06:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:06:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:06:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:06:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:06:50 INFO - Running setup.py install for mozleak 17:06:50 INFO - Running setup.py install for mozlog 17:06:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:06:50 INFO - Running setup.py install for moznetwork 17:06:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:06:50 INFO - Running setup.py install for mozprocess 17:06:50 INFO - Running setup.py install for mozprofile 17:06:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:06:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:06:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:06:50 INFO - Running setup.py install for mozrunner 17:06:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:06:51 INFO - Running setup.py install for mozscreenshot 17:06:51 INFO - Running setup.py install for moztest 17:06:51 INFO - Running setup.py install for mozversion 17:06:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:06:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:06:51 INFO - Cleaning up... 17:06:51 INFO - Return code: 0 17:06:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:06: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')]} 17:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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', '-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 0x7f7a0362cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2492630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523840>, '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 0x24906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490b60>, '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': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', '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 17:06:51 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 17:06:51 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 17:06:51 INFO - Using env: {'DISPLAY': ':0', 17:06:51 INFO - 'HOME': '/home/cltbld', 17:06:51 INFO - 'LANG': 'en_US.UTF-8', 17:06:51 INFO - 'LANGUAGE': 'en_US:en', 17:06:51 INFO - 'LOGNAME': 'cltbld', 17:06:51 INFO - 'MAIL': '/var/mail/cltbld', 17:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:51 INFO - 'MOZ_NO_REMOTE': '1', 17:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:51 INFO - 'NO_EM_RESTART': '1', 17:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:51 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:51 INFO - 'SHELL': '/bin/bash', 17:06:51 INFO - 'SHLVL': '1', 17:06:51 INFO - 'TERM': 'linux', 17:06:51 INFO - 'TMOUT': '86400', 17:06:51 INFO - 'USER': 'cltbld', 17:06:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', 17:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:51 INFO - '_': '/tools/buildbot/bin/python'} 17:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:06:51 INFO - Running setup.py (path:/tmp/pip-wle8_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:06:51 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)) 17:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:06:51 INFO - Running setup.py (path:/tmp/pip-PxsI2S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:06:51 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)) 17:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:06:51 INFO - Running setup.py (path:/tmp/pip-is5YKo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:06:51 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)) 17:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:06:51 INFO - Running setup.py (path:/tmp/pip-D1_jwV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:06:51 INFO - Running setup.py (path:/tmp/pip-URzIf5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:06:51 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)) 17:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:06:51 INFO - Running setup.py (path:/tmp/pip-FJcDk_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:06:51 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)) 17:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:06:51 INFO - Running setup.py (path:/tmp/pip-VCKzVr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:06:52 INFO - Running setup.py (path:/tmp/pip-AnNZP4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:06:52 INFO - Running setup.py (path:/tmp/pip-xSICKE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:06:52 INFO - Running setup.py (path:/tmp/pip-3zKwOh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:06:52 INFO - Running setup.py (path:/tmp/pip-Gh47Lr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:06:52 INFO - Running setup.py (path:/tmp/pip-dh8HIf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:06:52 INFO - Running setup.py (path:/tmp/pip-TNLSZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:06:52 INFO - Running setup.py (path:/tmp/pip-WNVwEj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:06:52 INFO - Running setup.py (path:/tmp/pip-kG3PyC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:06:52 INFO - Running setup.py (path:/tmp/pip-zLF3R2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:06:52 INFO - Running setup.py (path:/tmp/pip-m02ULy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:06:52 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)) 17:06:52 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)) 17:06:52 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)) 17:06:52 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)) 17:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:06:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:54 INFO - Downloading blessings-1.5.1.tar.gz 17:06:54 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 17:06:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:06:54 INFO - Installing collected packages: blessings 17:06:54 INFO - Running setup.py install for blessings 17:06:54 INFO - Successfully installed blessings 17:06:54 INFO - Cleaning up... 17:06:54 INFO - Return code: 0 17:06:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:06:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:06:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:06:54 INFO - Reading from file tmpfile_stdout 17:06:54 INFO - Current package versions: 17:06:54 INFO - argparse == 1.2.1 17:06:54 INFO - blessings == 1.5.1 17:06:54 INFO - blobuploader == 1.2.4 17:06:54 INFO - docopt == 0.6.1 17:06:54 INFO - manifestparser == 1.1 17:06:54 INFO - mozInstall == 1.12 17:06:54 INFO - mozcrash == 0.16 17:06:54 INFO - mozdebug == 0.1 17:06:54 INFO - mozdevice == 0.48 17:06:54 INFO - mozfile == 1.2 17:06:54 INFO - mozhttpd == 0.7 17:06:54 INFO - mozinfo == 0.9 17:06:54 INFO - mozleak == 0.1 17:06:54 INFO - mozlog == 3.1 17:06:54 INFO - moznetwork == 0.27 17:06:54 INFO - mozprocess == 0.22 17:06:54 INFO - mozprofile == 0.28 17:06:54 INFO - mozrunner == 6.11 17:06:54 INFO - mozscreenshot == 0.1 17:06:54 INFO - mozsystemmonitor == 0.0 17:06:54 INFO - moztest == 0.7 17:06:54 INFO - mozversion == 1.4 17:06:54 INFO - psutil == 3.1.1 17:06:54 INFO - requests == 1.2.3 17:06:54 INFO - wsgiref == 0.1.2 17:06:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:54 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 0x7f7a0362cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2492630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523840>, '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 0x24906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490b60>, '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': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', '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 17:06:54 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 17:06:54 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 17:06:54 INFO - Using env: {'DISPLAY': ':0', 17:06:54 INFO - 'HOME': '/home/cltbld', 17:06:54 INFO - 'LANG': 'en_US.UTF-8', 17:06:54 INFO - 'LANGUAGE': 'en_US:en', 17:06:54 INFO - 'LOGNAME': 'cltbld', 17:06:54 INFO - 'MAIL': '/var/mail/cltbld', 17:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:54 INFO - 'MOZ_NO_REMOTE': '1', 17:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:54 INFO - 'NO_EM_RESTART': '1', 17:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:54 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:54 INFO - 'SHELL': '/bin/bash', 17:06:54 INFO - 'SHLVL': '1', 17:06:54 INFO - 'TERM': 'linux', 17:06:54 INFO - 'TMOUT': '86400', 17:06:54 INFO - 'USER': 'cltbld', 17:06:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', 17:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:54 INFO - '_': '/tools/buildbot/bin/python'} 17:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 INFO - Cleaning up... 17:06:55 INFO - Return code: 0 17:06:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:06: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')]} 17:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:55 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 0x7f7a0362cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2492630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523840>, '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 0x24906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490b60>, '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': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', '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 17:06:55 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 17:06:55 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 17:06:55 INFO - Using env: {'DISPLAY': ':0', 17:06:55 INFO - 'HOME': '/home/cltbld', 17:06:55 INFO - 'LANG': 'en_US.UTF-8', 17:06:55 INFO - 'LANGUAGE': 'en_US:en', 17:06:55 INFO - 'LOGNAME': 'cltbld', 17:06:55 INFO - 'MAIL': '/var/mail/cltbld', 17:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:55 INFO - 'MOZ_NO_REMOTE': '1', 17:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:55 INFO - 'NO_EM_RESTART': '1', 17:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:55 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:55 INFO - 'SHELL': '/bin/bash', 17:06:55 INFO - 'SHLVL': '1', 17:06:55 INFO - 'TERM': 'linux', 17:06:55 INFO - 'TMOUT': '86400', 17:06:55 INFO - 'USER': 'cltbld', 17:06:55 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', 17:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:55 INFO - '_': '/tools/buildbot/bin/python'} 17:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:55 INFO - Downloading/unpacking jsonschema 17:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:06:57 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 17:06:57 INFO - Downloading/unpacking functools32 (from jsonschema) 17:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:57 INFO - Downloading functools32-3.2.3-2.tar.gz 17:06:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:06:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:06:57 INFO - warning: no files found matching '*.txt' 17:06:57 INFO - no previously-included directories found matching 'build' 17:06:57 INFO - no previously-included directories found matching 'dist' 17:06:57 INFO - no previously-included directories found matching '.git*' 17:06:57 INFO - Installing collected packages: jsonschema, functools32 17:06:57 INFO - Running setup.py install for functools32 17:06:57 INFO - warning: no files found matching '*.txt' 17:06:57 INFO - no previously-included directories found matching 'build' 17:06:57 INFO - no previously-included directories found matching 'dist' 17:06:57 INFO - no previously-included directories found matching '.git*' 17:06:57 INFO - Successfully installed jsonschema functools32 17:06:57 INFO - Cleaning up... 17:06:57 INFO - Return code: 0 17:06:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:57 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 0x7f7a0362cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2492630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523840>, '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 0x24906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490b60>, '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': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', '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 17:06:57 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 17:06:57 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 17:06:57 INFO - Using env: {'DISPLAY': ':0', 17:06:57 INFO - 'HOME': '/home/cltbld', 17:06:57 INFO - 'LANG': 'en_US.UTF-8', 17:06:57 INFO - 'LANGUAGE': 'en_US:en', 17:06:57 INFO - 'LOGNAME': 'cltbld', 17:06:57 INFO - 'MAIL': '/var/mail/cltbld', 17:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:57 INFO - 'MOZ_NO_REMOTE': '1', 17:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:57 INFO - 'NO_EM_RESTART': '1', 17:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:57 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:57 INFO - 'SHELL': '/bin/bash', 17:06:57 INFO - 'SHLVL': '1', 17:06:57 INFO - 'TERM': 'linux', 17:06:57 INFO - 'TMOUT': '86400', 17:06:57 INFO - 'USER': 'cltbld', 17:06:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', 17:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:57 INFO - '_': '/tools/buildbot/bin/python'} 17:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:57 INFO - Downloading/unpacking flake8 17:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:07:00 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 17:07:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:07:00 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 17:07:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:07:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:07:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:00 INFO - no previously-included directories found matching 'docs/_build' 17:07:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:07:02 INFO - Running setup.py install for pep8 17:07:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:02 INFO - no previously-included directories found matching 'docs/_build' 17:07:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:07:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:07:02 INFO - Cleaning up... 17:07:02 INFO - Return code: 0 17:07:02 INFO - Running post-action listener: _resource_record_post_action 17:07:02 INFO - Running post-action listener: _start_resource_monitoring 17:07:02 INFO - Starting resource monitoring. 17:07:02 INFO - ##### 17:07:02 INFO - ##### Running install step. 17:07:02 INFO - ##### 17:07:02 INFO - Running pre-action listener: _resource_record_pre_action 17:07:02 INFO - Running main action method: install 17:07:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:07:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:07:03 INFO - Reading from file tmpfile_stdout 17:07:03 INFO - Detecting whether we're running mozinstall >=1.0... 17:07:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:07:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:07:03 INFO - Reading from file tmpfile_stdout 17:07:03 INFO - Output received: 17:07:03 INFO - Usage: mozinstall [options] installer 17:07:03 INFO - Options: 17:07:03 INFO - -h, --help show this help message and exit 17:07:03 INFO - -d DEST, --destination=DEST 17:07:03 INFO - Directory to install application into. [default: 17:07:03 INFO - "/builds/slave/test-pgo"] 17:07:03 INFO - --app=APP Application being installed. [default: firefox] 17:07:03 INFO - mkdir: /builds/slave/test-pgo/build/application 17:07:03 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'] 17:07:03 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 17:07:19 INFO - Reading from file tmpfile_stdout 17:07:19 INFO - Output received: 17:07:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:07:19 INFO - Running post-action listener: _resource_record_post_action 17:07:19 INFO - ##### 17:07:19 INFO - ##### Running run-tests step. 17:07:19 INFO - ##### 17:07:19 INFO - Running pre-action listener: _resource_record_pre_action 17:07:19 INFO - Running main action method: run_tests 17:07:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:07:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:07:19 INFO - Python 2.7.3 17:07:19 INFO - Return code: 0 17:07:19 INFO - grabbing minidump binary from tooltool 17:07:19 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')]} 17:07:19 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 0x2523840>, '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 0x24906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:07:19 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 17:07:19 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 17:07:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:19 INFO - Return code: 0 17:07:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:07:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:07:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:07:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:07:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:07:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:07:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:07:20 INFO - Return code: 0 17:07:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 17:07:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 17:07:20 INFO - Using env: {'DISPLAY': ':0', 17:07:20 INFO - 'HOME': '/home/cltbld', 17:07:20 INFO - 'LANG': 'en_US.UTF-8', 17:07:20 INFO - 'LANGUAGE': 'en_US:en', 17:07:20 INFO - 'LOGNAME': 'cltbld', 17:07:20 INFO - 'MAIL': '/var/mail/cltbld', 17:07:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:07:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:20 INFO - 'MOZ_NO_REMOTE': '1', 17:07:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:20 INFO - 'NO_EM_RESTART': '1', 17:07:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:07:20 INFO - 'PWD': '/builds/slave/test-pgo', 17:07:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:07:20 INFO - 'SHELL': '/bin/bash', 17:07:20 INFO - 'SHLVL': '1', 17:07:20 INFO - 'TERM': 'linux', 17:07:20 INFO - 'TMOUT': '86400', 17:07:20 INFO - 'USER': 'cltbld', 17:07:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1452819975.856976-1177906198', 17:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:20 INFO - '_': '/tools/buildbot/bin/python'} 17:07:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 17:07:20 INFO - mozversion application_buildid: 20160114143022 17:07:20 INFO - mozversion application_changeset: b6ef37a7673e9829de96d0439244343948545955 17:07:20 INFO - mozversion application_display_name: Nightly 17:07:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:20 INFO - mozversion application_name: Firefox 17:07:20 INFO - mozversion application_remotingname: firefox 17:07:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:07:20 INFO - mozversion application_vendor: Mozilla 17:07:20 INFO - mozversion application_version: 46.0a1 17:07:20 INFO - mozversion platform_buildid: 20160114143022 17:07:20 INFO - mozversion platform_changeset: b6ef37a7673e9829de96d0439244343948545955 17:07:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:07:20 INFO - mozversion platform_version: 46.0a1 17:07:20 INFO - using testdate: 1452820040 17:07:20 INFO - actual date: 1452820040 17:07:20 INFO - starting webserver on 'localhost:52389' 17:07:20 INFO - SUITE-START | Running 3 tests 17:07:20 INFO - TEST-START | dromaeo_css 17:07:20 INFO - operating with platform_type : linux_ 17:07:20 INFO - Initialising browser for dromaeo_css test... 17:07:20 INFO - TEST-INFO | started process 14213 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl4oeo6/profile http://localhost:52389/getInfo.html) 17:07:25 INFO - PROCESS | 14213 | __metrics Screen width/height:1600/1200 17:07:25 INFO - PROCESS | 14213 | colorDepth:24 17:07:25 INFO - PROCESS | 14213 | Browser inner width/height: 1024/697 17:07:25 INFO - PROCESS | 14213 | __metrics 17:07:26 INFO - PROCESS | 14213 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:07:26 INFO - PROCESS | 14213 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:07:27 INFO - TEST-INFO | 14213: exit 0 17:07:27 INFO - Browser initialized. 17:07:27 INFO - Running cycle 1/1 for dromaeo_css test... 17:07:27 INFO - TEST-INFO | started process 14309 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl4oeo6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:39 INFO - PROCESS | 14309 | RSS: Main: 150847488 17:07:39 INFO - PROCESS | 14309 | 17:08:30 INFO - PROCESS | 14309 | 1452820110689 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] 17:10:39 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:52389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52389/tests/dromaeo/cssquery-ext.html) 17:10:40 INFO - PROCESS | 14309 | RSS: Main: 243499008 17:10:40 INFO - PROCESS | 14309 | 17:13:42 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:52389/tests/dromaeo/cssquery-ext.html (next: http://localhost:52389/tests/dromaeo/cssquery-jquery.html) 17:13:43 INFO - PROCESS | 14309 | RSS: Main: 226091008 17:13:43 INFO - PROCESS | 14309 | 17:16:45 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:52389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52389/tests/dromaeo/cssquery-mootools.html) 17:16:45 INFO - PROCESS | 14309 | RSS: Main: 243503104 17:16:45 INFO - PROCESS | 14309 | 17:19:47 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:52389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52389/tests/dromaeo/cssquery-prototype.html) 17:19:48 INFO - PROCESS | 14309 | RSS: Main: 207589376 17:19:48 INFO - PROCESS | 14309 | 17:22:50 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:52389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52389/tests/dromaeo/cssquery-yui.html) 17:22:51 INFO - PROCESS | 14309 | RSS: Main: 209043456 17:22:51 INFO - PROCESS | 14309 | 17:25:54 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:52389/tests/dromaeo/cssquery-yui.html (next: http://localhost:52389/tests/dromaeo/cssquery-dojo.html) 17:25:54 INFO - PROCESS | 14309 | RSS: Main: 276242432 17:25:54 INFO - PROCESS | 14309 | 17:25:54 INFO - PROCESS | 14309 | __start_tp_report 17:25:54 INFO - PROCESS | 14309 | _x_x_mozilla_page_load 17:25:54 INFO - PROCESS | 14309 | _x_x_mozilla_page_load_details 17:25:54 INFO - PROCESS | 14309 | |i|pagename|runs| 17:25:54 INFO - PROCESS | 14309 | |0;dojo.html;3113.78203525753;3117.3609410070935;3156.4949608062716;3169.9207519812016;3181.7136457718802;5071.1632580624155;5141.691498510092;5164.974175129124;5181.041507321148;5200.401953775312;5094.1594636884865;5114.590832733382;5162.741862906859;5205.791768329272;5231.5814734821215;4723.456802467708;4731.668783185179;4745.766100813796;4763.523647635226;4848.393950756155;4786.4974177711365;4790.904181916377;4837.177679794443;4838.9274160887435;4880.536349046835;4688.437387513521;4728.645351598644;4759.214729569617;4791.496892826255;4792;4763.571278584909;4775.283707443877;4779.211430114027;4779.641526885497;4782.593479554242;4646.628269738413;4734.526547345238;4736.881577960544;4743.1225223333795;4743.35964644772;4967.950320496785;4970.801167953277;4971.477994810529;4973.229149481836;4998.425181104183;5481.972590137064;5494.066008778477;5494.36814766303;5509.696966666832;5548.944510554924;5491.176323551499;5522.751476183541;5534.446555344433;5581.832545023656;5620.100783874561;5243.711595862188;5244.423113457517;5244.763985620618;5256.448072952323;5270.6047046471285;5633.549316054706;5670.943290567124;5681.318241811009;5683.943160568341;5687.203791469197;5394.460553944574;5469.316335458067;5478.315210598676;5480.3971563128025;5588.441155884379;5580;5593.664380137205;5606.887862242732;5607;5609.382967873531;5558.166275058693;5578.135389014709;5585.3297604287745;5586.748596313176;5591.52472039873;5444.754986025639;5518;5632.915506267409;5686.459786320293;5718.370979192368;4361.629261512743;4361.694681372273;4366.541513141138;4368.650507959355;4399.450068741407;3893.4743809585343;3895.4156876468755;3903.59012303704;3946.7039972002217;3952.8616498422416;5102.107131252016;5154.123798954187;5184.403793563789;5186.170212765939;5188.870278242998;5522.978249023943;5546.389897111315;5553.250311208016;5560.2493663355735;5562.082256427644;5154.175331946871;5158.509941555546;5163.4062082860955;5170.870728231825;5204.271402003723;4690.81236750533;4770.976145119253;4773.7374444405195;4804.231322988375;4845.248986407112;5716;5745.511631511285;5747.9137812932;5749.13762935563;5751.85620359486;5432.837014889559;5579.079451890392;5593.944060559343;5594.804181853616;5603;5647.435256474319;5744.885102298014;5774.769009239583;5816.2438882946635;5838.795642152504;5527.170924361378;5536.833894983157;5551.611387202857;5554.805581804618;5557.138643510262;5503.532199763065;5598.832035038955;5611.186377975252;5627.043402621646;5633.380328163817;5380.919286210788;5417.918731219113;5420.105682562333;5423.159410291411;5468.48049435303;5365.785368585213;5469.9179512306555;5473.124300111963;5477.561795056466;5517.806876759294;5256.894862102813;5322.8935421292135;5372.973135134455;5375.704336261387;5379.892402152013;5489.066858633962;5498.697571633438;5500.614956952975;5504.80733174337;5562.165675148598;5380.70406127651;5382.219578161223;5382.434844341287;5393.298871146726;5395.676259424447 17:25:54 INFO - PROCESS | 14309 | |1;ext.html;517.3843126679249;533.9839804805857;554.373557879596;571.7592823572849;576.8356018534718;29041.70958290419;29588.852055739717;29605.703942960565;29618.555721664194;36761.63238367616;39662;40127.19745605093;40174.59825401745;40260.39609405854;40277.798611006976;8393.370497212718;8610.78473038176;8611.526366049864;8612.09572994836;8614;8437.831243375129;8479.830403391928;8544.18830211132;8575.528345940971;8586.828263434727;8525.44584602002;8593.355498337618;8594.527300998443;8614.267787238092;8778.64885404583;8592.742217733477;8759.78100547485;8764.21122099014;8764.693235736782;8768.517731524764;8622.396432249745;8748.21266086049;8755.036945935943;8769.210771030637;8770.298376129895;40454.19091618151;40577.18845623101;40804;40812;40819.183616327806;3263.0700250428513;3263.6246831614194;3669.3945498992634;3856.1709232515145;4016.3373043448087;29325.413491730258;29531;29916.252093697614;30013.24966875824;30317.545236821465;4011.8011593601304;4069.47096877407;4087.509498860126;4113.115680128787;4167.291560434703;270615;272192;272530;273028;273269.63365183247;52570;53771.46228537665;58827;61606.383936160964;62532.37467625357;55332;55381.44618553763;55509.72245138748;55682.72158639181;55721.721391392784;15823.525294241192;15862.841371586368;15973.520794376187;16003.359865605478;16089.115098669452;10753.301035432673;11927.940360298317;11984.760304793856;12000.099992500423;12017;17122.40071597488;20410.18359265613;21015.369538913856;21049.368518944455;21085.89457052705;7863.37093032556;8018.679252829938;8124.431289809657;8451.23938845507;8514.850495183071;948.0708905272871;1080.152080616712;1084.8752393474695;1146.690393593725;1156.1791128298835;28868.566971495446;29136;29293;29664;29843.40313193724;1049.4962418039383;1066.0671912076932;1080.8165059260098;1112.816385296417;1145.7135716070982;15072.924635376972;15278.770818437732;15393.064334142047;15458.458953936559;15554.844451555566;318048;320703;322046;322491;322931;51131;51433.22850157251;51486;51545.22682159771;51547.48452515427;1324.9801252981213;1328.1765305510453;1338.0633556510481;1348.359529223611;1354.3363751761565;23631.763682362955;28468.43063138767;28944;29153.271168220963;29303.853480733313;41847.37228941507;42102;42243.15513689647;42383;42422.27299314676;204351;204807;204995;206171;206862;30900.381992360475;31249;31399.84300078485;32429.67570324361;32707.34585308328;37150.6750998072;37404.251914961;39675.60324396719;40044.79977600093;40146;34905.47641785426;35115.64884351124;35242.82378588091;35560.688555243825;35663.28673426569;34679;35163.64836351706;35442.468362975094;35465;35698.643013569534;34609;34825;35309;36464.27071458503;36516.452253216754;28297.15108546747;29620;30122.849385752932;31118.37763244768;31724.841375792974;24493.265202043967;24625.384365391008;24644.38389040288;25051.87474062618;25105.372365691004 17:25:54 INFO - PROCESS | 14309 | |2;jquery.html;367.4855202716197;368.6479412161385;368.9981550092249;371.19265597325824;374.18427827336393;15752.1336326502;16277.267522961465;16515;17010.914945425287;17042.488725338244;15344.769828452581;15611.297491612877;15810.13044282564;15840.207989600503;15884;5177.585793136559;5180.352455943007;5345.278387417708;5348.144296912495;5355.732213389334;5280.735963201843;5333.146696528556;5358.812441564546;5365.678059316453;5373;3882.3400021996185;4025.9798701006453;5132.717700526469;5344.732763361816;5612.663240205601;5628.465295796893;5749.540036797046;5763.452472015152;5791.189233507313;5791.884162316751;5062.797488100508;5064.82273120439;5069.44236134025;5080.441151473335;5082.567981721558;14924.179170145637;15889.28498217583;18276.177572009292;18931.526711832175;20059;2049.1700861151257;2124.1397234120204;2225.899834507451;2323.790858822714;2496.900123995038;9377.578008989543;10842.512086956027;11518.88481115195;12885.291308978003;13233.338333083308;1826.1964735516462;1851.3150134450204;1858.2474097990334;1874.4001919385803;1886.1889387563342;52573;53432.732836335956;53796.73101634506;54704;54812;9908.405495670282;9951.452670103214;9955.950220248997;9994.450305233282;10120.190384769201;13060.412281447358;13131.34343282832;13152.40814163365;13152.40814163365;13153.21080735159;7146.92853071473;7244.275572442713;7424.220456852061;7435.4795164337975;7467.215942326086;7197.568145911157;7216.855662886713;7270.054892864;7287.781366559012;7298.781036568806;3981.5023122109737;4123.628873401348;4355.477342718894;4424.557544245614;4469.687121901501;1783.1440908363797;1819.4814477873742;1859.1447933950265;1868.1033104110104;1892.4701083696311;441.7901496789;446.2948541304731;452.27861560810453;845.323741007204;923.7598224461553;9407.43555386679;10106.494675266207;10663.89336106629;10682;10857.67426977192;450.5652045775777;467.9485256621769;468.4261779320373;477.99859294777383;484.964600577762;5756.5682573807135;6092.390760923872;6255.374462553708;6321.336259692758;6340.682965851781;354638;521125;528257;538264;543677;59246.40753592409;72784.27215727881;72796.27203728001;76445.6177719119;77053.2294677046;497.8406909788905;511.09281026178087;511.28420211703167;512.0961502947301;513.204532973889;10303.433311167957;10394.636187733393;10487.318324308895;10496;10726.570937162425;32921;32981.17547061247;33236.33527329392;33260.1684957878;33270.334593308486;42735.57264427316;42898.142037159705;44366.556334436245;45169.32246016378;45398.77300613476;7324.230955749783;7534.773956781305;7547.0943486781935;7622.085349758065;7691.38468922496;10749.62376316825;11141.944290278496;11511.30932144074;11900.464479098287;11957.461914214055;9636.42181469114;9694.46680432583;9719.9028009719;10054.798904022025;10095.596176152872;2999.820010799359;3024.047425061187;9872.630568663613;9971.950140249251;10161.796764064826;9902.356346837432;9923.1069203772;10237.795244095225;10249.180065594586;10273.897261027294;7756.263155000266;7856.292933636;7875.881861772193;7876.921230787848;7883.408744344082;9649.807003860024;10304.536295866854;10597.682069537927;10730.678079657622;10797.892021079688 17:25:54 INFO - PROCESS | 14309 | |3;mootools.html;1284.8072789081643;1478.7855760914667;1481.3852251315705;1623.6103335199555;1817.4002579148882;7062.894056589149;7634.961825190873;7797.337226335754;7805.453618246711;7833.138354780969;7638.38892888569;7817.687292508293;7863.3316168125775;7864.803379915505;7882.527048377101;1991.3428568572335;2043.5299881027372;2266.1162146762777;2312.676225328451;2362.598358279097;2321.8374713770045;2327.7323107842562;2329.324495896188;2330.2892617751577;2330.6154484510034;2261.08426087434;2334.393057804966;2338.9766102339013;2339.9766002340016;2344.9531009379803;2281.133169395627;2313.7570555091643;2318;2318.246569864784;2328.7205535335784;2320.164740693349;2321.4312493439215;2328.2084091408833;2344.0623750499767;2346.425125844179;7968.601569921539;8044.59777011153;8046;8050.5169689818795;8057.798555036171;4870.318155458239;4963.1810751226;4993.151164302078;4998.57512111471;5000.449950505442;3065.938681226385;3105.813651180914;3147.921301967446;3263.461528847737;3265.7387409007224;1093.2016832310883;1105.2815669814604;1105.3312745788762;1110.189561620022;1125.5441546173813;10835.51240194193;10919;10934.398608076554;10937.617183398543;10952.97369986547;4451.688381813242;4481.887952801141;4492.393526873896;4503.527129651405;4549.431321084864;9392.436453812794;9394.859077113848;9400.858987115198;9401.10689484498;9401.388909720847;4908.680935739237;4909.509049095133;4936.037472692862;4936.802527898843;4937.11131996237;4445.666575006888;4474.418325617714;4495.595396414338;4496.865094047183;4504.864854054384;3465.86136554535;3525.894223173309;3718.5909549949483;3746.119661879456;3837.4052021936645;1203.8495188101488;1220.3776074202044;1222.6698791326291;1229.9877001230052;1256.2274201366095;1105.2815669814524;1132.043423307304;1135.1202817816259;1297.2605614799663;1371.6296599918167;7239.058922340062;7242.529235599669;7245.89131163033;7541.886871696929;7826.686932522749;1135.3641960502146;1135.4663308245113;1136.1989797193125;1143.5413860200636;1155.179822326141;5936.525077993837;5992.550558708114;6030.788922387783;6034.336223015464;6038.426349496791;9312.674056407994;9774.12032917041;9785.559649815634;9931.602735890483;9966.451845148442;9663.46850923192;9691.418514889128;9816.705498835046;9836;9839.262055345735;7370.852582948418;7626.313631773167;7634.389248860078;7706.691732330756;7711.190325015905;7347.7795666130105;7372.225916278713;7414.888776668462;7425.925740742523;7453.105627324756;8699.956500217459;8725.258353040063;8798.516081615317;8855.104619578675;8895.688650897187;8874;8896.065913079034;9084.818303633758;9102.59038343263;9185.678501252423;6105.481034111973;6828.829279268058;6891.965540172267;6917.827054323682;6948.062011628365;6912.723491060301;7146.249643787535;7263.16473605521;7265.564066156047;7279.344858962719;6764.830879228059;6932.688029038806;6965.477589180933;7028.683709232994;7039.190493093155;6620.271770105188;6633.170853643294;6851.349121833618;6874.415674667509;6878.65606719672;6820.31796820314;6828.692708828214;6865.073215115895;6877.518573699793;7033.577985320897;6524.9021264682015;6616.603003819594;6633.369829866155;6644;6648.1025061616065;6638.601683898982;6683.933160668331;6694.129763130762;6712.2952090031795;6739.359760822714 17:25:54 INFO - PROCESS | 14309 | |4;prototype.html;344.8517137630819;345.7182396346978;346.52353014604915;349.3031402352307;352.165368077656;5688.715564221783;5824.068149096145;5843.941560584393;5917.792877249297;5917.88164236715;5603.2435621191125;5754.136879468082;5780.046292361755;5781.248437703092;5785.768569257235;4556.066006468666;4560.97719511402;4564.42944631921;4564.703294285878;4567.0409214065085;4333.8699839004885;4433.379326894237;4445.933311000337;4538.954610453903;4568.223402021665;4499.077689073749;4503.166914120881;4526.637868970491;4535.773211339436;4553.043860789222;4538.954610453903;4539.614132798716;4543.7728113594185;4545;4558.361829343895;4016.0160760613544;4023.376376661622;4023.718339716221;4026.134381108076;4027.5569687334664;5437.700926449043;5539.972300138474;5566.526845218162;5642.887142257132;5647.971760141214;5179.533841954242;5179.948200517984;5184.248283998837;5214.478552144793;5225.346831646044;5891.3814049525035;6198.3801619838105;6198.690065496708;6199.442050215503;6200.720967556471;4224.345226489899;4244.108737165199;4335.978320108411;4338.349247612852;4346.56534346566;6319.968400158015;6464.482841372679;6474.935250647481;6500.154979852636;6512.7394904203775;4437.66869939017;4450.443694538183;4453.599176074169;4453.777311134495;4465.776711164429;4378.058717375779;4485.955140448619;4490.39379683745;4490.842820501332;4516.209663308908;5181;5181.896362072737;5182.559482444034;5186.507281808223;5187.507186817246;6194.986629345391;6197.504199664016;6201.069839524017;6201.10084037812;6208.689565521706;1568.5608029751688;1583.319172755703;1584.7622856571377;1587.063632456833;1587.1350114187796;1046.4819914142547;1070.2133931560297;1070.5022164693298;1071.5874388360382;1076.8923107689168;5864.765409383577;5865.208196893364;5867.647941123546;5871;5881.470667639847;6366.299707032223;6371.267304259976;6371.617702937839;6377.457916077093;6380.489560835122;5874.206982057368;5875.353711091777;5875.588708790344;5876.236089308448;5879.382664820132;3308.073739352985;3429.125572978924;3433.296174284266;3433.3476639438427;3433.6223015468777;6526.911388355776;6585.5719378240265;6602.2737498875085;6607.075009498674;6619.139511863524;6523.054157147187;6531.640759758259;6536.705848236841;6539.149910511603;6542.280349161589;6380.457661098766;6445.226572811199;6490.188726409199;6590.209174899042;6617;6150.723217455315;6295.433410993032;6408.807735767934;6431.228252609717;6443.516736244894;6184.072389141665;6322.083297921868;6330.8100756977365;6332.208473940757;6361.968190159019;6525.314841941527;6583.111279977142;6586.670666466754;6588.176477940257;6589.418539550377;4328.761918094535;4417.0724147929295;4472.530384309601;4472.843450479218;4473.060657262012;6322.36776322364;6364.713587888464;6379.872402552016;6382.585131966407;6385.361463853577;6170.845728856814;6201.193844800147;6219;6219.875602488016;6226.221722284715;6061.636301821904;6208.565400422108;6210.3168651449205;6213.285472170758;6223.751049958132;6095.451409373178;6103.938960610337;6147;6149.046897730859;6158.137860699416;6230.6884655767935;6316.842078948063;6351.872962540631;6366.808995730135;6376.649284289409;5973.372795856372;6120.387961203844;6155.630662160284;6158.753649853956;6162.322144564005 17:25:54 INFO - PROCESS | 14309 | |5;yui.html;772.8145245141164;796.5380079553855;855.1064137975815;865.788015514921;868.6395146014406;13868.098573592722;13999.580012599612;14005.649858753524;14015;14054.227017514046;13050.151740136884;13134.540291089814;13144.802827957565;13152.079354445194;13153.868461315384;656.7963931181325;665.7802925034752;801.7113839017949;827.0241115483727;829.8174401631661;824.6247957179469;836.9497830130181;837.1419295222385;839.4417712221366;840.6595328891779;869.8042940338405;870.3602851903846;871.4553404122423;872;872.380609767063;684.1687349869907;694.5554844899268;848.9320854331638;864.2524216552699;865.3380164174412;644.7453255963868;646.0793369448517;647.2265642557146;647.5758378262199;647.7441410642817;13376.665583360396;13459.192448453125;13475.66310842227;13500.987425943094;13514;12933.030022748237;13431.32843357838;13614.455421783117;13833.723325533432;13879.097858639156;10419.426931518763;10576.576936922515;10681.145508359312;10760.515776789985;10882.966118218757;3548.982255088708;3650.3611867923273;3650.963490365089;3665.9450108248398;3763.4166704160625;45355.319670204975;45954.31068533975;46053.76973115113;46326.07347853024;47419.76290118528;10287.27989040775;10408.323458975143;10486;10568.788624227473;10954.233203675667;19043.143058562397;19088.33190838314;19136.61726765457;19170.808291916903;19223;7535.434842386843;7627.809304767315;7640.732574359982;7649.9617501912135;7669.578173200416;4360.4767427908855;4518.186726389282;4525.298578720303;4558.726476411426;4622.514635963243;3042.361104168105;3084.6452657944624;3087.706667866549;3093.0256969055126;3100.085474784944;532.3558494222035;533.7171299211424;542.838325982398;542.9077056900258;548.5173047717983;565.1804882919782;572.8796952639992;601.9428154325332;672.3437964154906;693.6878404717897;7748.573828439377;8081.555514446762;8961.327900407496;9821.165200958;9983.201343892617;520.5783315514445;527.6807531443499;615.2555407956334;658.0951192110848;704.1620471638734;4245.280661332104;4256.191323648497;4326.4159338489535;4352.477702675699;4463.575960283768;51603.483965160616;51717.2242416364;51856.74071629693;51861.222081668806;51883.74058129685;46233.53766462292;48005.75997120062;48635.27047094297;48954.510454895;49048.26427603589;42771;43022.13955720931;43201.56798431976;43850;44266.33600495995;8513.19124683154;8805.779855503664;8986.591861444294;9085.500297483437;9327.347085704207;32945.176370590925;33199.83400082984;33728.83135584307;33956.32087358288;33982.66017339795;40433;43975;44120;44167.55832441634;44502.10995780131;11416.372099534605;11503.76992460163;11513.597024104116;11518.769624607294;11546.826797597874;11783.469743861375;11886.940565297118;11912.106592005808;12421.31682757457;12428.067894907737;11268.549258029587;11559.133065019989;11617.302961822317;11821.408929553316;11980.940095299467;11692.35692036946;11996.64010079699;12337.568185113478;12461.065420093348;12553.748925021631;11164.162687798611;11224.775504490028;11304.660860174208;11320.09439244842;11622.6513204604;8820.426672266281;9097.40866843653;9128.908710912805;9328.160465558132;9413.623455061721;8501;8525.616347264511;8801.427907186013;9106;9143.177114059501 17:25:54 INFO - PROCESS | 14309 | __end_tp_report 17:25:54 INFO - PROCESS | 14309 | __start_cc_report 17:25:54 INFO - PROCESS | 14309 | _x_x_mozilla_cycle_collect,770 17:25:54 INFO - PROCESS | 14309 | __end_cc_report 17:25:54 INFO - PROCESS | 14309 | __startTimestamp1452821154340__endTimestamp 17:25:54 INFO - PROCESS | 14309 | 17:25:54 INFO - PROCESS | 14309 | ------- Summary: start ------- 17:25:54 INFO - PROCESS | 14309 | Number of tests: 6 17:25:54 INFO - PROCESS | 14309 | 17:25:54 INFO - PROCESS | 14309 | [#0] dojo.html Cycles:165 Average:5175.65 Median:5380.92 stddev:556.05 (10.3%) stddev-sans-first:533.71 17:25:54 INFO - PROCESS | 14309 | Values: 3113.8 3117.4 3156.5 3169.9 3181.7 5071.2 5141.7 5165.0 5181.0 5200.4 5094.2 5114.6 5162.7 5205.8 5231.6 4723.5 4731.7 4745.8 4763.5 4848.4 4786.5 4790.9 4837.2 4838.9 4880.5 4688.4 4728.6 4759.2 4791.5 4792.0 4763.6 4775.3 4779.2 4779.6 4782.6 4646.6 4734.5 4736.9 4743.1 4743.4 4968.0 4970.8 4971.5 4973.2 4998.4 5482.0 5494.1 5494.4 5509.7 5548.9 5491.2 5522.8 5534.4 5581.8 5620.1 5243.7 5244.4 5244.8 5256.4 5270.6 5633.5 5670.9 5681.3 5683.9 5687.2 5394.5 5469.3 5478.3 5480.4 5588.4 5580.0 5593.7 5606.9 5607.0 5609.4 5558.2 5578.1 5585.3 5586.7 5591.5 5444.8 5518.0 5632.9 5686.5 5718.4 4361.6 4361.7 4366.5 4368.7 4399.5 3893.5 3895.4 3903.6 3946.7 3952.9 5102.1 5154.1 5184.4 5186.2 5188.9 5523.0 5546.4 5553.3 5560.2 5562.1 5154.2 5158.5 5163.4 5170.9 5204.3 4690.8 4771.0 4773.7 4804.2 4845.2 5716.0 5745.5 5747.9 5749.1 5751.9 5432.8 5579.1 5593.9 5594.8 5603.0 5647.4 5744.9 5774.8 5816.2 5838.8 5527.2 5536.8 5551.6 5554.8 5557.1 5503.5 5598.8 5611.2 5627.0 5633.4 5380.9 5417.9 5420.1 5423.2 5468.5 5365.8 5469.9 5473.1 5477.6 5517.8 5256.9 5322.9 5373.0 5375.7 5379.9 5489.1 5498.7 5500.6 5504.8 5562.2 5380.7 5382.2 5382.4 5393.3 5395.7 17:25:54 INFO - PROCESS | 14309 | 17:25:54 INFO - PROCESS | 14309 | [#1] ext.html Cycles:180 Average:43412.53 Median:35203.24 stddev:70645.86 (200.7%) stddev-sans-first:70770.63 17:25:54 INFO - PROCESS | 14309 | Values: 517.4 534.0 554.4 571.8 576.8 29041.7 29588.9 29605.7 29618.6 36761.6 39662.0 40127.2 40174.6 40260.4 40277.8 8393.4 8610.8 8611.5 8612.1 8614.0 8437.8 8479.8 8544.2 8575.5 8586.8 8525.4 8593.4 8594.5 8614.3 8778.6 8592.7 8759.8 8764.2 8764.7 8768.5 8622.4 8748.2 8755.0 8769.2 8770.3 40454.2 40577.2 40804.0 40812.0 40819.2 3263.1 3263.6 3669.4 3856.2 4016.3 29325.4 29531.0 29916.3 30013.2 30317.5 4011.8 4069.5 4087.5 4113.1 4167.3 270615.0 272192.0 272530.0 273028.0 273269.6 52570.0 53771.5 58827.0 61606.4 62532.4 55332.0 55381.4 55509.7 55682.7 55721.7 15823.5 15862.8 15973.5 16003.4 16089.1 10753.3 11927.9 11984.8 12000.1 12017.0 17122.4 20410.2 21015.4 21049.4 21085.9 7863.4 8018.7 8124.4 8451.2 8514.9 948.1 1080.2 1084.9 1146.7 1156.2 28868.6 29136.0 29293.0 29664.0 29843.4 1049.5 1066.1 1080.8 1112.8 1145.7 15072.9 15278.8 15393.1 15458.5 15554.8 318048.0 320703.0 322046.0 322491.0 322931.0 51131.0 51433.2 51486.0 51545.2 51547.5 1325.0 1328.2 1338.1 1348.4 1354.3 23631.8 28468.4 28944.0 29153.3 29303.9 41847.4 42102.0 42243.2 42383.0 42422.3 204351.0 204807.0 204995.0 206171.0 206862.0 30900.4 31249.0 31399.8 32429.7 32707.3 37150.7 37404.3 39675.6 40044.8 40146.0 34905.5 35115.6 35242.8 35560.7 35663.3 34679.0 35163.6 35442.5 35465.0 35698.6 34609.0 34825.0 35309.0 36464.3 36516.5 28297.2 29620.0 30122.8 31118.4 31724.8 24493.3 24625.4 24644.4 25051.9 25105.4 17:25:54 INFO - PROCESS | 14309 | 17:25:54 INFO - PROCESS | 14309 | [#2] jquery.html Cycles:180 Average:25803.38 Median:22810.80 stddev:82199.45 (360.4%) stddev-sans-first:82407.85 17:25:54 INFO - PROCESS | 14309 | Values: 367.5 368.6 369.0 371.2 374.2 15752.1 16277.3 16515.0 17010.9 17042.5 15344.8 15611.3 15810.1 15840.2 15884.0 5177.6 5180.4 5345.3 5348.1 5355.7 5280.7 5333.1 5358.8 5365.7 5373.0 3882.3 4026.0 5132.7 5344.7 5612.7 5628.5 5749.5 5763.5 5791.2 5791.9 5062.8 5064.8 5069.4 5080.4 5082.6 14924.2 15889.3 18276.2 18931.5 20059.0 2049.2 2124.1 2225.9 2323.8 2496.9 9377.6 10842.5 11518.9 12885.3 13233.3 1826.2 1851.3 1858.2 1874.4 1886.2 52573.0 53432.7 53796.7 54704.0 54812.0 9908.4 9951.5 9956.0 9994.5 10120.2 13060.4 13131.3 13152.4 13152.4 13153.2 7146.9 7244.3 7424.2 7435.5 7467.2 7197.6 7216.9 7270.1 7287.8 7298.8 3981.5 4123.6 4355.5 4424.6 4469.7 1783.1 1819.5 1859.1 1868.1 1892.5 441.8 446.3 452.3 845.3 923.8 9407.4 10106.5 10663.9 10682.0 10857.7 450.6 467.9 468.4 478.0 485.0 5756.6 6092.4 6255.4 6321.3 6340.7 354638.0 521125.0 528257.0 538264.0 543677.0 59246.4 72784.3 72796.3 76445.6 77053.2 497.8 511.1 511.3 512.1 513.2 10303.4 10394.6 10487.3 10496.0 10726.6 32921.0 32981.2 33236.3 33260.2 33270.3 42735.6 42898.1 44366.6 45169.3 45398.8 7324.2 7534.8 7547.1 7622.1 7691.4 10749.6 11141.9 11511.3 11900.5 11957.5 9636.4 9694.5 9719.9 10054.8 10095.6 2999.8 3024.0 9872.6 9972.0 10161.8 9902.4 9923.1 10237.8 10249.2 10273.9 7756.3 7856.3 7875.9 7876.9 7883.4 9649.8 10304.5 10597.7 10730.7 10797.9 17:25:54 INFO - PROCESS | 14309 | 17:25:54 INFO - PROCESS | 14309 | [#3] mootools.html Cycles:180 Average:5577.93 Median:6315.19 stddev:2888.98 (45.7%) stddev-sans-first:2879.06 17:25:54 INFO - PROCESS | 14309 | Values: 1284.8 1478.8 1481.4 1623.6 1817.4 7062.9 7635.0 7797.3 7805.5 7833.1 7638.4 7817.7 7863.3 7864.8 7882.5 1991.3 2043.5 2266.1 2312.7 2362.6 2321.8 2327.7 2329.3 2330.3 2330.6 2261.1 2334.4 2339.0 2340.0 2345.0 2281.1 2313.8 2318.0 2318.2 2328.7 2320.2 2321.4 2328.2 2344.1 2346.4 7968.6 8044.6 8046.0 8050.5 8057.8 4870.3 4963.2 4993.2 4998.6 5000.4 3065.9 3105.8 3147.9 3263.5 3265.7 1093.2 1105.3 1105.3 1110.2 1125.5 10835.5 10919.0 10934.4 10937.6 10953.0 4451.7 4481.9 4492.4 4503.5 4549.4 9392.4 9394.9 9400.9 9401.1 9401.4 4908.7 4909.5 4936.0 4936.8 4937.1 4445.7 4474.4 4495.6 4496.9 4504.9 3465.9 3525.9 3718.6 3746.1 3837.4 1203.8 1220.4 1222.7 1230.0 1256.2 1105.3 1132.0 1135.1 1297.3 1371.6 7239.1 7242.5 7245.9 7541.9 7826.7 1135.4 1135.5 1136.2 1143.5 1155.2 5936.5 5992.6 6030.8 6034.3 6038.4 9312.7 9774.1 9785.6 9931.6 9966.5 9663.5 9691.4 9816.7 9836.0 9839.3 7370.9 7626.3 7634.4 7706.7 7711.2 7347.8 7372.2 7414.9 7425.9 7453.1 8700.0 8725.3 8798.5 8855.1 8895.7 8874.0 8896.1 9084.8 9102.6 9185.7 6105.5 6828.8 6892.0 6917.8 6948.1 6912.7 7146.2 7263.2 7265.6 7279.3 6764.8 6932.7 6965.5 7028.7 7039.2 6620.3 6633.2 6851.3 6874.4 6878.7 6820.3 6828.7 6865.1 6877.5 7033.6 6524.9 6616.6 6633.4 6644.0 6648.1 6638.6 6683.9 6694.1 6712.3 6739.4 17:25:54 INFO - PROCESS | 14309 | 17:25:54 INFO - PROCESS | 14309 | [#4] prototype.html Cycles:180 Average:5188.98 Median:5869.32 stddev:1545.01 (26.3%) stddev-sans-first:1505.96 17:25:54 INFO - PROCESS | 14309 | Values: 344.9 345.7 346.5 349.3 352.2 5688.7 5824.1 5843.9 5917.8 5917.9 5603.2 5754.1 5780.0 5781.2 5785.8 4556.1 4561.0 4564.4 4564.7 4567.0 4333.9 4433.4 4445.9 4539.0 4568.2 4499.1 4503.2 4526.6 4535.8 4553.0 4539.0 4539.6 4543.8 4545.0 4558.4 4016.0 4023.4 4023.7 4026.1 4027.6 5437.7 5540.0 5566.5 5642.9 5648.0 5179.5 5179.9 5184.2 5214.5 5225.3 5891.4 6198.4 6198.7 6199.4 6200.7 4224.3 4244.1 4336.0 4338.3 4346.6 6320.0 6464.5 6474.9 6500.2 6512.7 4437.7 4450.4 4453.6 4453.8 4465.8 4378.1 4486.0 4490.4 4490.8 4516.2 5181.0 5181.9 5182.6 5186.5 5187.5 6195.0 6197.5 6201.1 6201.1 6208.7 1568.6 1583.3 1584.8 1587.1 1587.1 1046.5 1070.2 1070.5 1071.6 1076.9 5864.8 5865.2 5867.6 5871.0 5881.5 6366.3 6371.3 6371.6 6377.5 6380.5 5874.2 5875.4 5875.6 5876.2 5879.4 3308.1 3429.1 3433.3 3433.3 3433.6 6526.9 6585.6 6602.3 6607.1 6619.1 6523.1 6531.6 6536.7 6539.1 6542.3 6380.5 6445.2 6490.2 6590.2 6617.0 6150.7 6295.4 6408.8 6431.2 6443.5 6184.1 6322.1 6330.8 6332.2 6362.0 6525.3 6583.1 6586.7 6588.2 6589.4 4328.8 4417.1 4472.5 4472.8 4473.1 6322.4 6364.7 6379.9 6382.6 6385.4 6170.8 6201.2 6219.0 6219.9 6226.2 6061.6 6208.6 6210.3 6213.3 6223.8 6095.5 6103.9 6147.0 6149.0 6158.1 6230.7 6316.8 6351.9 6366.8 6376.6 5973.4 6120.4 6155.6 6158.8 6162.3 17:25:54 INFO - PROCESS | 14309 | 17:25:54 INFO - PROCESS | 14309 | [#5] yui.html Cycles:180 Average:13482.71 Median:4490.88 stddev:14911.71 (332.0%) stddev-sans-first:14922.99 17:25:54 INFO - PROCESS | 14309 | Values: 772.8 796.5 855.1 865.8 868.6 13868.1 13999.6 14005.6 14015.0 14054.2 13050.2 13134.5 13144.8 13152.1 13153.9 656.8 665.8 801.7 827.0 829.8 824.6 836.9 837.1 839.4 840.7 869.8 870.4 871.5 872.0 872.4 684.2 694.6 848.9 864.3 865.3 644.7 646.1 647.2 647.6 647.7 13376.7 13459.2 13475.7 13501.0 13514.0 12933.0 13431.3 13614.5 13833.7 13879.1 10419.4 10576.6 10681.1 10760.5 10883.0 3549.0 3650.4 3651.0 3665.9 3763.4 45355.3 45954.3 46053.8 46326.1 47419.8 10287.3 10408.3 10486.0 10568.8 10954.2 19043.1 19088.3 19136.6 19170.8 19223.0 7535.4 7627.8 7640.7 7650.0 7669.6 4360.5 4518.2 4525.3 4558.7 4622.5 3042.4 3084.6 3087.7 3093.0 3100.1 532.4 533.7 542.8 542.9 548.5 565.2 572.9 601.9 672.3 693.7 7748.6 8081.6 8961.3 9821.2 9983.2 520.6 527.7 615.3 658.1 704.2 4245.3 4256.2 4326.4 4352.5 4463.6 51603.5 51717.2 51856.7 51861.2 51883.7 46233.5 48005.8 48635.3 48954.5 49048.3 42771.0 43022.1 43201.6 43850.0 44266.3 8513.2 8805.8 8986.6 9085.5 9327.3 32945.2 33199.8 33728.8 33956.3 33982.7 40433.0 43975.0 44120.0 44167.6 44502.1 11416.4 11503.8 11513.6 11518.8 11546.8 11783.5 11886.9 11912.1 12421.3 12428.1 11268.5 11559.1 11617.3 11821.4 11980.9 11692.4 11996.6 12337.6 12461.1 12553.7 11164.2 11224.8 11304.7 11320.1 11622.7 8820.4 9097.4 9128.9 9328.2 9413.6 8501.0 8525.6 8801.4 9106.0 9143.2 17:25:54 INFO - PROCESS | 14309 | -------- Summary: end -------- 17:25:54 INFO - PROCESS | 14309 | 17:25:55 INFO - TEST-INFO | 14309: exit 0 17:25:55 INFO - TEST-OK | dromaeo_css | took 1114693ms 17:25:55 INFO - TEST-START | kraken 17:25:55 INFO - operating with platform_type : linux_ 17:25:55 INFO - Initialising browser for kraken test... 17:25:55 INFO - TEST-INFO | started process 14505 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRqhAWl/profile http://localhost:52389/getInfo.html) 17:25:59 INFO - PROCESS | 14505 | __metrics Screen width/height:1600/1200 17:25:59 INFO - PROCESS | 14505 | colorDepth:24 17:25:59 INFO - PROCESS | 14505 | Browser inner width/height: 1024/697 17:25:59 INFO - PROCESS | 14505 | __metrics 17:25:59 INFO - PROCESS | 14505 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:25:59 INFO - PROCESS | 14505 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:26:01 INFO - TEST-INFO | 14505: exit 0 17:26:01 INFO - Browser initialized. 17:26:01 INFO - Running cycle 1/1 for kraken test... 17:26:01 INFO - TEST-INFO | started process 14591 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRqhAWl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:26:12 INFO - PROCESS | 14591 | RSS: Main: 150122496 17:26:12 INFO - PROCESS | 14591 | 17:26:15 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52389/tests/kraken/driver.html?testName=audio-beat-detection) 17:26:16 INFO - PROCESS | 14591 | RSS: Main: 186195968 17:26:16 INFO - PROCESS | 14591 | 17:26:18 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52389/tests/kraken/driver.html?testName=audio-dft) 17:26:19 INFO - PROCESS | 14591 | RSS: Main: 177020928 17:26:19 INFO - PROCESS | 14591 | 17:26:22 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52389/tests/kraken/driver.html?testName=audio-fft) 17:26:22 INFO - PROCESS | 14591 | RSS: Main: 161402880 17:26:22 INFO - PROCESS | 14591 | 17:26:24 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52389/tests/kraken/driver.html?testName=audio-oscillator) 17:26:25 INFO - PROCESS | 14591 | RSS: Main: 162824192 17:26:25 INFO - PROCESS | 14591 | 17:26:27 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:28 INFO - PROCESS | 14591 | RSS: Main: 165040128 17:26:28 INFO - PROCESS | 14591 | 17:26:30 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52389/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:31 INFO - PROCESS | 14591 | RSS: Main: 167481344 17:26:31 INFO - PROCESS | 14591 | 17:26:34 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52389/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:35 INFO - PROCESS | 14591 | RSS: Main: 167309312 17:26:35 INFO - PROCESS | 14591 | 17:26:38 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52389/tests/kraken/driver.html?testName=json-parse-financial) 17:26:38 INFO - PROCESS | 14591 | RSS: Main: 167194624 17:26:38 INFO - PROCESS | 14591 | 17:26:40 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:26:40 INFO - PROCESS | 14591 | RSS: Main: 176279552 17:26:40 INFO - PROCESS | 14591 | 17:26:42 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52389/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:26:43 INFO - PROCESS | 14591 | RSS: Main: 173826048 17:26:43 INFO - PROCESS | 14591 | 17:26:45 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:26:45 INFO - PROCESS | 14591 | RSS: Main: 183676928 17:26:45 INFO - PROCESS | 14591 | 17:26:48 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:26:48 INFO - PROCESS | 14591 | RSS: Main: 189362176 17:26:48 INFO - PROCESS | 14591 | 17:26:51 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:26:51 INFO - PROCESS | 14591 | RSS: Main: 187555840 17:26:51 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | Cycle 1(1): loaded http://localhost:52389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52389/tests/kraken/driver.html?testName=ai-astar) 17:26:53 INFO - PROCESS | 14591 | RSS: Main: 245616640 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | __start_tp_report 17:26:53 INFO - PROCESS | 14591 | _x_x_mozilla_page_load 17:26:53 INFO - PROCESS | 14591 | _x_x_mozilla_page_load_details 17:26:53 INFO - PROCESS | 14591 | |i|pagename|runs| 17:26:53 INFO - PROCESS | 14591 | |0;ai-astar;111;111;108;112;113;112;101;112;113;111 17:26:53 INFO - PROCESS | 14591 | |1;audio-beat-detection;155;125;157;175;126;153;155;125;174;126 17:26:53 INFO - PROCESS | 14591 | |2;audio-dft;164;161;160;163;161;161;159;164;163;163 17:26:53 INFO - PROCESS | 14591 | |3;audio-fft;73;71;97;100;72;75;71;105;93;72 17:26:53 INFO - PROCESS | 14591 | |4;audio-oscillator;97;96;149;96;96;95;145;96;97;144 17:26:53 INFO - PROCESS | 14591 | |5;imaging-gaussian-blur;109;109;110;110;110;109;109;110;109;110 17:26:53 INFO - PROCESS | 14591 | |6;imaging-darkroom;146;146;146;146;147;146;146;145;144;145 17:26:53 INFO - PROCESS | 14591 | |7;imaging-desaturate;96;96;96;97;95;95;96;96;96;95 17:26:53 INFO - PROCESS | 14591 | |8;json-parse-financial;56;55;56;56;55;56;56;64;53;54 17:26:53 INFO - PROCESS | 14591 | |9;json-stringify-tinderbox;66;67;67;67;68;67;67;68;68;67 17:26:53 INFO - PROCESS | 14591 | |10;stanford-crypto-aes;83;82;89;83;81;82;86;83;84;83 17:26:53 INFO - PROCESS | 14591 | |11;stanford-crypto-ccm;116;114;114;119;123;114;114;114;119;119 17:26:53 INFO - PROCESS | 14591 | |12;stanford-crypto-pbkdf2;149;142;147;136;146;147;160;147;147;148 17:26:53 INFO - PROCESS | 14591 | |13;stanford-crypto-sha256-iterative;67;67;68;67;66;77;68;67;68;67 17:26:53 INFO - PROCESS | 14591 | __end_tp_report 17:26:53 INFO - PROCESS | 14591 | __start_cc_report 17:26:53 INFO - PROCESS | 14591 | _x_x_mozilla_cycle_collect,941 17:26:53 INFO - PROCESS | 14591 | __end_cc_report 17:26:53 INFO - PROCESS | 14591 | __startTimestamp1452821213807__endTimestamp 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | ------- Summary: start ------- 17:26:53 INFO - PROCESS | 14591 | Number of tests: 14 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:3.60 (3.2%) stddev-sans-first:3.81 17:26:53 INFO - PROCESS | 14591 | Values: 111.0 111.0 108.0 112.0 113.0 112.0 101.0 112.0 113.0 111.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:155.00 stddev:20.07 (13.0%) stddev-sans-first:21.09 17:26:53 INFO - PROCESS | 14591 | Values: 155.0 125.0 157.0 175.0 126.0 153.0 155.0 125.0 174.0 126.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#2] audio-dft Cycles:10 Average:161.90 Median:163.00 stddev:1.73 (1.1%) stddev-sans-first:1.66 17:26:53 INFO - PROCESS | 14591 | Values: 164.0 161.0 160.0 163.0 161.0 161.0 159.0 164.0 163.0 163.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#3] audio-fft Cycles:10 Average:82.90 Median:72.50 stddev:14.00 (19.3%) stddev-sans-first:14.38 17:26:53 INFO - PROCESS | 14591 | Values: 73.0 71.0 97.0 100.0 72.0 75.0 71.0 105.0 93.0 72.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:96.00 stddev:24.12 (25.1%) stddev-sans-first:25.04 17:26:53 INFO - PROCESS | 14591 | Values: 97.0 96.0 149.0 96.0 96.0 95.0 145.0 96.0 97.0 144.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:26:53 INFO - PROCESS | 14591 | Values: 109.0 109.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 110.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 17:26:53 INFO - PROCESS | 14591 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 144.0 145.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:26:53 INFO - PROCESS | 14591 | Values: 96.0 96.0 96.0 97.0 95.0 95.0 96.0 96.0 96.0 95.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:2.96 (5.3%) stddev-sans-first:3.14 17:26:53 INFO - PROCESS | 14591 | Values: 56.0 55.0 56.0 56.0 55.0 56.0 56.0 64.0 53.0 54.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 17:26:53 INFO - PROCESS | 14591 | Values: 66.0 67.0 67.0 67.0 68.0 67.0 67.0 68.0 68.0 67.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:2.32 (2.8%) stddev-sans-first:2.45 17:26:53 INFO - PROCESS | 14591 | Values: 83.0 82.0 89.0 83.0 81.0 82.0 86.0 83.0 84.0 83.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#11] stanford-crypto-ccm Cycles:10 Average:116.60 Median:117.50 stddev:3.20 (2.7%) stddev-sans-first:3.39 17:26:53 INFO - PROCESS | 14591 | Values: 116.0 114.0 114.0 119.0 123.0 114.0 114.0 114.0 119.0 119.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:147.00 stddev:5.97 (4.1%) stddev-sans-first:6.28 17:26:53 INFO - PROCESS | 14591 | Values: 149.0 142.0 147.0 136.0 146.0 147.0 160.0 147.0 147.0 148.0 17:26:53 INFO - PROCESS | 14591 | 17:26:53 INFO - PROCESS | 14591 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:67.50 stddev:3.16 (4.7%) stddev-sans-first:3.32 17:26:53 INFO - PROCESS | 14591 | Values: 67.0 67.0 68.0 67.0 66.0 77.0 68.0 67.0 68.0 67.0 17:26:53 INFO - PROCESS | 14591 | -------- Summary: end -------- 17:26:53 INFO - PROCESS | 14591 | 17:26:55 INFO - TEST-INFO | 14591: exit 0 17:26:55 INFO - TEST-OK | kraken | took 59984ms 17:26:55 INFO - TEST-START | v8_7 17:26:55 INFO - operating with platform_type : linux_ 17:26:55 INFO - Initialising browser for v8_7 test... 17:26:55 INFO - TEST-INFO | started process 14837 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3bzmu1/profile http://localhost:52389/getInfo.html) 17:26:59 INFO - PROCESS | 14837 | __metrics Screen width/height:1600/1200 17:26:59 INFO - PROCESS | 14837 | colorDepth:24 17:26:59 INFO - PROCESS | 14837 | Browser inner width/height: 1024/697 17:26:59 INFO - PROCESS | 14837 | __metrics 17:26:59 INFO - PROCESS | 14837 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:26:59 INFO - PROCESS | 14837 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:27:01 INFO - TEST-INFO | 14837: exit 0 17:27:01 INFO - Browser initialized. 17:27:01 INFO - Running cycle 1/1 for v8_7 test... 17:27:01 INFO - TEST-INFO | started process 14923 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3bzmu1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:13 INFO - PROCESS | 14923 | RSS: Main: 150417408 17:27:13 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | Cycle 1(1): loaded http://localhost:52389/tests/v8_7/run.html (next: http://localhost:52389/tests/v8_7/run.html) 17:27:35 INFO - PROCESS | 14923 | RSS: Main: 543383552 17:27:35 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | __start_tp_report 17:27:35 INFO - PROCESS | 14923 | _x_x_mozilla_page_load 17:27:35 INFO - PROCESS | 14923 | _x_x_mozilla_page_load_details 17:27:35 INFO - PROCESS | 14923 | |i|pagename|runs| 17:27:35 INFO - PROCESS | 14923 | |0;Richards;166.86133822793258 17:27:35 INFO - PROCESS | 14923 | |1;DeltaBlue;189.3939393939394 17:27:35 INFO - PROCESS | 14923 | |2;Encrypt;280.2690582959641 17:27:35 INFO - PROCESS | 14923 | |3;Decrypt;5191.709844559586 17:27:35 INFO - PROCESS | 14923 | |4;RayTrace;1962.7450980392157 17:27:35 INFO - PROCESS | 14923 | |5;Earley;789.8894154818325 17:27:35 INFO - PROCESS | 14923 | |6;Boyer;12370.37037037037 17:27:35 INFO - PROCESS | 14923 | |7;RegExp;43574.46808510638 17:27:35 INFO - PROCESS | 14923 | |8;Splay;579.7101449275362 17:27:35 INFO - PROCESS | 14923 | |9;NavierStokes;4850.241545893719 17:27:35 INFO - PROCESS | 14923 | __end_tp_report 17:27:35 INFO - PROCESS | 14923 | __startTimestamp1452821255745__endTimestamp 17:27:35 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | ------- Summary: start ------- 17:27:35 INFO - PROCESS | 14923 | Number of tests: 10 17:27:35 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | [#0] Richards Cycles:1 Average:166.86 Median:166.86 stddev:0.00 (0.0%) 17:27:35 INFO - PROCESS | 14923 | Values: 166.9 17:27:35 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | [#1] DeltaBlue Cycles:1 Average:189.39 Median:189.39 stddev:0.00 (0.0%) 17:27:35 INFO - PROCESS | 14923 | Values: 189.4 17:27:35 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 17:27:35 INFO - PROCESS | 14923 | Values: 280.3 17:27:35 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 17:27:35 INFO - PROCESS | 14923 | Values: 5191.7 17:27:35 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | [#4] RayTrace Cycles:1 Average:1962.75 Median:1962.75 stddev:0.00 (0.0%) 17:27:35 INFO - PROCESS | 14923 | Values: 1962.7 17:27:35 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 17:27:35 INFO - PROCESS | 14923 | Values: 789.9 17:27:35 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 17:27:35 INFO - PROCESS | 14923 | Values: 12370.4 17:27:35 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | [#7] RegExp Cycles:1 Average:43574.47 Median:43574.47 stddev:0.00 (0.0%) 17:27:35 INFO - PROCESS | 14923 | Values: 43574.5 17:27:35 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | [#8] Splay Cycles:1 Average:579.71 Median:579.71 stddev:0.00 (0.0%) 17:27:35 INFO - PROCESS | 14923 | Values: 579.7 17:27:35 INFO - PROCESS | 14923 | 17:27:35 INFO - PROCESS | 14923 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 17:27:35 INFO - PROCESS | 14923 | Values: 4850.2 17:27:35 INFO - PROCESS | 14923 | -------- Summary: end -------- 17:27:35 INFO - PROCESS | 14923 | 17:27:36 INFO - TEST-INFO | 14923: exit 0 17:27:36 INFO - TEST-OK | v8_7 | took 41533ms 17:27:36 INFO - SUITE-END | took 1216s 17:27:36 INFO - Completed test suite (00:20:16) 17:27:36 INFO - Working with test: dromaeo_css 17:27:36 INFO - Generating results file: dromaeo_css 17:27:36 INFO - Working with test: kraken 17:27:36 INFO - Generating results file: kraken 17:27:36 INFO - javascript benchmark 17:27:36 INFO - Working with test: v8_7 17:27:36 INFO - Generating results file: v8_7 17:27:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:27:36 INFO - process_Request line: dromaeo_css 6745.22 graph.html#tests=[[72,64,35]] 17:27:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:36 INFO - process_Request line: kraken 1503.00 graph.html#tests=[[232,64,35]] 17:27:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:36 INFO - process_Request line: v8_7 18911.90 graph.html#tests=[[230,64,35]] 17:27:36 INFO - RETURN: dromaeo_css: 6745.22 17:27:36 INFO - RETURN: kraken: 1503.00 17:27:36 INFO - RETURN: v8_7: 18911.90 17:27:36 INFO - javascript benchmark 17:27:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3113.78203525753, 3117.3609410070935, 3156.4949608062716, 3169.9207519812016, 3181.7136457718802, 5071.1632580624155, 5141.691498510092, 5164.974175129124, 5181.041507321148, 5200.401953775312, 5094.1594636884865, 5114.590832733382, 5162.741862906859, 5205.791768329272, 5231.5814734821215, 4723.456802467708, 4731.668783185179, 4745.766100813796, 4763.523647635226, 4848.393950756155, 4786.4974177711365, 4790.904181916377, 4837.177679794443, 4838.9274160887435, 4880.536349046835, 4688.437387513521, 4728.645351598644, 4759.214729569617, 4791.496892826255, 4792.0, 4763.571278584909, 4775.283707443877, 4779.211430114027, 4779.641526885497, 4782.593479554242, 4646.628269738413, 4734.526547345238, 4736.881577960544, 4743.1225223333795, 4743.35964644772, 4967.950320496785, 4970.801167953277, 4971.477994810529, 4973.229149481836, 4998.425181104183, 5481.972590137064, 5494.066008778477, 5494.36814766303, 5509.696966666832, 5548.944510554924, 5491.176323551499, 5522.751476183541, 5534.446555344433, 5581.832545023656, 5620.100783874561, 5243.711595862188, 5244.423113457517, 5244.763985620618, 5256.448072952323, 5270.6047046471285, 5633.549316054706, 5670.943290567124, 5681.318241811009, 5683.943160568341, 5687.203791469197, 5394.460553944574, 5469.316335458067, 5478.315210598676, 5480.3971563128025, 5588.441155884379, 5580.0, 5593.664380137205, 5606.887862242732, 5607.0, 5609.382967873531, 5558.166275058693, 5578.135389014709, 5585.3297604287745, 5586.748596313176, 5591.52472039873, 5444.754986025639, 5518.0, 5632.915506267409, 5686.459786320293, 5718.370979192368, 4361.629261512743, 4361.694681372273, 4366.541513141138, 4368.650507959355, 4399.450068741407, 3893.4743809585343, 3895.4156876468755, 3903.59012303704, 3946.7039972002217, 3952.8616498422416, 5102.107131252016, 5154.123798954187, 5184.403793563789, 5186.170212765939, 5188.870278242998, 5522.978249023943, 5546.389897111315, 5553.250311208016, 5560.2493663355735, 5562.082256427644, 5154.175331946871, 5158.509941555546, 5163.4062082860955, 5170.870728231825, 5204.271402003723, 4690.81236750533, 4770.976145119253, 4773.7374444405195, 4804.231322988375, 4845.248986407112, 5716.0, 5745.511631511285, 5747.9137812932, 5749.13762935563, 5751.85620359486, 5432.837014889559, 5579.079451890392, 5593.944060559343, 5594.804181853616, 5603.0, 5647.435256474319, 5744.885102298014, 5774.769009239583, 5816.2438882946635, 5838.795642152504, 5527.170924361378, 5536.833894983157, 5551.611387202857, 5554.805581804618, 5557.138643510262, 5503.532199763065, 5598.832035038955, 5611.186377975252, 5627.043402621646, 5633.380328163817, 5380.919286210788, 5417.918731219113, 5420.105682562333, 5423.159410291411, 5468.48049435303, 5365.785368585213, 5469.9179512306555, 5473.124300111963, 5477.561795056466, 5517.806876759294, 5256.894862102813, 5322.8935421292135, 5372.973135134455, 5375.704336261387, 5379.892402152013, 5489.066858633962, 5498.697571633438, 5500.614956952975, 5504.80733174337, 5562.165675148598, 5380.70406127651, 5382.219578161223, 5382.434844341287, 5393.298871146726, 5395.676259424447], "unit": "score", "name": "dojo.html", "value": 5140.8459341365915}, {"lowerIsBetter": false, "replicates": [517.3843126679249, 533.9839804805857, 554.373557879596, 571.7592823572849, 576.8356018534718, 29041.70958290419, 29588.852055739717, 29605.703942960565, 29618.555721664194, 36761.63238367616, 39662.0, 40127.19745605093, 40174.59825401745, 40260.39609405854, 40277.798611006976, 8393.370497212718, 8610.78473038176, 8611.526366049864, 8612.09572994836, 8614.0, 8437.831243375129, 8479.830403391928, 8544.18830211132, 8575.528345940971, 8586.828263434727, 8525.44584602002, 8593.355498337618, 8594.527300998443, 8614.267787238092, 8778.64885404583, 8592.742217733477, 8759.78100547485, 8764.21122099014, 8764.693235736782, 8768.517731524764, 8622.396432249745, 8748.21266086049, 8755.036945935943, 8769.210771030637, 8770.298376129895, 40454.19091618151, 40577.18845623101, 40804.0, 40812.0, 40819.183616327806, 3263.0700250428513, 3263.6246831614194, 3669.3945498992634, 3856.1709232515145, 4016.3373043448087, 29325.413491730258, 29531.0, 29916.252093697614, 30013.24966875824, 30317.545236821465, 4011.8011593601304, 4069.47096877407, 4087.509498860126, 4113.115680128787, 4167.291560434703, 270615.0, 272192.0, 272530.0, 273028.0, 273269.63365183247, 52570.0, 53771.46228537665, 58827.0, 61606.383936160964, 62532.37467625357, 55332.0, 55381.44618553763, 55509.72245138748, 55682.72158639181, 55721.721391392784, 15823.525294241192, 15862.841371586368, 15973.520794376187, 16003.359865605478, 16089.115098669452, 10753.301035432673, 11927.940360298317, 11984.760304793856, 12000.099992500423, 12017.0, 17122.40071597488, 20410.18359265613, 21015.369538913856, 21049.368518944455, 21085.89457052705, 7863.37093032556, 8018.679252829938, 8124.431289809657, 8451.23938845507, 8514.850495183071, 948.0708905272871, 1080.152080616712, 1084.8752393474695, 1146.690393593725, 1156.1791128298835, 28868.566971495446, 29136.0, 29293.0, 29664.0, 29843.40313193724, 1049.4962418039383, 1066.0671912076932, 1080.8165059260098, 1112.816385296417, 1145.7135716070982, 15072.924635376972, 15278.770818437732, 15393.064334142047, 15458.458953936559, 15554.844451555566, 318048.0, 320703.0, 322046.0, 322491.0, 322931.0, 51131.0, 51433.22850157251, 51486.0, 51545.22682159771, 51547.48452515427, 1324.9801252981213, 1328.1765305510453, 1338.0633556510481, 1348.359529223611, 1354.3363751761565, 23631.763682362955, 28468.43063138767, 28944.0, 29153.271168220963, 29303.853480733313, 41847.37228941507, 42102.0, 42243.15513689647, 42383.0, 42422.27299314676, 204351.0, 204807.0, 204995.0, 206171.0, 206862.0, 30900.381992360475, 31249.0, 31399.84300078485, 32429.67570324361, 32707.34585308328, 37150.6750998072, 37404.251914961, 39675.60324396719, 40044.79977600093, 40146.0, 34905.47641785426, 35115.64884351124, 35242.82378588091, 35560.688555243825, 35663.28673426569, 34679.0, 35163.64836351706, 35442.468362975094, 35465.0, 35698.643013569534, 34609.0, 34825.0, 35309.0, 36464.27071458503, 36516.452253216754, 28297.15108546747, 29620.0, 30122.849385752932, 31118.37763244768, 31724.841375792974, 24493.265202043967, 24625.384365391008, 24644.38389040288, 25051.87474062618, 25105.372365691004], "unit": "score", "name": "ext.html", "value": 18091.82789531331}, {"lowerIsBetter": false, "replicates": [367.4855202716197, 368.6479412161385, 368.9981550092249, 371.19265597325824, 374.18427827336393, 15752.1336326502, 16277.267522961465, 16515.0, 17010.914945425287, 17042.488725338244, 15344.769828452581, 15611.297491612877, 15810.13044282564, 15840.207989600503, 15884.0, 5177.585793136559, 5180.352455943007, 5345.278387417708, 5348.144296912495, 5355.732213389334, 5280.735963201843, 5333.146696528556, 5358.812441564546, 5365.678059316453, 5373.0, 3882.3400021996185, 4025.9798701006453, 5132.717700526469, 5344.732763361816, 5612.663240205601, 5628.465295796893, 5749.540036797046, 5763.452472015152, 5791.189233507313, 5791.884162316751, 5062.797488100508, 5064.82273120439, 5069.44236134025, 5080.441151473335, 5082.567981721558, 14924.179170145637, 15889.28498217583, 18276.177572009292, 18931.526711832175, 20059.0, 2049.1700861151257, 2124.1397234120204, 2225.899834507451, 2323.790858822714, 2496.900123995038, 9377.578008989543, 10842.512086956027, 11518.88481115195, 12885.291308978003, 13233.338333083308, 1826.1964735516462, 1851.3150134450204, 1858.2474097990334, 1874.4001919385803, 1886.1889387563342, 52573.0, 53432.732836335956, 53796.73101634506, 54704.0, 54812.0, 9908.405495670282, 9951.452670103214, 9955.950220248997, 9994.450305233282, 10120.190384769201, 13060.412281447358, 13131.34343282832, 13152.40814163365, 13152.40814163365, 13153.21080735159, 7146.92853071473, 7244.275572442713, 7424.220456852061, 7435.4795164337975, 7467.215942326086, 7197.568145911157, 7216.855662886713, 7270.054892864, 7287.781366559012, 7298.781036568806, 3981.5023122109737, 4123.628873401348, 4355.477342718894, 4424.557544245614, 4469.687121901501, 1783.1440908363797, 1819.4814477873742, 1859.1447933950265, 1868.1033104110104, 1892.4701083696311, 441.7901496789, 446.2948541304731, 452.27861560810453, 845.323741007204, 923.7598224461553, 9407.43555386679, 10106.494675266207, 10663.89336106629, 10682.0, 10857.67426977192, 450.5652045775777, 467.9485256621769, 468.4261779320373, 477.99859294777383, 484.964600577762, 5756.5682573807135, 6092.390760923872, 6255.374462553708, 6321.336259692758, 6340.682965851781, 354638.0, 521125.0, 528257.0, 538264.0, 543677.0, 59246.40753592409, 72784.27215727881, 72796.27203728001, 76445.6177719119, 77053.2294677046, 497.8406909788905, 511.09281026178087, 511.28420211703167, 512.0961502947301, 513.204532973889, 10303.433311167957, 10394.636187733393, 10487.318324308895, 10496.0, 10726.570937162425, 32921.0, 32981.17547061247, 33236.33527329392, 33260.1684957878, 33270.334593308486, 42735.57264427316, 42898.142037159705, 44366.556334436245, 45169.32246016378, 45398.77300613476, 7324.230955749783, 7534.773956781305, 7547.0943486781935, 7622.085349758065, 7691.38468922496, 10749.62376316825, 11141.944290278496, 11511.30932144074, 11900.464479098287, 11957.461914214055, 9636.42181469114, 9694.46680432583, 9719.9028009719, 10054.798904022025, 10095.596176152872, 2999.820010799359, 3024.047425061187, 9872.630568663613, 9971.950140249251, 10161.796764064826, 9902.356346837432, 9923.1069203772, 10237.795244095225, 10249.180065594586, 10273.897261027294, 7756.263155000266, 7856.292933636, 7875.881861772193, 7876.921230787848, 7883.408744344082, 9649.807003860024, 10304.536295866854, 10597.682069537927, 10730.678079657622, 10797.892021079688], "unit": "score", "name": "jquery.html", "value": 7451.937499356343}, {"lowerIsBetter": false, "replicates": [1284.8072789081643, 1478.7855760914667, 1481.3852251315705, 1623.6103335199555, 1817.4002579148882, 7062.894056589149, 7634.961825190873, 7797.337226335754, 7805.453618246711, 7833.138354780969, 7638.38892888569, 7817.687292508293, 7863.3316168125775, 7864.803379915505, 7882.527048377101, 1991.3428568572335, 2043.5299881027372, 2266.1162146762777, 2312.676225328451, 2362.598358279097, 2321.8374713770045, 2327.7323107842562, 2329.324495896188, 2330.2892617751577, 2330.6154484510034, 2261.08426087434, 2334.393057804966, 2338.9766102339013, 2339.9766002340016, 2344.9531009379803, 2281.133169395627, 2313.7570555091643, 2318.0, 2318.246569864784, 2328.7205535335784, 2320.164740693349, 2321.4312493439215, 2328.2084091408833, 2344.0623750499767, 2346.425125844179, 7968.601569921539, 8044.59777011153, 8046.0, 8050.5169689818795, 8057.798555036171, 4870.318155458239, 4963.1810751226, 4993.151164302078, 4998.57512111471, 5000.449950505442, 3065.938681226385, 3105.813651180914, 3147.921301967446, 3263.461528847737, 3265.7387409007224, 1093.2016832310883, 1105.2815669814604, 1105.3312745788762, 1110.189561620022, 1125.5441546173813, 10835.51240194193, 10919.0, 10934.398608076554, 10937.617183398543, 10952.97369986547, 4451.688381813242, 4481.887952801141, 4492.393526873896, 4503.527129651405, 4549.431321084864, 9392.436453812794, 9394.859077113848, 9400.858987115198, 9401.10689484498, 9401.388909720847, 4908.680935739237, 4909.509049095133, 4936.037472692862, 4936.802527898843, 4937.11131996237, 4445.666575006888, 4474.418325617714, 4495.595396414338, 4496.865094047183, 4504.864854054384, 3465.86136554535, 3525.894223173309, 3718.5909549949483, 3746.119661879456, 3837.4052021936645, 1203.8495188101488, 1220.3776074202044, 1222.6698791326291, 1229.9877001230052, 1256.2274201366095, 1105.2815669814524, 1132.043423307304, 1135.1202817816259, 1297.2605614799663, 1371.6296599918167, 7239.058922340062, 7242.529235599669, 7245.89131163033, 7541.886871696929, 7826.686932522749, 1135.3641960502146, 1135.4663308245113, 1136.1989797193125, 1143.5413860200636, 1155.179822326141, 5936.525077993837, 5992.550558708114, 6030.788922387783, 6034.336223015464, 6038.426349496791, 9312.674056407994, 9774.12032917041, 9785.559649815634, 9931.602735890483, 9966.451845148442, 9663.46850923192, 9691.418514889128, 9816.705498835046, 9836.0, 9839.262055345735, 7370.852582948418, 7626.313631773167, 7634.389248860078, 7706.691732330756, 7711.190325015905, 7347.7795666130105, 7372.225916278713, 7414.888776668462, 7425.925740742523, 7453.105627324756, 8699.956500217459, 8725.258353040063, 8798.516081615317, 8855.104619578675, 8895.688650897187, 8874.0, 8896.065913079034, 9084.818303633758, 9102.59038343263, 9185.678501252423, 6105.481034111973, 6828.829279268058, 6891.965540172267, 6917.827054323682, 6948.062011628365, 6912.723491060301, 7146.249643787535, 7263.16473605521, 7265.564066156047, 7279.344858962719, 6764.830879228059, 6932.688029038806, 6965.477589180933, 7028.683709232994, 7039.190493093155, 6620.271770105188, 6633.170853643294, 6851.349121833618, 6874.415674667509, 6878.65606719672, 6820.31796820314, 6828.692708828214, 6865.073215115895, 6877.518573699793, 7033.577985320897, 6524.9021264682015, 6616.603003819594, 6633.369829866155, 6644.0, 6648.1025061616065, 6638.601683898982, 6683.933160668331, 6694.129763130762, 6712.2952090031795, 6739.359760822714], "unit": "score", "name": "mootools.html", "value": 4592.75734548753}, {"lowerIsBetter": false, "replicates": [344.8517137630819, 345.7182396346978, 346.52353014604915, 349.3031402352307, 352.165368077656, 5688.715564221783, 5824.068149096145, 5843.941560584393, 5917.792877249297, 5917.88164236715, 5603.2435621191125, 5754.136879468082, 5780.046292361755, 5781.248437703092, 5785.768569257235, 4556.066006468666, 4560.97719511402, 4564.42944631921, 4564.703294285878, 4567.0409214065085, 4333.8699839004885, 4433.379326894237, 4445.933311000337, 4538.954610453903, 4568.223402021665, 4499.077689073749, 4503.166914120881, 4526.637868970491, 4535.773211339436, 4553.043860789222, 4538.954610453903, 4539.614132798716, 4543.7728113594185, 4545.0, 4558.361829343895, 4016.0160760613544, 4023.376376661622, 4023.718339716221, 4026.134381108076, 4027.5569687334664, 5437.700926449043, 5539.972300138474, 5566.526845218162, 5642.887142257132, 5647.971760141214, 5179.533841954242, 5179.948200517984, 5184.248283998837, 5214.478552144793, 5225.346831646044, 5891.3814049525035, 6198.3801619838105, 6198.690065496708, 6199.442050215503, 6200.720967556471, 4224.345226489899, 4244.108737165199, 4335.978320108411, 4338.349247612852, 4346.56534346566, 6319.968400158015, 6464.482841372679, 6474.935250647481, 6500.154979852636, 6512.7394904203775, 4437.66869939017, 4450.443694538183, 4453.599176074169, 4453.777311134495, 4465.776711164429, 4378.058717375779, 4485.955140448619, 4490.39379683745, 4490.842820501332, 4516.209663308908, 5181.0, 5181.896362072737, 5182.559482444034, 5186.507281808223, 5187.507186817246, 6194.986629345391, 6197.504199664016, 6201.069839524017, 6201.10084037812, 6208.689565521706, 1568.5608029751688, 1583.319172755703, 1584.7622856571377, 1587.063632456833, 1587.1350114187796, 1046.4819914142547, 1070.2133931560297, 1070.5022164693298, 1071.5874388360382, 1076.8923107689168, 5864.765409383577, 5865.208196893364, 5867.647941123546, 5871.0, 5881.470667639847, 6366.299707032223, 6371.267304259976, 6371.617702937839, 6377.457916077093, 6380.489560835122, 5874.206982057368, 5875.353711091777, 5875.588708790344, 5876.236089308448, 5879.382664820132, 3308.073739352985, 3429.125572978924, 3433.296174284266, 3433.3476639438427, 3433.6223015468777, 6526.911388355776, 6585.5719378240265, 6602.2737498875085, 6607.075009498674, 6619.139511863524, 6523.054157147187, 6531.640759758259, 6536.705848236841, 6539.149910511603, 6542.280349161589, 6380.457661098766, 6445.226572811199, 6490.188726409199, 6590.209174899042, 6617.0, 6150.723217455315, 6295.433410993032, 6408.807735767934, 6431.228252609717, 6443.516736244894, 6184.072389141665, 6322.083297921868, 6330.8100756977365, 6332.208473940757, 6361.968190159019, 6525.314841941527, 6583.111279977142, 6586.670666466754, 6588.176477940257, 6589.418539550377, 4328.761918094535, 4417.0724147929295, 4472.530384309601, 4472.843450479218, 4473.060657262012, 6322.36776322364, 6364.713587888464, 6379.872402552016, 6382.585131966407, 6385.361463853577, 6170.845728856814, 6201.193844800147, 6219.0, 6219.875602488016, 6226.221722284715, 6061.636301821904, 6208.565400422108, 6210.3168651449205, 6213.285472170758, 6223.751049958132, 6095.451409373178, 6103.938960610337, 6147.0, 6149.046897730859, 6158.137860699416, 6230.6884655767935, 6316.842078948063, 6351.872962540631, 6366.808995730135, 6376.649284289409, 5973.372795856372, 6120.387961203844, 6155.630662160284, 6158.753649853956, 6162.322144564005], "unit": "score", "name": "prototype.html", "value": 4693.008875025108}, {"lowerIsBetter": false, "replicates": [772.8145245141164, 796.5380079553855, 855.1064137975815, 865.788015514921, 868.6395146014406, 13868.098573592722, 13999.580012599612, 14005.649858753524, 14015.0, 14054.227017514046, 13050.151740136884, 13134.540291089814, 13144.802827957565, 13152.079354445194, 13153.868461315384, 656.7963931181325, 665.7802925034752, 801.7113839017949, 827.0241115483727, 829.8174401631661, 824.6247957179469, 836.9497830130181, 837.1419295222385, 839.4417712221366, 840.6595328891779, 869.8042940338405, 870.3602851903846, 871.4553404122423, 872.0, 872.380609767063, 684.1687349869907, 694.5554844899268, 848.9320854331638, 864.2524216552699, 865.3380164174412, 644.7453255963868, 646.0793369448517, 647.2265642557146, 647.5758378262199, 647.7441410642817, 13376.665583360396, 13459.192448453125, 13475.66310842227, 13500.987425943094, 13514.0, 12933.030022748237, 13431.32843357838, 13614.455421783117, 13833.723325533432, 13879.097858639156, 10419.426931518763, 10576.576936922515, 10681.145508359312, 10760.515776789985, 10882.966118218757, 3548.982255088708, 3650.3611867923273, 3650.963490365089, 3665.9450108248398, 3763.4166704160625, 45355.319670204975, 45954.31068533975, 46053.76973115113, 46326.07347853024, 47419.76290118528, 10287.27989040775, 10408.323458975143, 10486.0, 10568.788624227473, 10954.233203675667, 19043.143058562397, 19088.33190838314, 19136.61726765457, 19170.808291916903, 19223.0, 7535.434842386843, 7627.809304767315, 7640.732574359982, 7649.9617501912135, 7669.578173200416, 4360.4767427908855, 4518.186726389282, 4525.298578720303, 4558.726476411426, 4622.514635963243, 3042.361104168105, 3084.6452657944624, 3087.706667866549, 3093.0256969055126, 3100.085474784944, 532.3558494222035, 533.7171299211424, 542.838325982398, 542.9077056900258, 548.5173047717983, 565.1804882919782, 572.8796952639992, 601.9428154325332, 672.3437964154906, 693.6878404717897, 7748.573828439377, 8081.555514446762, 8961.327900407496, 9821.165200958, 9983.201343892617, 520.5783315514445, 527.6807531443499, 615.2555407956334, 658.0951192110848, 704.1620471638734, 4245.280661332104, 4256.191323648497, 4326.4159338489535, 4352.477702675699, 4463.575960283768, 51603.483965160616, 51717.2242416364, 51856.74071629693, 51861.222081668806, 51883.74058129685, 46233.53766462292, 48005.75997120062, 48635.27047094297, 48954.510454895, 49048.26427603589, 42771.0, 43022.13955720931, 43201.56798431976, 43850.0, 44266.33600495995, 8513.19124683154, 8805.779855503664, 8986.591861444294, 9085.500297483437, 9327.347085704207, 32945.176370590925, 33199.83400082984, 33728.83135584307, 33956.32087358288, 33982.66017339795, 40433.0, 43975.0, 44120.0, 44167.55832441634, 44502.10995780131, 11416.372099534605, 11503.76992460163, 11513.597024104116, 11518.769624607294, 11546.826797597874, 11783.469743861375, 11886.940565297118, 11912.106592005808, 12421.31682757457, 12428.067894907737, 11268.549258029587, 11559.133065019989, 11617.302961822317, 11821.408929553316, 11980.940095299467, 11692.35692036946, 11996.64010079699, 12337.568185113478, 12461.065420093348, 12553.748925021631, 11164.162687798611, 11224.775504490028, 11304.660860174208, 11320.09439244842, 11622.6513204604, 8820.426672266281, 9097.40866843653, 9128.908710912805, 9328.160465558132, 9413.623455061721, 8501.0, 8525.616347264511, 8801.427907186013, 9106.0, 9143.177114059501], "unit": "score", "name": "yui.html", "value": 6304.1493194478035}], "name": "dromaeo_css", "value": 6745.21307583423}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 108.0, 112.0, 113.0, 112.0, 101.0, 112.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [155.0, 125.0, 157.0, 175.0, 126.0, 153.0, 155.0, 125.0, 174.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 160.0, 163.0, 161.0, 161.0, 159.0, 164.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 97.0, 100.0, 72.0, 75.0, 71.0, 105.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 149.0, 96.0, 96.0, 95.0, 145.0, 96.0, 97.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 111.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 144.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 64.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 89.0, 83.0, 81.0, 82.0, 86.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [116.0, 114.0, 114.0, 119.0, 123.0, 114.0, 114.0, 114.0, 119.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.6}, {"lowerIsBetter": true, "replicates": [149.0, 142.0, 147.0, 136.0, 146.0, 147.0, 160.0, 147.0, 147.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 66.0, 77.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1502.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.86133822793258], "unit": "score", "name": "Richards", "value": 211.56488599999994}, {"lowerIsBetter": false, "replicates": [189.3939393939394], "unit": "score", "name": "DeltaBlue", "value": 349.1030400000001}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1962.7450980392157], "unit": "score", "name": "RayTrace", "value": 377.0173726273725}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [43574.46808510638], "unit": "score", "name": "RegExp", "value": 20.906394042968756}, {"lowerIsBetter": false, "replicates": [579.7101449275362], "unit": "score", "name": "Splay", "value": 140.57197499999998}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 18911.89620344524}]} 17:27:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18911.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1503.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6745.22"}}} 17:27:36 INFO - Return code: 0 17:27:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:27:37 INFO - # TBPL SUCCESS # 17:27:37 INFO - Running post-action listener: _resource_record_post_action 17:27:37 INFO - Running post-run listener: _resource_record_post_run 17:27:38 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 412573696; Read time: 0; Write time: 798980 17:27:38 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 69365760; Read time: 0; Write time: 184968 17:27:38 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 310935552; Read time: 0; Write time: 510936 17:27:38 INFO - Running post-run listener: _upload_blobber_files 17:27:38 INFO - Blob upload gear active. 17:27:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:27:38 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:27:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:27:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:27:38 INFO - (blobuploader) - INFO - Open directory for files ... 17:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:27:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:27:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:27:39 INFO - (blobuploader) - INFO - Done attempting. 17:27:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:27:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:27:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:27:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:27:40 INFO - (blobuploader) - INFO - Done attempting. 17:27:40 INFO - (blobuploader) - INFO - Iteration through files over. 17:27:40 INFO - Return code: 0 17:27:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:27:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:27:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6dcd537ea199467414b9107b978b8a0532a27a3ae623a0b9e806465c2c4192c1c5c7af7da9b6f00c04d9419fc8f38eaa505bb72314100b4225f60bf00c3506fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/effa7306e04b4267a207c4f1a6c6bbc5020634d64b3d6db9158869eb969973276c56a723761cf19d89841e4f6badd39d72fb438d1c3a5649673cd9049d249f1f"} 17:27:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:27:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:27:40 INFO - Contents: 17:27:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6dcd537ea199467414b9107b978b8a0532a27a3ae623a0b9e806465c2c4192c1c5c7af7da9b6f00c04d9419fc8f38eaa505bb72314100b4225f60bf00c3506fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/effa7306e04b4267a207c4f1a6c6bbc5020634d64b3d6db9158869eb969973276c56a723761cf19d89841e4f6badd39d72fb438d1c3a5649673cd9049d249f1f"} 17:27:40 INFO - Copying logs to upload dir... 17:27:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1282.452010 ========= master_lag: -0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-14 17:27:39.593232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 17:27:39.598596) ========= 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=745a4373a2a16df560f216e000000264-1452819975.856976-1177906198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6dcd537ea199467414b9107b978b8a0532a27a3ae623a0b9e806465c2c4192c1c5c7af7da9b6f00c04d9419fc8f38eaa505bb72314100b4225f60bf00c3506fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/effa7306e04b4267a207c4f1a6c6bbc5020634d64b3d6db9158869eb969973276c56a723761cf19d89841e4f6badd39d72fb438d1c3a5649673cd9049d249f1f"} build_url:https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/NTYKSjikTjKKXUQQCQO9YA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6dcd537ea199467414b9107b978b8a0532a27a3ae623a0b9e806465c2c4192c1c5c7af7da9b6f00c04d9419fc8f38eaa505bb72314100b4225f60bf00c3506fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/effa7306e04b4267a207c4f1a6c6bbc5020634d64b3d6db9158869eb969973276c56a723761cf19d89841e4f6badd39d72fb438d1c3a5649673cd9049d249f1f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 17:27:39.627290) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:27:39.627668) ========= 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=745a4373a2a16df560f216e000000264-1452819975.856976-1177906198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 17:27:39.710175) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 17:27:39.710532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 17:27:39.710848) ========= ========= Total master_lag: -0.06 =========