builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1453337472.56 results: success (0) buildid: 20160120143015 builduid: ba39ddd98ab74408ba3330337d5ad87a revision: 3fa5fc79c9ce26e9c554dcb4473d6eac3334809a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.564019) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.565260) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.565552) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006476 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.593487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.593787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.613444) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.613759) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004655 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.666229) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.666546) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.666955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.667265) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 16:51:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-01-20 16:51:12 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094405 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.774786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.775168) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022396 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.824791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:12.825200) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 3fa5fc79c9ce26e9c554dcb4473d6eac3334809a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 3fa5fc79c9ce26e9c554dcb4473d6eac3334809a --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=fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 16:51:13,018 truncating revision to first 12 chars 2016-01-20 16:51:13,018 Setting DEBUG logging. 2016-01-20 16:51:13,019 attempt 1/10 2016-01-20 16:51:13,019 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/3fa5fc79c9ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 16:51:13,253 unpacking tar archive at: b2g-inbound-3fa5fc79c9ce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525632 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:13.364739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:13.365077) ========= echo 3fa5fc79c9ce26e9c554dcb4473d6eac3334809a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3fa5fc79c9ce26e9c554dcb4473d6eac3334809a'] 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=fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3fa5fc79c9ce26e9c554dcb4473d6eac3334809a program finished with exit code 0 elapsedTime=0.004409 script_repo_revision: '3fa5fc79c9ce26e9c554dcb4473d6eac3334809a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:13.418472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:13.419072) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:13.431850) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:13.432183) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/3fa5fc79c9ce26e9c554dcb4473d6eac3334809a ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 16:51:13.432620) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 1 hrs, 11 mins, 4 secs) (at 2016-01-20 16:51:13.432926) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:51:13 INFO - MultiFileLogger online at 20160120 16:51:13 in /builds/slave/test-pgo 16:51:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 16:51:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:51:13 INFO - {'append_to_log': False, 16:51:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:51:13 INFO - 'blob_upload_branch': 'B2G-Inbound', 16:51:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:51:13 INFO - 'branch': 'B2G-Inbound', 16:51:13 INFO - 'buildbot_json_path': 'buildprops.json', 16:51:13 INFO - 'config_files': ('talos/linux_config.py',), 16:51:13 INFO - 'default_actions': ('clobber', 16:51:13 INFO - 'read-buildbot-config', 16:51:13 INFO - 'download-and-extract', 16:51:13 INFO - 'populate-webroot', 16:51:13 INFO - 'create-virtualenv', 16:51:13 INFO - 'install', 16:51:13 INFO - 'run-tests'), 16:51:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:51:13 INFO - 'download_minidump_stackwalk': True, 16:51:13 INFO - 'download_symbols': 'ondemand', 16:51:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:51:13 INFO - 'tooltool.py': '/tools/tooltool.py', 16:51:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:51:13 INFO - '/tools/misc-python/virtualenv.py')}, 16:51:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:51:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:51:13 INFO - 'installer_path': 'installer.exe', 16:51:13 INFO - 'log_level': 'info', 16:51:13 INFO - 'log_name': 'talos', 16:51:13 INFO - 'log_to_console': True, 16:51:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:51:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:51:13 INFO - 'opt_config_files': (), 16:51:13 INFO - 'pip_index': False, 16:51:13 INFO - 'sps_profile': False, 16:51:13 INFO - 'sps_profile_interval': 0, 16:51:13 INFO - 'suite': 'dromaeojs', 16:51:13 INFO - 'system_bits': '32', 16:51:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:51:13 INFO - 'title': 'talos-linux64-ix-014', 16:51:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:51:13 INFO - 'use_talos_json': True, 16:51:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:51:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:51:13 INFO - 'work_dir': 'build'} 16:51:13 INFO - ##### 16:51:13 INFO - ##### Running clobber step. 16:51:13 INFO - ##### 16:51:13 INFO - Running pre-action listener: _resource_record_pre_action 16:51:13 INFO - Running main action method: clobber 16:51:13 INFO - rmtree: /builds/slave/test-pgo/build 16:51:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:51:14 INFO - Running post-action listener: _resource_record_post_action 16:51:14 INFO - ##### 16:51:14 INFO - ##### Running read-buildbot-config step. 16:51:14 INFO - ##### 16:51:14 INFO - Running pre-action listener: _resource_record_pre_action 16:51:14 INFO - Running main action method: read_buildbot_config 16:51:14 INFO - Using buildbot properties: 16:51:14 INFO - { 16:51:14 INFO - "project": "", 16:51:14 INFO - "product": "firefox", 16:51:14 INFO - "script_repo_revision": "production", 16:51:14 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 16:51:14 INFO - "repository": "", 16:51:14 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 16:51:14 INFO - "buildid": "20160120143015", 16:51:14 INFO - "pgo_build": "True", 16:51:14 INFO - "basedir": "/builds/slave/test-pgo", 16:51:14 INFO - "buildnumber": 218, 16:51:14 INFO - "slavename": "talos-linux64-ix-014", 16:51:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:51:14 INFO - "platform": "ubuntu64_hw", 16:51:14 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 16:51:14 INFO - "branch": "b2g-inbound", 16:51:14 INFO - "repo_path": "integration/b2g-inbound", 16:51:14 INFO - "revision": "3fa5fc79c9ce26e9c554dcb4473d6eac3334809a", 16:51:14 INFO - "stage_platform": "linux64-pgo", 16:51:14 INFO - "builduid": "ba39ddd98ab74408ba3330337d5ad87a", 16:51:14 INFO - "slavebuilddir": "test" 16:51:14 INFO - } 16:51:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:51:14 INFO - Running post-action listener: _resource_record_post_action 16:51:14 INFO - ##### 16:51:14 INFO - ##### Running download-and-extract step. 16:51:14 INFO - ##### 16:51:14 INFO - Running pre-action listener: _resource_record_pre_action 16:51:14 INFO - Running main action method: download_and_extract 16:51:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:14 INFO - https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:51:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/test_packages.json 16:51:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/test_packages.json 16:51:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:51:17 INFO - Downloaded 1448 bytes. 16:51:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:51:17 INFO - Using the following test package requirements: 16:51:17 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:51:17 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:51:17 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:51:17 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:17 INFO - u'jsshell-linux-x86_64.zip'], 16:51:17 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:51:17 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:51:17 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:51:17 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:51:17 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:51:17 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:51:17 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:51:17 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:17 INFO - https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:51:18 INFO - Downloaded 22485206 bytes. 16:51:18 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'] 16:51:18 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 16:51:20 INFO - Return code: 0 16:51:20 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:51: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')]} 16:51:20 INFO - https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:51:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:51:21 INFO - Downloaded 22485206 bytes. 16:51:21 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'] 16:51:21 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 16:51:23 INFO - Return code: 0 16:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:23 INFO - https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:51:24 INFO - Downloaded 11132144 bytes. 16:51:24 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'] 16:51:24 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 16:51:24 INFO - Return code: 0 16:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:24 INFO - https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:51:26 INFO - Downloaded 55935865 bytes. 16:51:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:26 INFO - mkdir: /builds/slave/test-pgo/properties 16:51:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:51:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:51:26 INFO - Contents: 16:51:26 INFO - build_url:https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:26 INFO - Running post-action listener: _resource_record_post_action 16:51:26 INFO - Running post-action listener: set_extra_try_arguments 16:51:26 INFO - ##### 16:51:26 INFO - ##### Running populate-webroot step. 16:51:26 INFO - ##### 16:51:26 INFO - Running pre-action listener: _resource_record_pre_action 16:51:26 INFO - Running main action method: populate_webroot 16:51:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:51:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:51:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:51:26 INFO - '--tppagecycles', 16:51:26 INFO - '7'], 16:51:26 INFO - 'tests': ['tsvgm']}}, 16:51:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:51:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:51:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:51:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:51:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:51:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:51:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:26 INFO - 'talos_options': ['--e10s'], 16:51:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:26 INFO - 'tests': ['damp', 'tps']}, 16:51:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:26 INFO - 'talos_options': ['--e10s'], 16:51:26 INFO - 'tests': ['damp', 'tps']}, 16:51:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:51:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:51:26 INFO - 'other': {'tests': ['a11yr', 16:51:26 INFO - 'ts_paint', 16:51:26 INFO - 'tpaint', 16:51:26 INFO - 'sessionrestore', 16:51:26 INFO - 'sessionrestore_no_auto_restore']}, 16:51:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:51:26 INFO - 'tests': ['a11yr', 16:51:26 INFO - 'ts_paint', 16:51:26 INFO - 'tpaint', 16:51:26 INFO - 'sessionrestore', 16:51:26 INFO - 'sessionrestore_no_auto_restore']}, 16:51:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:51:26 INFO - 'tests': ['a11yr', 16:51:26 INFO - 'ts_paint', 16:51:26 INFO - 'tpaint', 16:51:26 INFO - 'sessionrestore', 16:51:26 INFO - 'sessionrestore_no_auto_restore']}, 16:51:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:51:26 INFO - 'tests': ['a11yr', 16:51:26 INFO - 'ts_paint', 16:51:26 INFO - 'tpaint', 16:51:26 INFO - 'sessionrestore', 16:51:26 INFO - 'sessionrestore_no_auto_restore']}, 16:51:26 INFO - 'other_l64': {'tests': ['a11yr', 16:51:26 INFO - 'ts_paint', 16:51:26 INFO - 'tpaint', 16:51:26 INFO - 'sessionrestore', 16:51:26 INFO - 'sessionrestore_no_auto_restore']}, 16:51:26 INFO - 'other_nol64': {'tests': ['a11yr', 16:51:26 INFO - 'ts_paint', 16:51:26 INFO - 'tpaint', 16:51:26 INFO - 'sessionrestore', 16:51:26 INFO - 'sessionrestore_no_auto_restore']}, 16:51:26 INFO - 'svgr': {'tests': ['tsvgx', 16:51:26 INFO - 'tsvgr_opacity', 16:51:26 INFO - 'tart', 16:51:26 INFO - 'tscrollx', 16:51:26 INFO - 'cart']}, 16:51:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:51:26 INFO - 'tests': ['tsvgx', 16:51:26 INFO - 'tsvgr_opacity', 16:51:26 INFO - 'tart', 16:51:26 INFO - 'tscrollx', 16:51:26 INFO - 'cart']}, 16:51:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:26 INFO - 'tests': ['tp5o']}, 16:51:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:26 INFO - 'talos_options': ['--e10s'], 16:51:26 INFO - 'tests': ['tp5o']}, 16:51:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:26 INFO - 'talos_options': ['--xperf_path', 16:51:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:26 INFO - 'tests': ['tp5n']}, 16:51:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:26 INFO - 'talos_options': ['--e10s', 16:51:26 INFO - '--xperf_path', 16:51:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:26 INFO - 'tests': ['tp5n']}}, 16:51:26 INFO - 'talos.zip': {'path': '', 16:51:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:51:26 INFO - Running post-action listener: _resource_record_post_action 16:51:26 INFO - ##### 16:51:26 INFO - ##### Running create-virtualenv step. 16:51:26 INFO - ##### 16:51:26 INFO - Running pre-action listener: _resource_record_pre_action 16:51:26 INFO - Running main action method: create_virtualenv 16:51:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:51:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 16:51:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:51:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:51:26 INFO - Using real prefix '/usr' 16:51:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:51:26 INFO - Installing distribute.............................................................................................................................................................................................done. 16:51:28 INFO - Installing pip.................done. 16:51:28 INFO - Return code: 0 16:51:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:51: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')]} 16:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4462bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1489840>, '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 0x13f66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f6b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:51:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:51:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:51:28 INFO - Using env: {'DISPLAY': ':0', 16:51:28 INFO - 'HOME': '/home/cltbld', 16:51:28 INFO - 'LANG': 'en_US.UTF-8', 16:51:28 INFO - 'LANGUAGE': 'en_US:en', 16:51:28 INFO - 'LOGNAME': 'cltbld', 16:51:28 INFO - 'MAIL': '/var/mail/cltbld', 16:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:28 INFO - 'MOZ_NO_REMOTE': '1', 16:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:28 INFO - 'NO_EM_RESTART': '1', 16:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:28 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:28 INFO - 'SHELL': '/bin/bash', 16:51:28 INFO - 'SHLVL': '1', 16:51:28 INFO - 'TERM': 'linux', 16:51:28 INFO - 'TMOUT': '86400', 16:51:28 INFO - 'USER': 'cltbld', 16:51:28 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 16:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:28 INFO - '_': '/tools/buildbot/bin/python'} 16:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:51:28 INFO - Cleaning up... 16:51:28 INFO - Return code: 0 16:51:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:51: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')]} 16:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4462bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1489840>, '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 0x13f66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f6b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:51:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:51:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:51:28 INFO - Using env: {'DISPLAY': ':0', 16:51:28 INFO - 'HOME': '/home/cltbld', 16:51:28 INFO - 'LANG': 'en_US.UTF-8', 16:51:28 INFO - 'LANGUAGE': 'en_US:en', 16:51:28 INFO - 'LOGNAME': 'cltbld', 16:51:28 INFO - 'MAIL': '/var/mail/cltbld', 16:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:28 INFO - 'MOZ_NO_REMOTE': '1', 16:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:28 INFO - 'NO_EM_RESTART': '1', 16:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:28 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:28 INFO - 'SHELL': '/bin/bash', 16:51:28 INFO - 'SHLVL': '1', 16:51:28 INFO - 'TERM': 'linux', 16:51:28 INFO - 'TMOUT': '86400', 16:51:28 INFO - 'USER': 'cltbld', 16:51:28 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 16:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:28 INFO - '_': '/tools/buildbot/bin/python'} 16:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:29 INFO - Downloading/unpacking psutil>=0.7.1 16:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:51:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:31 INFO - Installing collected packages: psutil 16:51:31 INFO - Running setup.py install for psutil 16:51:31 INFO - building 'psutil._psutil_linux' extension 16:51:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:51:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:51:31 INFO - building 'psutil._psutil_posix' extension 16:51:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:51:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:51:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:31 INFO - Successfully installed psutil 16:51:31 INFO - Cleaning up... 16:51:31 INFO - Return code: 0 16:51:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4462bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1489840>, '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 0x13f66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f6b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:51:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:51:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:51:31 INFO - Using env: {'DISPLAY': ':0', 16:51:31 INFO - 'HOME': '/home/cltbld', 16:51:31 INFO - 'LANG': 'en_US.UTF-8', 16:51:31 INFO - 'LANGUAGE': 'en_US:en', 16:51:31 INFO - 'LOGNAME': 'cltbld', 16:51:31 INFO - 'MAIL': '/var/mail/cltbld', 16:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:31 INFO - 'MOZ_NO_REMOTE': '1', 16:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:31 INFO - 'NO_EM_RESTART': '1', 16:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:31 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:31 INFO - 'SHELL': '/bin/bash', 16:51:31 INFO - 'SHLVL': '1', 16:51:31 INFO - 'TERM': 'linux', 16:51:31 INFO - 'TMOUT': '86400', 16:51:31 INFO - 'USER': 'cltbld', 16:51:31 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 16:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:31 INFO - '_': '/tools/buildbot/bin/python'} 16:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:51:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:51:33 INFO - Installing collected packages: mozsystemmonitor 16:51:33 INFO - Running setup.py install for mozsystemmonitor 16:51:33 INFO - Successfully installed mozsystemmonitor 16:51:33 INFO - Cleaning up... 16:51:33 INFO - Return code: 0 16:51:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4462bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1489840>, '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 0x13f66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f6b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:51:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:51:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:51:33 INFO - Using env: {'DISPLAY': ':0', 16:51:33 INFO - 'HOME': '/home/cltbld', 16:51:33 INFO - 'LANG': 'en_US.UTF-8', 16:51:33 INFO - 'LANGUAGE': 'en_US:en', 16:51:33 INFO - 'LOGNAME': 'cltbld', 16:51:33 INFO - 'MAIL': '/var/mail/cltbld', 16:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:33 INFO - 'MOZ_NO_REMOTE': '1', 16:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:33 INFO - 'NO_EM_RESTART': '1', 16:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:33 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:33 INFO - 'SHELL': '/bin/bash', 16:51:33 INFO - 'SHLVL': '1', 16:51:33 INFO - 'TERM': 'linux', 16:51:33 INFO - 'TMOUT': '86400', 16:51:33 INFO - 'USER': 'cltbld', 16:51:33 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 16:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:33 INFO - '_': '/tools/buildbot/bin/python'} 16:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:33 INFO - Downloading/unpacking blobuploader==1.2.4 16:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:35 INFO - Downloading blobuploader-1.2.4.tar.gz 16:51:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:51:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:51:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:36 INFO - Downloading docopt-0.6.1.tar.gz 16:51:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:51:36 INFO - Installing collected packages: blobuploader, requests, docopt 16:51:36 INFO - Running setup.py install for blobuploader 16:51:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:51:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:51:36 INFO - Running setup.py install for requests 16:51:36 INFO - Running setup.py install for docopt 16:51:36 INFO - Successfully installed blobuploader requests docopt 16:51:36 INFO - Cleaning up... 16:51:36 INFO - Return code: 0 16:51:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4462bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1489840>, '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 0x13f66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f6b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:51:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:51:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:51:36 INFO - Using env: {'DISPLAY': ':0', 16:51:36 INFO - 'HOME': '/home/cltbld', 16:51:36 INFO - 'LANG': 'en_US.UTF-8', 16:51:36 INFO - 'LANGUAGE': 'en_US:en', 16:51:36 INFO - 'LOGNAME': 'cltbld', 16:51:36 INFO - 'MAIL': '/var/mail/cltbld', 16:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:36 INFO - 'MOZ_NO_REMOTE': '1', 16:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:36 INFO - 'NO_EM_RESTART': '1', 16:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:36 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:36 INFO - 'SHELL': '/bin/bash', 16:51:36 INFO - 'SHLVL': '1', 16:51:36 INFO - 'TERM': 'linux', 16:51:36 INFO - 'TMOUT': '86400', 16:51:36 INFO - 'USER': 'cltbld', 16:51:36 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 16:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:36 INFO - '_': '/tools/buildbot/bin/python'} 16:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:37 INFO - Running setup.py (path:/tmp/pip-MV_z5U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:37 INFO - Running setup.py (path:/tmp/pip-uYnQsu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:37 INFO - Running setup.py (path:/tmp/pip-6m45gc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:37 INFO - Running setup.py (path:/tmp/pip-8JbhWv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:37 INFO - Running setup.py (path:/tmp/pip-mmi3lU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:37 INFO - Running setup.py (path:/tmp/pip-YJbicX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:37 INFO - Running setup.py (path:/tmp/pip-dlPbf5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:37 INFO - Running setup.py (path:/tmp/pip-_celtE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:37 INFO - Running setup.py (path:/tmp/pip-9RYxO9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:37 INFO - Running setup.py (path:/tmp/pip-X4UIEw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:37 INFO - Running setup.py (path:/tmp/pip-ahtgXA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:37 INFO - Running setup.py (path:/tmp/pip-gNUp2d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:38 INFO - Running setup.py (path:/tmp/pip-4QnzWv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:38 INFO - Running setup.py (path:/tmp/pip-AYVfCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:38 INFO - Running setup.py (path:/tmp/pip-xLSo99-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:38 INFO - Running setup.py (path:/tmp/pip-y0tV7U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:38 INFO - Running setup.py (path:/tmp/pip-nT49Su-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:51:38 INFO - Running setup.py install for manifestparser 16:51:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:51:38 INFO - Running setup.py install for mozcrash 16:51:38 INFO - Running setup.py install for mozdebug 16:51:38 INFO - Running setup.py install for mozdevice 16:51:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:51:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:51:38 INFO - Running setup.py install for mozfile 16:51:38 INFO - Running setup.py install for mozhttpd 16:51:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:51:39 INFO - Running setup.py install for mozinfo 16:51:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:51:39 INFO - Running setup.py install for mozInstall 16:51:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:51:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:51:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:51:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:51:39 INFO - Running setup.py install for mozleak 16:51:39 INFO - Running setup.py install for mozlog 16:51:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:51:39 INFO - Running setup.py install for moznetwork 16:51:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:51:39 INFO - Running setup.py install for mozprocess 16:51:39 INFO - Running setup.py install for mozprofile 16:51:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:51:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:51:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:51:39 INFO - Running setup.py install for mozrunner 16:51:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:51:39 INFO - Running setup.py install for mozscreenshot 16:51:39 INFO - Running setup.py install for moztest 16:51:40 INFO - Running setup.py install for mozversion 16:51:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:51:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:51:40 INFO - Cleaning up... 16:51:40 INFO - Return code: 0 16:51:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4462bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1489840>, '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 0x13f66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f6b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:51:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:51:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:51:40 INFO - Using env: {'DISPLAY': ':0', 16:51:40 INFO - 'HOME': '/home/cltbld', 16:51:40 INFO - 'LANG': 'en_US.UTF-8', 16:51:40 INFO - 'LANGUAGE': 'en_US:en', 16:51:40 INFO - 'LOGNAME': 'cltbld', 16:51:40 INFO - 'MAIL': '/var/mail/cltbld', 16:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:40 INFO - 'MOZ_NO_REMOTE': '1', 16:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:40 INFO - 'NO_EM_RESTART': '1', 16:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:40 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:40 INFO - 'SHELL': '/bin/bash', 16:51:40 INFO - 'SHLVL': '1', 16:51:40 INFO - 'TERM': 'linux', 16:51:40 INFO - 'TMOUT': '86400', 16:51:40 INFO - 'USER': 'cltbld', 16:51:40 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 16:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:40 INFO - '_': '/tools/buildbot/bin/python'} 16:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:40 INFO - Running setup.py (path:/tmp/pip-qq9voS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 16:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:40 INFO - Running setup.py (path:/tmp/pip-jJIS31-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:40 INFO - Running setup.py (path:/tmp/pip-N2t76l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:40 INFO - Running setup.py (path:/tmp/pip-MTEsTI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:40 INFO - Running setup.py (path:/tmp/pip-WhKqkn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 16:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:40 INFO - Running setup.py (path:/tmp/pip-QBoDgL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 16:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:40 INFO - Running setup.py (path:/tmp/pip-ABlGBw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 16:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:40 INFO - Running setup.py (path:/tmp/pip-Ec8aE9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 16:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:40 INFO - Running setup.py (path:/tmp/pip-TEGmls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 16:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:41 INFO - Running setup.py (path:/tmp/pip-Dsg1tH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:41 INFO - Running setup.py (path:/tmp/pip-JHzwe5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 16:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:41 INFO - Running setup.py (path:/tmp/pip-nL_NEu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 16:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:41 INFO - Running setup.py (path:/tmp/pip-IJtcrC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 16:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:41 INFO - Running setup.py (path:/tmp/pip-nWp9sA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 16:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:41 INFO - Running setup.py (path:/tmp/pip-fyBH0P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 16:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:41 INFO - Running setup.py (path:/tmp/pip-ZMhOyE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 16:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:41 INFO - Running setup.py (path:/tmp/pip-wcpU3K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:51:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:43 INFO - Downloading blessings-1.6.tar.gz 16:51:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:51:43 INFO - Installing collected packages: blessings 16:51:43 INFO - Running setup.py install for blessings 16:51:43 INFO - Successfully installed blessings 16:51:43 INFO - Cleaning up... 16:51:43 INFO - Return code: 0 16:51:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:51:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:51:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:51:43 INFO - Reading from file tmpfile_stdout 16:51:43 INFO - Current package versions: 16:51:43 INFO - argparse == 1.2.1 16:51:43 INFO - blessings == 1.6 16:51:43 INFO - blobuploader == 1.2.4 16:51:43 INFO - docopt == 0.6.1 16:51:43 INFO - manifestparser == 1.1 16:51:43 INFO - mozInstall == 1.12 16:51:43 INFO - mozcrash == 0.16 16:51:43 INFO - mozdebug == 0.1 16:51:43 INFO - mozdevice == 0.48 16:51:43 INFO - mozfile == 1.2 16:51:43 INFO - mozhttpd == 0.7 16:51:43 INFO - mozinfo == 0.9 16:51:43 INFO - mozleak == 0.1 16:51:43 INFO - mozlog == 3.1 16:51:43 INFO - moznetwork == 0.27 16:51:43 INFO - mozprocess == 0.22 16:51:43 INFO - mozprofile == 0.28 16:51:43 INFO - mozrunner == 6.11 16:51:43 INFO - mozscreenshot == 0.1 16:51:43 INFO - mozsystemmonitor == 0.0 16:51:43 INFO - moztest == 0.7 16:51:43 INFO - mozversion == 1.4 16:51:43 INFO - psutil == 3.1.1 16:51:43 INFO - requests == 1.2.3 16:51:43 INFO - wsgiref == 0.1.2 16:51:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4462bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1489840>, '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 0x13f66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f6b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:51:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:51:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:51:43 INFO - Using env: {'DISPLAY': ':0', 16:51:43 INFO - 'HOME': '/home/cltbld', 16:51:43 INFO - 'LANG': 'en_US.UTF-8', 16:51:43 INFO - 'LANGUAGE': 'en_US:en', 16:51:43 INFO - 'LOGNAME': 'cltbld', 16:51:43 INFO - 'MAIL': '/var/mail/cltbld', 16:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:43 INFO - 'MOZ_NO_REMOTE': '1', 16:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:43 INFO - 'NO_EM_RESTART': '1', 16:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:43 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:43 INFO - 'SHELL': '/bin/bash', 16:51:43 INFO - 'SHLVL': '1', 16:51:43 INFO - 'TERM': 'linux', 16:51:43 INFO - 'TMOUT': '86400', 16:51:43 INFO - 'USER': 'cltbld', 16:51:43 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 16:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:43 INFO - '_': '/tools/buildbot/bin/python'} 16:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 16:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 16:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 16:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 16:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 16:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 16:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:51:44 INFO - Cleaning up... 16:51:44 INFO - Return code: 0 16:51:44 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:51: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')]} 16:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4462bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1489840>, '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 0x13f66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f6b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:51:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:51:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:51:44 INFO - Using env: {'DISPLAY': ':0', 16:51:44 INFO - 'HOME': '/home/cltbld', 16:51:44 INFO - 'LANG': 'en_US.UTF-8', 16:51:44 INFO - 'LANGUAGE': 'en_US:en', 16:51:44 INFO - 'LOGNAME': 'cltbld', 16:51:44 INFO - 'MAIL': '/var/mail/cltbld', 16:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:44 INFO - 'MOZ_NO_REMOTE': '1', 16:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:44 INFO - 'NO_EM_RESTART': '1', 16:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:44 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:44 INFO - 'SHELL': '/bin/bash', 16:51:44 INFO - 'SHLVL': '1', 16:51:44 INFO - 'TERM': 'linux', 16:51:44 INFO - 'TMOUT': '86400', 16:51:44 INFO - 'USER': 'cltbld', 16:51:44 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 16:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:44 INFO - '_': '/tools/buildbot/bin/python'} 16:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:44 INFO - Downloading/unpacking jsonschema 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:51:46 INFO - Downloading/unpacking functools32 (from jsonschema) 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:46 INFO - Downloading functools32-3.2.3-2.tar.gz 16:51:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:51:46 INFO - warning: no files found matching '*.txt' 16:51:46 INFO - no previously-included directories found matching 'build' 16:51:46 INFO - no previously-included directories found matching 'dist' 16:51:46 INFO - no previously-included directories found matching '.git*' 16:51:46 INFO - Installing collected packages: jsonschema, functools32 16:51:46 INFO - Running setup.py install for functools32 16:51:46 INFO - warning: no files found matching '*.txt' 16:51:46 INFO - no previously-included directories found matching 'build' 16:51:46 INFO - no previously-included directories found matching 'dist' 16:51:46 INFO - no previously-included directories found matching '.git*' 16:51:46 INFO - Successfully installed jsonschema functools32 16:51:46 INFO - Cleaning up... 16:51:46 INFO - Return code: 0 16:51:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4462bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1489840>, '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 0x13f66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f6b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:51:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:51:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:51:46 INFO - Using env: {'DISPLAY': ':0', 16:51:46 INFO - 'HOME': '/home/cltbld', 16:51:46 INFO - 'LANG': 'en_US.UTF-8', 16:51:46 INFO - 'LANGUAGE': 'en_US:en', 16:51:46 INFO - 'LOGNAME': 'cltbld', 16:51:46 INFO - 'MAIL': '/var/mail/cltbld', 16:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:46 INFO - 'MOZ_NO_REMOTE': '1', 16:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:46 INFO - 'NO_EM_RESTART': '1', 16:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:46 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:46 INFO - 'SHELL': '/bin/bash', 16:51:46 INFO - 'SHLVL': '1', 16:51:46 INFO - 'TERM': 'linux', 16:51:46 INFO - 'TMOUT': '86400', 16:51:46 INFO - 'USER': 'cltbld', 16:51:46 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 16:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:46 INFO - '_': '/tools/buildbot/bin/python'} 16:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:46 INFO - Downloading/unpacking flake8 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:51:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:51:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:51:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:51:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:51:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:51:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:51:49 INFO - no previously-included directories found matching 'docs/_build' 16:51:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:51:49 INFO - Running setup.py install for pep8 16:51:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:51:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:51:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:51:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:51:49 INFO - no previously-included directories found matching 'docs/_build' 16:51:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:51:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:51:49 INFO - Cleaning up... 16:51:49 INFO - Return code: 0 16:51:49 INFO - Running post-action listener: _resource_record_post_action 16:51:49 INFO - Running post-action listener: _start_resource_monitoring 16:51:49 INFO - Starting resource monitoring. 16:51:49 INFO - ##### 16:51:49 INFO - ##### Running install step. 16:51:49 INFO - ##### 16:51:49 INFO - Running pre-action listener: _resource_record_pre_action 16:51:49 INFO - Running main action method: install 16:51:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:51:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:51:49 INFO - Reading from file tmpfile_stdout 16:51:49 INFO - Detecting whether we're running mozinstall >=1.0... 16:51:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:51:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:51:49 INFO - Reading from file tmpfile_stdout 16:51:49 INFO - Output received: 16:51:49 INFO - Usage: mozinstall [options] installer 16:51:49 INFO - Options: 16:51:49 INFO - -h, --help show this help message and exit 16:51:49 INFO - -d DEST, --destination=DEST 16:51:49 INFO - Directory to install application into. [default: 16:51:49 INFO - "/builds/slave/test-pgo"] 16:51:49 INFO - --app=APP Application being installed. [default: firefox] 16:51:49 INFO - mkdir: /builds/slave/test-pgo/build/application 16:51:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:51:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:52:05 INFO - Reading from file tmpfile_stdout 16:52:05 INFO - Output received: 16:52:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:52:05 INFO - Running post-action listener: _resource_record_post_action 16:52:05 INFO - ##### 16:52:05 INFO - ##### Running run-tests step. 16:52:05 INFO - ##### 16:52:05 INFO - Running pre-action listener: _resource_record_pre_action 16:52:05 INFO - Running main action method: run_tests 16:52:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:52:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:52:05 INFO - Python 2.7.3 16:52:05 INFO - Return code: 0 16:52:05 INFO - grabbing minidump binary from tooltool 16:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:05 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 0x1489840>, '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 0x13f66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f6b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:52:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 16:52:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:52:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:52:05 INFO - Return code: 0 16:52:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:52:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:52:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:52:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:52:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:52:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:52:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:52:06 INFO - Return code: 0 16:52:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 16:52:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 16:52:06 INFO - Using env: {'DISPLAY': ':0', 16:52:06 INFO - 'HOME': '/home/cltbld', 16:52:06 INFO - 'LANG': 'en_US.UTF-8', 16:52:06 INFO - 'LANGUAGE': 'en_US:en', 16:52:06 INFO - 'LOGNAME': 'cltbld', 16:52:06 INFO - 'MAIL': '/var/mail/cltbld', 16:52:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:52:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:06 INFO - 'MOZ_NO_REMOTE': '1', 16:52:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:06 INFO - 'NO_EM_RESTART': '1', 16:52:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:52:06 INFO - 'PWD': '/builds/slave/test-pgo', 16:52:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:52:06 INFO - 'SHELL': '/bin/bash', 16:52:06 INFO - 'SHLVL': '1', 16:52:06 INFO - 'TERM': 'linux', 16:52:06 INFO - 'TMOUT': '86400', 16:52:06 INFO - 'USER': 'cltbld', 16:52:06 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480', 16:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:06 INFO - '_': '/tools/buildbot/bin/python'} 16:52:06 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:52:06 INFO - mozversion application_buildid: 20160120143015 16:52:06 INFO - mozversion application_changeset: 3fa5fc79c9ce26e9c554dcb4473d6eac3334809a 16:52:06 INFO - mozversion application_display_name: Nightly 16:52:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:52:06 INFO - mozversion application_name: Firefox 16:52:06 INFO - mozversion application_remotingname: firefox 16:52:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 16:52:06 INFO - mozversion application_vendor: Mozilla 16:52:06 INFO - mozversion application_version: 46.0a1 16:52:06 INFO - mozversion platform_buildid: 20160120143015 16:52:06 INFO - mozversion platform_changeset: 3fa5fc79c9ce26e9c554dcb4473d6eac3334809a 16:52:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 16:52:06 INFO - mozversion platform_version: 46.0a1 16:52:06 INFO - using testdate: 1453337526 16:52:06 INFO - actual date: 1453337526 16:52:06 INFO - starting webserver on 'localhost:41621' 16:52:06 INFO - SUITE-START | Running 3 tests 16:52:06 INFO - TEST-START | dromaeo_css 16:52:06 INFO - operating with platform_type : linux_ 16:52:06 INFO - Initialising browser for dromaeo_css test... 16:52:06 INFO - TEST-INFO | started process 13053 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUR7ERm/profile http://localhost:41621/getInfo.html) 16:52:10 INFO - PROCESS | 13053 | __metrics Screen width/height:1600/1200 16:52:10 INFO - PROCESS | 13053 | colorDepth:24 16:52:10 INFO - PROCESS | 13053 | Browser inner width/height: 1024/697 16:52:10 INFO - PROCESS | 13053 | __metrics 16:52:10 INFO - PROCESS | 13053 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:52:10 INFO - PROCESS | 13053 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:52:12 INFO - TEST-INFO | 13053: exit 0 16:52:12 INFO - Browser initialized. 16:52:12 INFO - Running cycle 1/1 for dromaeo_css test... 16:52:12 INFO - TEST-INFO | started process 13146 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUR7ERm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:52:23 INFO - PROCESS | 13146 | RSS: Main: 149327872 16:52:23 INFO - PROCESS | 13146 | 16:53:15 INFO - PROCESS | 13146 | 1453337595485 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:55:23 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:41621/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41621/tests/dromaeo/cssquery-ext.html) 16:55:24 INFO - PROCESS | 13146 | RSS: Main: 241602560 16:55:24 INFO - PROCESS | 13146 | 16:58:26 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:41621/tests/dromaeo/cssquery-ext.html (next: http://localhost:41621/tests/dromaeo/cssquery-jquery.html) 16:58:27 INFO - PROCESS | 13146 | RSS: Main: 226869248 16:58:27 INFO - PROCESS | 13146 | 17:01:29 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:41621/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41621/tests/dromaeo/cssquery-mootools.html) 17:01:29 INFO - PROCESS | 13146 | RSS: Main: 232271872 17:01:29 INFO - PROCESS | 13146 | 17:04:31 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:41621/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41621/tests/dromaeo/cssquery-prototype.html) 17:04:32 INFO - PROCESS | 13146 | RSS: Main: 211734528 17:04:32 INFO - PROCESS | 13146 | 17:07:34 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:41621/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41621/tests/dromaeo/cssquery-yui.html) 17:07:35 INFO - PROCESS | 13146 | RSS: Main: 213880832 17:07:35 INFO - PROCESS | 13146 | 17:10:37 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:41621/tests/dromaeo/cssquery-yui.html (next: http://localhost:41621/tests/dromaeo/cssquery-dojo.html) 17:10:38 INFO - PROCESS | 13146 | RSS: Main: 291840000 17:10:38 INFO - PROCESS | 13146 | 17:10:38 INFO - PROCESS | 13146 | __start_tp_report 17:10:38 INFO - PROCESS | 13146 | _x_x_mozilla_page_load 17:10:38 INFO - PROCESS | 13146 | _x_x_mozilla_page_load_details 17:10:38 INFO - PROCESS | 13146 | |i|pagename|runs| 17:10:38 INFO - PROCESS | 13146 | |0;dojo.html;3082.3989322082193;3129.030000699782;3166.5408515765216;3168.192111011693;3187.665295144009;4917.21324588066;5043.646944713872;5044.06684763319;5072.26452164436;5128.692278463295;5021.522955319248;5074.695518268906;5104.8979020419565;5125.077486052509;5129.589632829374;4633.08907522784;4657.231556793134;4682.508336624656;4758.785854636532;4776.713397196179;4725.740084295362;4741.193997020515;4759.7144171349655;4786.928196077061;4813.037392521493;4621.052684199731;4630.7453090080035;4710.646701497384;4719.834805781781;4747.810087596492;4616.446026476844;4623.445186577598;4623.537646235383;4639.768011599406;4650.395448591661;4644.140833945731;4646.628269738413;4652.55800698933;4656.301554766778;4659.697119687244;4855.295982082614;4927.950720492785;4993.475685053089;5028.396592408898;5076.82231121909;5375.892482150374;5403.324584426947;5409.594280428944;5422.593305502103;5425.674459532401;5351.678899266057;5463.262459567947;5470.835874923759;5471.637274598788;5509.47659972302;5126.692398456067;5155.742212889378;5174.5860331173035;5176.430592634807;5186.714730689773;5553.694546799884;5562.638428502134;5573.665580065209;5581.05122129239;5596.412376700469;5295.443978382292;5353.330833645794;5357.732113394315;5367.516923476827;5384.0847056000575;5423.484768946943;5469.617126801165;5489.533389661923;5500.367457742331;5529.640573362719;5432.75552600134;5452.154915987949;5460.044492213847;5460.890782184413;5465.480779325958;5355.116405793078;5438.374586922555;5462;5466.043442397565;5497.230387745719;4256.553061928453;4272.679549033773;4294.184105020036;4307.56924307573;4330.415393921843;3824.4836947012354;3833.5783063862955;3835.079580900564;3860.478835357247;3874.070223146481;4988.850334489971;5038.420581633086;5072.1123803335;5088.0587091388215;5201.531862132426;5422.864428389322;5470.863228419242;5473.753681084281;5484.61607687458;5488.9725551372785;5005.524475174852;5007.098722230034;5058.280184737207;5071.797128114834;5093.923591146136;4575.771211439414;4654.604358629486;4655;4708.788104535236;4744.312074749142;5683.062294721407;5735.11105778605;5740.770369185186;5751.597388182787;5754.338251101177;5316.3354580677415;5480.835574932758;5495.972520137374;5504.036793561191;5552.500274975271;5589.748461319169;5608.6073974821375;5632.2678051853;5669.744861481161;5682.119271512922;5438.18427235902;5453.836384908459;5455.399906010256;5455.481729235717;5470.53500452466;5406.378266499246;5487.259220005249;5522.0336441121835;5524.8342549723575;5584.86037849057;5318.840434786963;5364.839054828361;5366.436524164907;5366.597505187048;5424.24060631504;5323.813666521653;5354.705491198021;5360.41035486104;5360.892782144258;5410.75651595687;5137.8715532112;5237.8428647140645;5268.604854635841;5290.1800220965815;5291.841244762663;5359.062164121341;5401.378841433286;5404.297441332602;5437.184422336682;5448.809291674773;5276.947230527646;5279.8680032997945;5284.418713941386;5285.68285902847;5294.100002999422 17:10:38 INFO - PROCESS | 13146 | |1;ext.html;517.6143772889201;523.3249108649842;530.5172293213177;545.9027355016416;586.8972929737295;27622;35218.11954701134;35603;35613.465798012985;35645;36953.44569831455;37464.438033429455;37981.81009094958;38263.234735305276;38270;8383.203595658402;8539.530325832076;8607.870881936777;8612.397132200716;8620.568971551429;8314.376421768362;8453;8454.070052294242;8457.196566326189;8460.66157353705;8414.579271036455;8697.739067827975;8703.43427677199;8705.173008564208;8707.912920870773;8541.95729021351;8559.400841941035;8601.053884072748;8627.870581941275;8650.740477785677;8376.246137847562;8459;8478.025027121897;8481.618327175293;8702.347323950666;39785.80107099475;40240.79879600612;40383;40386.19227615461;40395.990100247436;3137.7332926701256;3147.9527807082914;3161.2571045804216;3166.8258245796474;3547.733919956014;29331.413371732448;29615.703842961724;30211.848940755375;30410.54384184239;31039.0688279352;3610.837512311952;3630.16506203572;3637.5453068366455;3677.797721125337;3730.7637133514913;261543;264532;264620;265177;265877;53532.46467535275;53955.73022134864;58692.11961820576;59142.40857591369;60733.392666073654;59558;59704.402955970756;60084;60085.39914600798;60137;14308.141511509342;14451.92774036123;14470.927645361917;14478.927605361905;14480.275986200648;9204.309676774135;9270.536473176315;10884;11046.171537134747;11118.444077796077;19357.90321048414;19431.805681943282;19490.415287541397;19519.512012199808;19536.609267814565;7652.69389224436;7903.209679032051;7943.404244681672;8002.399820013522;8071.677132914618;881.2509367038094;949.2613809160621;989.678354534779;1013.7212266626589;1033.2508931024947;27761.722382775915;28728.569071463946;28967.454600892786;29258.707412926025;29342.706572933996;1016.5019140621042;1026.1688032693542;1068.3963560588243;1090.4820210399996;1122.5229277557005;14988.550343489713;15106.169160696047;15155.393784248507;15287.541373758804;15288.159151246566;309894;313184;313624;313752;314351;50423;51186;51328.743356283725;51363.48636513587;51367;1301.7982212757038;1305.2364366845502;1316.967075823112;1320.5444121778164;1322.385090932721;27491.17526474209;28226.43547129087;28403;28679.42641147207;28812.567811482426;46005.07989840252;46433.446160460146;46440.767796160806;46469.76765116288;46479.30281045719;285854;365659;369077;369474;385979;32195.51706724354;32234.516482252315;32251.838740807085;32486.83756581202;32795.508067378534;42062.36906446467;42149.578504214565;43128.56871431245;43808.561914381724;43968.78015609901;35962.46056309105;35987.280254395286;36227.63772362243;36251.81874090718;37321.2535749278;35698.46452303269;36504.280604706204;36714.4492832613;37509.43735844019;37776.433353500266;35314.82342588373;35697.1075723109;36545;36550.26899462049;36556.63443365532;30702;30832.229194270323;32932;35481.64518354784;35869.461958070126;23690.170844020377;24250;24366.634500482152;24780.752192477845;24835.627465588394 17:10:38 INFO - PROCESS | 13146 | |2;jquery.html;355.253966669993;356.8233724306468;356.9714422846172;358.3603268166322;362.41108199176307;13561.593152205425;13627.252505560975;16377.263023163956;16996;17939.55151121221;13591;13838.308084595781;14136.929315353435;14137.081089729161;14309.212993285391;5240.8689782755355;5434.3207099112615;5435.537979271747;5436.293281873351;5440.510354068133;3981.5819338969427;4141.151064031867;5319.787208511655;5408.810691625794;5724.227229324029;5720.084786434171;5878.559108066891;5922.466977971982;5924.229850119478;5928;5900.940990590104;5924.644521328691;5944.643321400708;5948.40515948406;5951.107333899907;4831.9275210871865;5004.824831130893;5006.424261209971;5217.426083130853;5225.764840582183;19520.51198720029;19656.50858728529;20056.197752089898;20308.593828123354;20321.288754893507;1987.8608497405187;2183.3777373448493;2194.2429861697847;2196.681481185219;2217.5897458970144;8962.551872406353;9100.408473449272;9205.079492050809;9215.585298661576;9268.397554159026;1742.9564260893453;1746.7816522934634;1792.829681180286;1860.265195247883;1924.6824273994773;52807.207891881655;55024.9999999996;56136.71931640356;56692.149617755764;57068.429315707144;9439.622415103457;9574.569144388519;9683.564239609235;9703;9816.950915245521;12668.49326026967;12700.237985720887;12703.237805731686;12727.80908286358;12735.044871634664;6661.933380666228;6813.182418109858;6832.965835170792;6923.688434020381;6983.8603227935155;6640.900386494206;6699.799006029827;6742.258351581322;6756.223034351015;6767.221769496571;4134.793260336971;4232.957670423257;4241.088166044316;4265.594768496988;4324.805383757675;1692.7884014498188;1752.6144248265362;1760.260690509989;1761.6036391811997;1781.09164326192;575.9884802303931;837.7319257837555;908.5366463103733;930.8976012638605;983.9458829764288;15759.448419305269;16560.75158872618;16854.41009564659;16986.405475808286;17129.14354282281;913.1051569461964;919.7102912582515;939.5537119868145;983.955721992512;1021.6015753856002;9560.40623772773;9672.468014259282;9679.419234845931;9687.41875487473;9797;488190;494618;517449;524110;528010;66480;69736;71023.64488177525;71827.28172718205;72023.27976720271;1091.579741799413;1100.7083122972258;1113.3987646670869;1126.7352172239516;1128.7403897103711;14138.575842724735;14684.486042988445;14719.484818031318;15122.319495622503;15263.847361526243;30912.845435772677;31006.379872401976;31393.8430307847;31608.683913160574;32068.67931320657;38180.6181938177;38334.23331533298;38347.2330553393;38655;39040.80479597584;6581.506387021088;6680.6993685283305;6732.932670673231;6757.952517359817;6884.070650462324;7731.072271327476;8214.46605970634;9537.856932145885;9897.604095836374;10180.083792458714;6868.896966545606;8482.575871206538;8665;8912.197902188835;8947.328950328621;8424;8548.615312310836;8724.258438032839;8733.91266087331;9180.862287065833;6867.416269616939;8404.621792019252;8847.69033083839;8869.778255543662;9065.592048357708;6636.303188165173;6791.93208067913;6838.555493892881;6840.623765692934;6996.510244282851;8738.737837864874;8826.338024648048;8827.16141966512;8880.73357799267;8944.552772361487 17:10:38 INFO - PROCESS | 13146 | |3;mootools.html;1346.7373862096895;1478.578605097547;1494.8804095672344;1640.7784949031884;1814.292425953879;6586.473082153429;7260.673269702863;7430.554166749998;7430.814229644248;7433.182349941502;7226.6025368604705;7430.851382972337;7437.405007599393;7438.107427108741;7439.2188820173915;1990.4426760507008;2041.1121162294376;2041.5814757974579;2238.8992495337666;2265.5808675395024;2070.213318938801;2200.064972386729;2271.545690861826;2278.54429114177;2280.4184932842104;2195.82433405328;2225.8887055647233;2238.675392068149;2239.854409463388;2248.7526372099055;2237.4406398400483;2237.530118675072;2237.9104835806547;2244.932652020442;2247.820174386045;2103.347962131744;2136.6154092263387;2139.9251026214165;2142.4965133193687;2150.5053837617434;7545.471816972814;7555.622218889033;7574.242575742437;7600.467967242295;7614.847703045908;4424.867253982386;4550.954490455086;4557.863264102082;4562.726236425825;4578.473475550321;3139.670334614855;3195.456772348683;3211.1008917503136;3256.4464041112833;3276.410246155691;1053.441675911768;1063.31416236527;1077.7359546911057;1086.706589220906;1097.412884107007;10172.643957461454;10288.331258468175;10288.434136122585;10294.948525257401;10296.330738501973;4187.7696726679715;4193.643540299047;4243.851465198703;4256.233877902007;4278.72188307759;8829.072947340564;8855.468671879707;8873.645054197888;8873.778155546033;8906.465612063168;4531.637469002472;4544.295634176708;4557.134144512532;4559.065391594715;4560.315952607136;4129.587041295907;4166.91666166675;4170.103427763045;4172.4993000840095;4173.332266837291;3299.9340013199603;3592.3533763922223;3595.5505561804775;3606.855725770992;3635.8000309983204;1079.9676009719722;1129.7514546799691;1136.0343707848263;1138.9487473063732;1141.19545720267;1204.2593804809978;1204.740980689156;1217.3730528777687;1222.896053835434;1230.2003697596633;6689.665516724144;6773.254941956381;6797.388235058868;6836.350546698056;6974.6512674367095;1074.908632766208;1081.3079629037422;1086.8695756509112;1114.5597488991802;1120.1654767198327;5283.920741188886;5336.8398948030845;5371.462853714597;5374.48942350476;5377.435369286247;8596.527191004554;8723.127687231354;8989.820203595891;9007.279417646572;9084.454932704059;9017.549122543978;9065.093490651014;9092.772680683036;9171.128742769426;9188.035256297993;7055.7177712891935;7174.3184397482155;7184.676689548983;7186.059763863727;7209.243029481829;6749.392554670103;6774.491913106438;6789.558678685869;6791.151106111736;6792.490563207681;7973.521588704696;8085.272325490734;8216.09622941488;8270.793230169294;8273.875891861506;8185.79535511617;8367.958160209404;8381.413301068867;8390.496570205807;8494.74515764528;6347;6365.490760739222;6465.967670161619;6489.3510648934725;6490.123833282447;6319.778807741707;6465.06256592782;7259.419246460165;7262.782116536512;7317.963410182915;5970.432808883149;6407.381684690979;6889.931100688929;6890.069840571458;6918.51570390088;6610.768623098168;6723.125993620798;6724.596524208563;6780.491463140185;6864.622445765531;6642.634655094016;6687.063811066552;6691.732330706717;6761.763338283136;6764.28974957642;6201.410865967726;6228.813135605939;6288.182536270256;6402.519811014286;6403.103565500926;6275.811725648238;6290.654014029273;6345.746170153142;6347.523935704933;6349.777757778455 17:10:38 INFO - PROCESS | 13146 | |4;prototype.html;323.35006636660313;331.58055060348653;333.9465685490322;336.9208236064526;347.4024677554605;5843.561732870031;5926.9407305926925;5953.821385358441;5955.791547295846;5990.4309090636425;5687.573431992607;5833.59164858459;5839.445252700997;5846.795362162326;5851.678157701324;4584.762114229156;4589.5869371756535;4591.908161836761;4591.977040114794;4595.012072404433;4398.34024896265;4490.910181796362;4496.415465989433;4605.125026245003;4605.424321959755;4568.132054909556;4574.748388838612;4581.221192397301;4589.724616523003;4600.769961501928;4572.954270457302;4581.083783243348;4582.702124361906;4583.977080114611;4591.357209990604;4064.309067458539;4070.5115386153557;4072.002359421931;4074.3888416737727;4074.9592504074876;5527.53015993641;5556.055470569972;5604.299462567179;5605.803796867131;5607.299087614048;5327.973360133214;5332.066888294572;5341.759620817073;5346.97326513365;5347.54545863602;5955.583109182359;6231.688415579249;6252.499800016033;6259.655718935457;6261.968690156566;4396.450443694538;4414.205443020255;4499.595036446703;4504.617107545862;4504.909901801946;6538.640374779386;6565.770198043046;6571.80284591463;6576.736930522773;6580.177477815273;4604.37840891482;4604.930926036112;4605.378273932976;4609.838655647103;4610.354550362885;4409.559044095565;4542.818287268538;4547.590716835501;4664.603508701798;4667.463241727177;5261.368635763656;5274.5780337572905;5275.472452754694;5276.709780962084;5276.841694749163;6350.872982540416;6367.968160159169;6370.140031095742;6371.55399122057;6374.298827129012;1593.179512551037;1608.5335252776563;1610.2109966116752;1614.1767698473864;1616.3534586165629;1074.940878251688;1082.9729256768487;1088.8094583447864;1104.7735214281054;1111.1055600241882;6052.364501727343;6054.274531758428;6058.4244496772735;6058.485028772516;6061.272647282266;6504.284528701839;6533.150690410216;6540.705668244846;6540.70566824494;6551.115599394021;5920.31916329619;6035.577509574287;6047.576669633084;6048.939510604926;6052.364501727343;3431.879884204091;3506.7545271830727;3513.841877115536;3514.4376899695926;3514.947275790865;6817.829554261084;6823.93176068233;6825.48808839339;6833.794986150423;6835.213950395669;6672.733090676318;6672.9656903180085;6673.232578253466;6681.599104053772;6694.665266736643;6623.569467984566;6808.659567021728;6816.011678306618;6820.897686534706;6824.0446337512785;6324.557280990287;6388.1376014237485;6478.28738838718;6508.08886755864;6522.21733391996;6490.415862572202;6504.15445992018;6523.739050437929;6527.9020814688765;6559.212894452697;6890.069840571458;6890.586564806128;6899.413549848319;6902.24075351721;6906.8618627626165;4370.191514569815;4471.754053526957;4483.574060464251;4520.819167233274;4541.613962813066;6528.281888992112;6530.967345163243;6531.967340163269;6535.117759102651;6537.5096867736065;6308.053791931247;6358.205224346957;6358.300586935341;6363;6373.681315934277;6155.322914479493;6344.587601805868;6353.8729225416155;6394.552381333262;6396.648184349905;6243.43809057187;6295.370462953668;6303.716332765129;6314.210723659543;6315.684215789101;6451.709673064817;6453.612783232833;6455.870882582416;6458.806235812933;6461.579997300349;6169.907451388322;6292.716827742671;6300.275468321019;6301.96849015752;6310.11658367838 17:10:38 INFO - PROCESS | 13146 | |5;yui.html;725.300085417572;747.798094514481;806.9031716194057;819.3404309530825;836.5984327522791;13563.457461701533;13755.862441375582;13777.035607507465;13791.172529648227;13796.862031379684;12937.676558086052;13075.60773176804;13096.01779866509;13111.803322950163;13124.540641077565;656.9605823650572;665.3845193196298;803.8713805791075;818.5579786915059;819.5574389829485;827;828.0146625515647;831.6714897615468;832.0431503770652;833.7873842170238;694.4166899804163;699.8635266123108;858.4119877883638;858.6865793985213;860.9182127697859;844.2359664503604;855.6235256487188;864.7492227254089;865.5628907401784;867.3538214030556;628.2398298059354;628.4155735166294;629.05013429721;633.8954072578019;634.742929113705;12491.812622810665;12537.498500059986;12538.93419059381;12567.748645027048;12575.993920486431;11758.470868810924;12195.634130975996;12205.755884882341;12274.631761047183;12309.815352769716;10435.478226088666;10515.579376824919;10595.099416549603;10640.94679526605;10721.410322432263;3537.239493508908;3545.804980726059;3567.3935430976794;3658.5975542690285;3659.87190448333;47192.29211561829;47411.28883066757;47436.288455673195;47525.76237118827;47807.80480487981;10207.948960255151;10352.792944141225;10354.1198998086;10408.271421000458;10506.106980906556;18622.720659190123;18644.067796610114;18674.813251867577;18722.531936701693;18757.7186342205;7290.526115802456;7300.6349682515665;7404.444666650023;7464.776056718307;7607.619619019027;4108.931677763743;4188.790560471964;4199.790010499462;4221.6833737469815;4257.723247988933;3096.783225174216;3128.9217769555944;3137.576427182347;3145.2923092304504;3147.59081319427;565.4345654345655;568.7440651706748;573.5554944917723;579.4379451931619;594.8096609085138;518.3002946022914;524.7743470307728;551.8856921649096;577.9739911703983;693.5006795107514;8033.839323213503;8473.618687159093;8555.486670799772;8610.311175105977;8689.087645797226;490.825756856318;512.3518748782793;528.2235114381853;648.3225029843825;657.3163909534031;3759;3862.362710152793;4006.659433948147;4090.570490098556;4130.297849365615;55775;56539.15191272134;56643.43356566464;56680.71659641758;56827.71586142043;47667.523324766305;47984;48366.75816620894;48598;49076.26385604219;43889.78055109704;44603.33095003577;45646;45682;45725.54274457279;8384.706535271236;8521.105283945097;8573.142685731376;8680.131986801269;8953.507557084424;34257.31485370328;34651.30697385988;35700.28599427945;35919.46120808242;36005.27989440144;39979.40030899597;40215.3913843443;40669.79665101656;43352.13295734004;44148.77925610352;11027;11120.388378639253;11207.271527350696;11293.619105205533;11350.313069074564;11050.668479945614;11110.833337500106;11267.211295209585;11965.401729913643;12203.084768642564;10216.335938163995;10751.13990880712;10818.29681070728;10986.121110311316;11007.559697612005;10889.237753357189;11740.471678774305;11762.882371176178;11818.763624727286;12207.145499814927;11011.229213954946;11099.445027748741;11187.776244474902;11392.47464979501;11493.712657183638;9432.528373581155;9507.334486585873;9621.56702948355;9800;10149;9049.366544342096;9172.495512746864;9343.439393636403;9385.533568624405;9906.752331191778 17:10:38 INFO - PROCESS | 13146 | __end_tp_report 17:10:38 INFO - PROCESS | 13146 | __start_cc_report 17:10:38 INFO - PROCESS | 13146 | _x_x_mozilla_cycle_collect,745 17:10:38 INFO - PROCESS | 13146 | __end_cc_report 17:10:38 INFO - PROCESS | 13146 | __startTimestamp1453338638231__endTimestamp 17:10:38 INFO - PROCESS | 13146 | 17:10:38 INFO - PROCESS | 13146 | ------- Summary: start ------- 17:10:38 INFO - PROCESS | 13146 | Number of tests: 6 17:10:38 INFO - PROCESS | 13146 | 17:10:38 INFO - PROCESS | 13146 | [#0] dojo.html Cycles:165 Average:5087.56 Median:5290.18 stddev:541.29 (10.2%) stddev-sans-first:519.59 17:10:38 INFO - PROCESS | 13146 | Values: 3082.4 3129.0 3166.5 3168.2 3187.7 4917.2 5043.6 5044.1 5072.3 5128.7 5021.5 5074.7 5104.9 5125.1 5129.6 4633.1 4657.2 4682.5 4758.8 4776.7 4725.7 4741.2 4759.7 4786.9 4813.0 4621.1 4630.7 4710.6 4719.8 4747.8 4616.4 4623.4 4623.5 4639.8 4650.4 4644.1 4646.6 4652.6 4656.3 4659.7 4855.3 4928.0 4993.5 5028.4 5076.8 5375.9 5403.3 5409.6 5422.6 5425.7 5351.7 5463.3 5470.8 5471.6 5509.5 5126.7 5155.7 5174.6 5176.4 5186.7 5553.7 5562.6 5573.7 5581.1 5596.4 5295.4 5353.3 5357.7 5367.5 5384.1 5423.5 5469.6 5489.5 5500.4 5529.6 5432.8 5452.2 5460.0 5460.9 5465.5 5355.1 5438.4 5462.0 5466.0 5497.2 4256.6 4272.7 4294.2 4307.6 4330.4 3824.5 3833.6 3835.1 3860.5 3874.1 4988.9 5038.4 5072.1 5088.1 5201.5 5422.9 5470.9 5473.8 5484.6 5489.0 5005.5 5007.1 5058.3 5071.8 5093.9 4575.8 4654.6 4655.0 4708.8 4744.3 5683.1 5735.1 5740.8 5751.6 5754.3 5316.3 5480.8 5496.0 5504.0 5552.5 5589.7 5608.6 5632.3 5669.7 5682.1 5438.2 5453.8 5455.4 5455.5 5470.5 5406.4 5487.3 5522.0 5524.8 5584.9 5318.8 5364.8 5366.4 5366.6 5424.2 5323.8 5354.7 5360.4 5360.9 5410.8 5137.9 5237.8 5268.6 5290.2 5291.8 5359.1 5401.4 5404.3 5437.2 5448.8 5276.9 5279.9 5284.4 5285.7 5294.1 17:10:38 INFO - PROCESS | 13146 | 17:10:38 INFO - PROCESS | 13146 | [#1] ext.html Cycles:180 Average:47484.64 Median:20070.91 stddev:82291.65 (410.0%) stddev-sans-first:82446.94 17:10:38 INFO - PROCESS | 13146 | Values: 517.6 523.3 530.5 545.9 586.9 27622.0 35218.1 35603.0 35613.5 35645.0 36953.4 37464.4 37981.8 38263.2 38270.0 8383.2 8539.5 8607.9 8612.4 8620.6 8314.4 8453.0 8454.1 8457.2 8460.7 8414.6 8697.7 8703.4 8705.2 8707.9 8542.0 8559.4 8601.1 8627.9 8650.7 8376.2 8459.0 8478.0 8481.6 8702.3 39785.8 40240.8 40383.0 40386.2 40396.0 3137.7 3148.0 3161.3 3166.8 3547.7 29331.4 29615.7 30211.8 30410.5 31039.1 3610.8 3630.2 3637.5 3677.8 3730.8 261543.0 264532.0 264620.0 265177.0 265877.0 53532.5 53955.7 58692.1 59142.4 60733.4 59558.0 59704.4 60084.0 60085.4 60137.0 14308.1 14451.9 14470.9 14478.9 14480.3 9204.3 9270.5 10884.0 11046.2 11118.4 19357.9 19431.8 19490.4 19519.5 19536.6 7652.7 7903.2 7943.4 8002.4 8071.7 881.3 949.3 989.7 1013.7 1033.3 27761.7 28728.6 28967.5 29258.7 29342.7 1016.5 1026.2 1068.4 1090.5 1122.5 14988.6 15106.2 15155.4 15287.5 15288.2 309894.0 313184.0 313624.0 313752.0 314351.0 50423.0 51186.0 51328.7 51363.5 51367.0 1301.8 1305.2 1317.0 1320.5 1322.4 27491.2 28226.4 28403.0 28679.4 28812.6 46005.1 46433.4 46440.8 46469.8 46479.3 285854.0 365659.0 369077.0 369474.0 385979.0 32195.5 32234.5 32251.8 32486.8 32795.5 42062.4 42149.6 43128.6 43808.6 43968.8 35962.5 35987.3 36227.6 36251.8 37321.3 35698.5 36504.3 36714.4 37509.4 37776.4 35314.8 35697.1 36545.0 36550.3 36556.6 30702.0 30832.2 32932.0 35481.6 35869.5 23690.2 24250.0 24366.6 24780.8 24835.6 17:10:38 INFO - PROCESS | 13146 | 17:10:38 INFO - PROCESS | 13146 | [#2] jquery.html Cycles:180 Average:26095.45 Median:5438.40 stddev:83455.15 (1534.6%) stddev-sans-first:83666.88 17:10:38 INFO - PROCESS | 13146 | Values: 355.3 356.8 357.0 358.4 362.4 13561.6 13627.3 16377.3 16996.0 17939.6 13591.0 13838.3 14136.9 14137.1 14309.2 5240.9 5434.3 5435.5 5436.3 5440.5 3981.6 4141.2 5319.8 5408.8 5724.2 5720.1 5878.6 5922.5 5924.2 5928.0 5900.9 5924.6 5944.6 5948.4 5951.1 4831.9 5004.8 5006.4 5217.4 5225.8 19520.5 19656.5 20056.2 20308.6 20321.3 1987.9 2183.4 2194.2 2196.7 2217.6 8962.6 9100.4 9205.1 9215.6 9268.4 1743.0 1746.8 1792.8 1860.3 1924.7 52807.2 55025.0 56136.7 56692.1 57068.4 9439.6 9574.6 9683.6 9703.0 9817.0 12668.5 12700.2 12703.2 12727.8 12735.0 6661.9 6813.2 6833.0 6923.7 6983.9 6640.9 6699.8 6742.3 6756.2 6767.2 4134.8 4233.0 4241.1 4265.6 4324.8 1692.8 1752.6 1760.3 1761.6 1781.1 576.0 837.7 908.5 930.9 983.9 15759.4 16560.8 16854.4 16986.4 17129.1 913.1 919.7 939.6 984.0 1021.6 9560.4 9672.5 9679.4 9687.4 9797.0 488190.0 494618.0 517449.0 524110.0 528010.0 66480.0 69736.0 71023.6 71827.3 72023.3 1091.6 1100.7 1113.4 1126.7 1128.7 14138.6 14684.5 14719.5 15122.3 15263.8 30912.8 31006.4 31393.8 31608.7 32068.7 38180.6 38334.2 38347.2 38655.0 39040.8 6581.5 6680.7 6732.9 6758.0 6884.1 7731.1 8214.5 9537.9 9897.6 10180.1 6868.9 8482.6 8665.0 8912.2 8947.3 8424.0 8548.6 8724.3 8733.9 9180.9 6867.4 8404.6 8847.7 8869.8 9065.6 6636.3 6791.9 6838.6 6840.6 6996.5 8738.7 8826.3 8827.2 8880.7 8944.6 17:10:38 INFO - PROCESS | 13146 | 17:10:38 INFO - PROCESS | 13146 | [#3] mootools.html Cycles:180 Average:5257.10 Median:6085.92 stddev:2689.53 (44.2%) stddev-sans-first:2681.01 17:10:38 INFO - PROCESS | 13146 | Values: 1346.7 1478.6 1494.9 1640.8 1814.3 6586.5 7260.7 7430.6 7430.8 7433.2 7226.6 7430.9 7437.4 7438.1 7439.2 1990.4 2041.1 2041.6 2238.9 2265.6 2070.2 2200.1 2271.5 2278.5 2280.4 2195.8 2225.9 2238.7 2239.9 2248.8 2237.4 2237.5 2237.9 2244.9 2247.8 2103.3 2136.6 2139.9 2142.5 2150.5 7545.5 7555.6 7574.2 7600.5 7614.8 4424.9 4551.0 4557.9 4562.7 4578.5 3139.7 3195.5 3211.1 3256.4 3276.4 1053.4 1063.3 1077.7 1086.7 1097.4 10172.6 10288.3 10288.4 10294.9 10296.3 4187.8 4193.6 4243.9 4256.2 4278.7 8829.1 8855.5 8873.6 8873.8 8906.5 4531.6 4544.3 4557.1 4559.1 4560.3 4129.6 4166.9 4170.1 4172.5 4173.3 3299.9 3592.4 3595.6 3606.9 3635.8 1080.0 1129.8 1136.0 1138.9 1141.2 1204.3 1204.7 1217.4 1222.9 1230.2 6689.7 6773.3 6797.4 6836.4 6974.7 1074.9 1081.3 1086.9 1114.6 1120.2 5283.9 5336.8 5371.5 5374.5 5377.4 8596.5 8723.1 8989.8 9007.3 9084.5 9017.5 9065.1 9092.8 9171.1 9188.0 7055.7 7174.3 7184.7 7186.1 7209.2 6749.4 6774.5 6789.6 6791.2 6792.5 7973.5 8085.3 8216.1 8270.8 8273.9 8185.8 8368.0 8381.4 8390.5 8494.7 6347.0 6365.5 6466.0 6489.4 6490.1 6319.8 6465.1 7259.4 7262.8 7318.0 5970.4 6407.4 6889.9 6890.1 6918.5 6610.8 6723.1 6724.6 6780.5 6864.6 6642.6 6687.1 6691.7 6761.8 6764.3 6201.4 6228.8 6288.2 6402.5 6403.1 6275.8 6290.7 6345.7 6347.5 6349.8 17:10:38 INFO - PROCESS | 13146 | 17:10:38 INFO - PROCESS | 13146 | [#4] prototype.html Cycles:180 Average:5307.15 Median:5973.11 stddev:1594.24 (26.7%) stddev-sans-first:1554.21 17:10:38 INFO - PROCESS | 13146 | Values: 323.4 331.6 333.9 336.9 347.4 5843.6 5926.9 5953.8 5955.8 5990.4 5687.6 5833.6 5839.4 5846.8 5851.7 4584.8 4589.6 4591.9 4592.0 4595.0 4398.3 4490.9 4496.4 4605.1 4605.4 4568.1 4574.7 4581.2 4589.7 4600.8 4573.0 4581.1 4582.7 4584.0 4591.4 4064.3 4070.5 4072.0 4074.4 4075.0 5527.5 5556.1 5604.3 5605.8 5607.3 5328.0 5332.1 5341.8 5347.0 5347.5 5955.6 6231.7 6252.5 6259.7 6262.0 4396.5 4414.2 4499.6 4504.6 4504.9 6538.6 6565.8 6571.8 6576.7 6580.2 4604.4 4604.9 4605.4 4609.8 4610.4 4409.6 4542.8 4547.6 4664.6 4667.5 5261.4 5274.6 5275.5 5276.7 5276.8 6350.9 6368.0 6370.1 6371.6 6374.3 1593.2 1608.5 1610.2 1614.2 1616.4 1074.9 1083.0 1088.8 1104.8 1111.1 6052.4 6054.3 6058.4 6058.5 6061.3 6504.3 6533.2 6540.7 6540.7 6551.1 5920.3 6035.6 6047.6 6048.9 6052.4 3431.9 3506.8 3513.8 3514.4 3514.9 6817.8 6823.9 6825.5 6833.8 6835.2 6672.7 6673.0 6673.2 6681.6 6694.7 6623.6 6808.7 6816.0 6820.9 6824.0 6324.6 6388.1 6478.3 6508.1 6522.2 6490.4 6504.2 6523.7 6527.9 6559.2 6890.1 6890.6 6899.4 6902.2 6906.9 4370.2 4471.8 4483.6 4520.8 4541.6 6528.3 6531.0 6532.0 6535.1 6537.5 6308.1 6358.2 6358.3 6363.0 6373.7 6155.3 6344.6 6353.9 6394.6 6396.6 6243.4 6295.4 6303.7 6314.2 6315.7 6451.7 6453.6 6455.9 6458.8 6461.6 6169.9 6292.7 6300.3 6302.0 6310.1 17:10:38 INFO - PROCESS | 13146 | 17:10:38 INFO - PROCESS | 13146 | [#5] yui.html Cycles:180 Average:13521.26 Median:44019.28 stddev:15442.27 (35.1%) stddev-sans-first:15455.69 17:10:38 INFO - PROCESS | 13146 | Values: 725.3 747.8 806.9 819.3 836.6 13563.5 13755.9 13777.0 13791.2 13796.9 12937.7 13075.6 13096.0 13111.8 13124.5 657.0 665.4 803.9 818.6 819.6 827.0 828.0 831.7 832.0 833.8 694.4 699.9 858.4 858.7 860.9 844.2 855.6 864.7 865.6 867.4 628.2 628.4 629.1 633.9 634.7 12491.8 12537.5 12538.9 12567.7 12576.0 11758.5 12195.6 12205.8 12274.6 12309.8 10435.5 10515.6 10595.1 10640.9 10721.4 3537.2 3545.8 3567.4 3658.6 3659.9 47192.3 47411.3 47436.3 47525.8 47807.8 10207.9 10352.8 10354.1 10408.3 10506.1 18622.7 18644.1 18674.8 18722.5 18757.7 7290.5 7300.6 7404.4 7464.8 7607.6 4108.9 4188.8 4199.8 4221.7 4257.7 3096.8 3128.9 3137.6 3145.3 3147.6 565.4 568.7 573.6 579.4 594.8 518.3 524.8 551.9 578.0 693.5 8033.8 8473.6 8555.5 8610.3 8689.1 490.8 512.4 528.2 648.3 657.3 3759.0 3862.4 4006.7 4090.6 4130.3 55775.0 56539.2 56643.4 56680.7 56827.7 47667.5 47984.0 48366.8 48598.0 49076.3 43889.8 44603.3 45646.0 45682.0 45725.5 8384.7 8521.1 8573.1 8680.1 8953.5 34257.3 34651.3 35700.3 35919.5 36005.3 39979.4 40215.4 40669.8 43352.1 44148.8 11027.0 11120.4 11207.3 11293.6 11350.3 11050.7 11110.8 11267.2 11965.4 12203.1 10216.3 10751.1 10818.3 10986.1 11007.6 10889.2 11740.5 11762.9 11818.8 12207.1 11011.2 11099.4 11187.8 11392.5 11493.7 9432.5 9507.3 9621.6 9800.0 10149.0 9049.4 9172.5 9343.4 9385.5 9906.8 17:10:38 INFO - PROCESS | 13146 | -------- Summary: end -------- 17:10:38 INFO - PROCESS | 13146 | 17:10:38 INFO - TEST-INFO | 13146: exit 0 17:10:38 INFO - TEST-OK | dromaeo_css | took 1111987ms 17:10:38 INFO - TEST-START | kraken 17:10:38 INFO - operating with platform_type : linux_ 17:10:38 INFO - Initialising browser for kraken test... 17:10:38 INFO - TEST-INFO | started process 13347 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBFiw6w/profile http://localhost:41621/getInfo.html) 17:10:42 INFO - PROCESS | 13347 | __metrics Screen width/height:1600/1200 17:10:42 INFO - PROCESS | 13347 | colorDepth:24 17:10:42 INFO - PROCESS | 13347 | Browser inner width/height: 1024/697 17:10:42 INFO - PROCESS | 13347 | __metrics 17:10:42 INFO - PROCESS | 13347 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:10:42 INFO - PROCESS | 13347 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:10:43 INFO - TEST-INFO | 13347: exit 0 17:10:43 INFO - Browser initialized. 17:10:43 INFO - Running cycle 1/1 for kraken test... 17:10:43 INFO - TEST-INFO | started process 13425 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBFiw6w/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:55 INFO - PROCESS | 13425 | RSS: Main: 149004288 17:10:55 INFO - PROCESS | 13425 | 17:10:58 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41621/tests/kraken/driver.html?testName=audio-beat-detection) 17:10:58 INFO - PROCESS | 13425 | RSS: Main: 184745984 17:10:58 INFO - PROCESS | 13425 | 17:11:01 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41621/tests/kraken/driver.html?testName=audio-dft) 17:11:01 INFO - PROCESS | 13425 | RSS: Main: 175620096 17:11:01 INFO - PROCESS | 13425 | 17:11:04 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41621/tests/kraken/driver.html?testName=audio-fft) 17:11:05 INFO - PROCESS | 13425 | RSS: Main: 165507072 17:11:05 INFO - PROCESS | 13425 | 17:11:07 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41621/tests/kraken/driver.html?testName=audio-oscillator) 17:11:07 INFO - PROCESS | 13425 | RSS: Main: 164687872 17:11:07 INFO - PROCESS | 13425 | 17:11:10 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41621/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:11:10 INFO - PROCESS | 13425 | RSS: Main: 166277120 17:11:10 INFO - PROCESS | 13425 | 17:11:13 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41621/tests/kraken/driver.html?testName=imaging-darkroom) 17:11:14 INFO - PROCESS | 13425 | RSS: Main: 166514688 17:11:14 INFO - PROCESS | 13425 | 17:11:17 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41621/tests/kraken/driver.html?testName=imaging-desaturate) 17:11:18 INFO - PROCESS | 13425 | RSS: Main: 167661568 17:11:18 INFO - PROCESS | 13425 | 17:11:20 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41621/tests/kraken/driver.html?testName=json-parse-financial) 17:11:21 INFO - PROCESS | 13425 | RSS: Main: 168730624 17:11:21 INFO - PROCESS | 13425 | 17:11:22 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41621/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:11:23 INFO - PROCESS | 13425 | RSS: Main: 179875840 17:11:23 INFO - PROCESS | 13425 | 17:11:25 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41621/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:11:25 INFO - PROCESS | 13425 | RSS: Main: 176898048 17:11:25 INFO - PROCESS | 13425 | 17:11:27 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41621/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:11:28 INFO - PROCESS | 13425 | RSS: Main: 187904000 17:11:28 INFO - PROCESS | 13425 | 17:11:30 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41621/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:11:31 INFO - PROCESS | 13425 | RSS: Main: 193859584 17:11:31 INFO - PROCESS | 13425 | 17:11:34 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41621/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:11:34 INFO - PROCESS | 13425 | RSS: Main: 194936832 17:11:34 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:41621/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41621/tests/kraken/driver.html?testName=ai-astar) 17:11:36 INFO - PROCESS | 13425 | RSS: Main: 252080128 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | __start_tp_report 17:11:36 INFO - PROCESS | 13425 | _x_x_mozilla_page_load 17:11:36 INFO - PROCESS | 13425 | _x_x_mozilla_page_load_details 17:11:36 INFO - PROCESS | 13425 | |i|pagename|runs| 17:11:36 INFO - PROCESS | 13425 | |0;ai-astar;112;111;106;110;110;110;111;112;104;110 17:11:36 INFO - PROCESS | 13425 | |1;audio-beat-detection;151;124;152;161;127;154;149;127;183;131 17:11:36 INFO - PROCESS | 13425 | |2;audio-dft;161;160;159;160;159;162;161;159;161;162 17:11:36 INFO - PROCESS | 13425 | |3;audio-fft;72;74;72;140;74;73;75;73;145;73 17:11:36 INFO - PROCESS | 13425 | |4;audio-oscillator;95;96;144;96;96;96;140;96;97;142 17:11:36 INFO - PROCESS | 13425 | |5;imaging-gaussian-blur;109;109;109;109;110;109;109;110;110;110 17:11:36 INFO - PROCESS | 13425 | |6;imaging-darkroom;145;145;145;146;146;146;145;145;145;145 17:11:36 INFO - PROCESS | 13425 | |7;imaging-desaturate;96;96;96;96;97;96;96;95;96;95 17:11:36 INFO - PROCESS | 13425 | |8;json-parse-financial;55;56;56;56;55;56;57;58;65;53 17:11:36 INFO - PROCESS | 13425 | |9;json-stringify-tinderbox;67;67;67;67;69;68;68;68;68;68 17:11:36 INFO - PROCESS | 13425 | |10;stanford-crypto-aes;81;82;84;82;90;82;81;82;85;84 17:11:36 INFO - PROCESS | 13425 | |11;stanford-crypto-ccm;119;118;118;116;114;117;114;115;117;123 17:11:36 INFO - PROCESS | 13425 | |12;stanford-crypto-pbkdf2;151;138;150;153;155;141;150;150;151;154 17:11:36 INFO - PROCESS | 13425 | |13;stanford-crypto-sha256-iterative;69;67;70;67;67;68;65;67;67;68 17:11:36 INFO - PROCESS | 13425 | __end_tp_report 17:11:36 INFO - PROCESS | 13425 | __start_cc_report 17:11:36 INFO - PROCESS | 13425 | _x_x_mozilla_cycle_collect,955 17:11:36 INFO - PROCESS | 13425 | __end_cc_report 17:11:36 INFO - PROCESS | 13425 | __startTimestamp1453338696537__endTimestamp 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | ------- Summary: start ------- 17:11:36 INFO - PROCESS | 13425 | Number of tests: 14 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.59 (2.3%) stddev-sans-first:2.60 17:11:36 INFO - PROCESS | 13425 | Values: 112.0 111.0 106.0 110.0 110.0 110.0 111.0 112.0 104.0 110.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:151.50 stddev:18.73 (12.4%) stddev-sans-first:19.78 17:11:36 INFO - PROCESS | 13425 | Values: 151.0 124.0 152.0 161.0 127.0 154.0 149.0 127.0 183.0 131.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 17:11:36 INFO - PROCESS | 13425 | Values: 161.0 160.0 159.0 160.0 159.0 162.0 161.0 159.0 161.0 162.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#3] audio-fft Cycles:10 Average:87.10 Median:73.00 stddev:29.24 (40.0%) stddev-sans-first:30.49 17:11:36 INFO - PROCESS | 13425 | Values: 72.0 74.0 72.0 140.0 74.0 73.0 75.0 73.0 145.0 73.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:96.00 stddev:22.25 (23.2%) stddev-sans-first:22.94 17:11:36 INFO - PROCESS | 13425 | Values: 95.0 96.0 144.0 96.0 96.0 96.0 140.0 96.0 97.0 142.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:11:36 INFO - PROCESS | 13425 | Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 110.0 110.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:11:36 INFO - PROCESS | 13425 | Values: 145.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:11:36 INFO - PROCESS | 13425 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 95.0 96.0 95.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:3.20 (5.7%) stddev-sans-first:3.33 17:11:36 INFO - PROCESS | 13425 | Values: 55.0 56.0 56.0 56.0 55.0 56.0 57.0 58.0 65.0 53.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 17:11:36 INFO - PROCESS | 13425 | Values: 67.0 67.0 67.0 67.0 69.0 68.0 68.0 68.0 68.0 68.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:2.71 (3.3%) stddev-sans-first:2.74 17:11:36 INFO - PROCESS | 13425 | Values: 81.0 82.0 84.0 82.0 90.0 82.0 81.0 82.0 85.0 84.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:117.50 stddev:2.69 (2.3%) stddev-sans-first:2.76 17:11:36 INFO - PROCESS | 13425 | Values: 119.0 118.0 118.0 116.0 114.0 117.0 114.0 115.0 117.0 123.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:151.00 stddev:5.50 (3.6%) stddev-sans-first:5.80 17:11:36 INFO - PROCESS | 13425 | Values: 151.0 138.0 150.0 153.0 155.0 141.0 150.0 150.0 151.0 154.0 17:11:36 INFO - PROCESS | 13425 | 17:11:36 INFO - PROCESS | 13425 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.35 (2.0%) stddev-sans-first:1.32 17:11:36 INFO - PROCESS | 13425 | Values: 69.0 67.0 70.0 67.0 67.0 68.0 65.0 67.0 67.0 68.0 17:11:36 INFO - PROCESS | 13425 | -------- Summary: end -------- 17:11:36 INFO - PROCESS | 13425 | 17:11:37 INFO - TEST-INFO | 13425: exit 0 17:11:37 INFO - TEST-OK | kraken | took 58439ms 17:11:37 INFO - TEST-START | v8_7 17:11:37 INFO - operating with platform_type : linux_ 17:11:37 INFO - Initialising browser for v8_7 test... 17:11:37 INFO - TEST-INFO | started process 13675 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps6QbdH/profile http://localhost:41621/getInfo.html) 17:11:41 INFO - PROCESS | 13675 | __metrics Screen width/height:1600/1200 17:11:41 INFO - PROCESS | 13675 | colorDepth:24 17:11:41 INFO - PROCESS | 13675 | Browser inner width/height: 1024/697 17:11:41 INFO - PROCESS | 13675 | __metrics 17:11:41 INFO - PROCESS | 13675 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:11:41 INFO - PROCESS | 13675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:11:42 INFO - TEST-INFO | 13675: exit 0 17:11:42 INFO - Browser initialized. 17:11:42 INFO - Running cycle 1/1 for v8_7 test... 17:11:42 INFO - TEST-INFO | started process 13759 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps6QbdH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:54 INFO - PROCESS | 13759 | RSS: Main: 149426176 17:11:54 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | Cycle 1(1): loaded http://localhost:41621/tests/v8_7/run.html (next: http://localhost:41621/tests/v8_7/run.html) 17:12:16 INFO - PROCESS | 13759 | RSS: Main: 589570048 17:12:16 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | __start_tp_report 17:12:16 INFO - PROCESS | 13759 | _x_x_mozilla_page_load 17:12:16 INFO - PROCESS | 13759 | _x_x_mozilla_page_load_details 17:12:16 INFO - PROCESS | 13759 | |i|pagename|runs| 17:12:16 INFO - PROCESS | 13759 | |0;Richards;167.42005692281936 17:12:16 INFO - PROCESS | 13759 | |1;DeltaBlue;188.11136192626034 17:12:16 INFO - PROCESS | 13759 | |2;Encrypt;282.88543140028287 17:12:16 INFO - PROCESS | 13759 | |3;Decrypt;5329.787234042553 17:12:16 INFO - PROCESS | 13759 | |4;RayTrace;1998.0039920159682 17:12:16 INFO - PROCESS | 13759 | |5;Earley;774.5933384972889 17:12:16 INFO - PROCESS | 13759 | |6;Boyer;12280.487804878048 17:12:16 INFO - PROCESS | 13759 | |7;RegExp;43041.666666666664 17:12:16 INFO - PROCESS | 13759 | |8;Splay;641.4368184733804 17:12:16 INFO - PROCESS | 13759 | |9;NavierStokes;4840.579710144928 17:12:16 INFO - PROCESS | 13759 | __end_tp_report 17:12:16 INFO - PROCESS | 13759 | __startTimestamp1453338736795__endTimestamp 17:12:16 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | ------- Summary: start ------- 17:12:16 INFO - PROCESS | 13759 | Number of tests: 10 17:12:16 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | [#0] Richards Cycles:1 Average:167.42 Median:167.42 stddev:0.00 (0.0%) 17:12:16 INFO - PROCESS | 13759 | Values: 167.4 17:12:16 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | [#1] DeltaBlue Cycles:1 Average:188.11 Median:188.11 stddev:0.00 (0.0%) 17:12:16 INFO - PROCESS | 13759 | Values: 188.1 17:12:16 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | [#2] Encrypt Cycles:1 Average:282.89 Median:282.89 stddev:0.00 (0.0%) 17:12:16 INFO - PROCESS | 13759 | Values: 282.9 17:12:16 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | [#3] Decrypt Cycles:1 Average:5329.79 Median:5329.79 stddev:0.00 (0.0%) 17:12:16 INFO - PROCESS | 13759 | Values: 5329.8 17:12:16 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | [#4] RayTrace Cycles:1 Average:1998.00 Median:1998.00 stddev:0.00 (0.0%) 17:12:16 INFO - PROCESS | 13759 | Values: 1998.0 17:12:16 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | [#5] Earley Cycles:1 Average:774.59 Median:774.59 stddev:0.00 (0.0%) 17:12:16 INFO - PROCESS | 13759 | Values: 774.6 17:12:16 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 17:12:16 INFO - PROCESS | 13759 | Values: 12280.5 17:12:16 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | [#7] RegExp Cycles:1 Average:43041.67 Median:43041.67 stddev:0.00 (0.0%) 17:12:16 INFO - PROCESS | 13759 | Values: 43041.7 17:12:16 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | [#8] Splay Cycles:1 Average:641.44 Median:641.44 stddev:0.00 (0.0%) 17:12:16 INFO - PROCESS | 13759 | Values: 641.4 17:12:16 INFO - PROCESS | 13759 | 17:12:16 INFO - PROCESS | 13759 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 17:12:16 INFO - PROCESS | 13759 | Values: 4840.6 17:12:16 INFO - PROCESS | 13759 | -------- Summary: end -------- 17:12:16 INFO - PROCESS | 13759 | 17:12:17 INFO - TEST-INFO | 13759: exit 0 17:12:17 INFO - TEST-OK | v8_7 | took 40208ms 17:12:17 INFO - SUITE-END | took 1210s 17:12:17 INFO - Completed test suite (00:20:10) 17:12:17 INFO - Working with test: dromaeo_css 17:12:17 INFO - Generating results file: dromaeo_css 17:12:17 INFO - Working with test: kraken 17:12:17 INFO - Generating results file: kraken 17:12:17 INFO - javascript benchmark 17:12:17 INFO - Working with test: v8_7 17:12:17 INFO - Generating results file: v8_7 17:12:17 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:12:17 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 17:12:17 INFO - process_Request line: dromaeo_css 6726.90 graph.html#tests=[[72,201,35]] 17:12:17 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:12:17 INFO - process_Request line: kraken 1505.00 graph.html#tests=[[232,201,35]] 17:12:17 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:12:17 INFO - process_Request line: v8_7 18705.16 graph.html#tests=[[230,201,35]] 17:12:17 INFO - RETURN: dromaeo_css: 6726.90 17:12:17 INFO - RETURN: kraken: 1505.00 17:12:17 INFO - RETURN: v8_7: 18705.16 17:12:17 INFO - javascript benchmark 17:12:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3082.3989322082193, 3129.030000699782, 3166.5408515765216, 3168.192111011693, 3187.665295144009, 4917.21324588066, 5043.646944713872, 5044.06684763319, 5072.26452164436, 5128.692278463295, 5021.522955319248, 5074.695518268906, 5104.8979020419565, 5125.077486052509, 5129.589632829374, 4633.08907522784, 4657.231556793134, 4682.508336624656, 4758.785854636532, 4776.713397196179, 4725.740084295362, 4741.193997020515, 4759.7144171349655, 4786.928196077061, 4813.037392521493, 4621.052684199731, 4630.7453090080035, 4710.646701497384, 4719.834805781781, 4747.810087596492, 4616.446026476844, 4623.445186577598, 4623.537646235383, 4639.768011599406, 4650.395448591661, 4644.140833945731, 4646.628269738413, 4652.55800698933, 4656.301554766778, 4659.697119687244, 4855.295982082614, 4927.950720492785, 4993.475685053089, 5028.396592408898, 5076.82231121909, 5375.892482150374, 5403.324584426947, 5409.594280428944, 5422.593305502103, 5425.674459532401, 5351.678899266057, 5463.262459567947, 5470.835874923759, 5471.637274598788, 5509.47659972302, 5126.692398456067, 5155.742212889378, 5174.5860331173035, 5176.430592634807, 5186.714730689773, 5553.694546799884, 5562.638428502134, 5573.665580065209, 5581.05122129239, 5596.412376700469, 5295.443978382292, 5353.330833645794, 5357.732113394315, 5367.516923476827, 5384.0847056000575, 5423.484768946943, 5469.617126801165, 5489.533389661923, 5500.367457742331, 5529.640573362719, 5432.75552600134, 5452.154915987949, 5460.044492213847, 5460.890782184413, 5465.480779325958, 5355.116405793078, 5438.374586922555, 5462.0, 5466.043442397565, 5497.230387745719, 4256.553061928453, 4272.679549033773, 4294.184105020036, 4307.56924307573, 4330.415393921843, 3824.4836947012354, 3833.5783063862955, 3835.079580900564, 3860.478835357247, 3874.070223146481, 4988.850334489971, 5038.420581633086, 5072.1123803335, 5088.0587091388215, 5201.531862132426, 5422.864428389322, 5470.863228419242, 5473.753681084281, 5484.61607687458, 5488.9725551372785, 5005.524475174852, 5007.098722230034, 5058.280184737207, 5071.797128114834, 5093.923591146136, 4575.771211439414, 4654.604358629486, 4655.0, 4708.788104535236, 4744.312074749142, 5683.062294721407, 5735.11105778605, 5740.770369185186, 5751.597388182787, 5754.338251101177, 5316.3354580677415, 5480.835574932758, 5495.972520137374, 5504.036793561191, 5552.500274975271, 5589.748461319169, 5608.6073974821375, 5632.2678051853, 5669.744861481161, 5682.119271512922, 5438.18427235902, 5453.836384908459, 5455.399906010256, 5455.481729235717, 5470.53500452466, 5406.378266499246, 5487.259220005249, 5522.0336441121835, 5524.8342549723575, 5584.86037849057, 5318.840434786963, 5364.839054828361, 5366.436524164907, 5366.597505187048, 5424.24060631504, 5323.813666521653, 5354.705491198021, 5360.41035486104, 5360.892782144258, 5410.75651595687, 5137.8715532112, 5237.8428647140645, 5268.604854635841, 5290.1800220965815, 5291.841244762663, 5359.062164121341, 5401.378841433286, 5404.297441332602, 5437.184422336682, 5448.809291674773, 5276.947230527646, 5279.8680032997945, 5284.418713941386, 5285.68285902847, 5294.100002999422], "unit": "score", "name": "dojo.html", "value": 5054.295300683377}, {"lowerIsBetter": false, "replicates": [517.6143772889201, 523.3249108649842, 530.5172293213177, 545.9027355016416, 586.8972929737295, 27622.0, 35218.11954701134, 35603.0, 35613.465798012985, 35645.0, 36953.44569831455, 37464.438033429455, 37981.81009094958, 38263.234735305276, 38270.0, 8383.203595658402, 8539.530325832076, 8607.870881936777, 8612.397132200716, 8620.568971551429, 8314.376421768362, 8453.0, 8454.070052294242, 8457.196566326189, 8460.66157353705, 8414.579271036455, 8697.739067827975, 8703.43427677199, 8705.173008564208, 8707.912920870773, 8541.95729021351, 8559.400841941035, 8601.053884072748, 8627.870581941275, 8650.740477785677, 8376.246137847562, 8459.0, 8478.025027121897, 8481.618327175293, 8702.347323950666, 39785.80107099475, 40240.79879600612, 40383.0, 40386.19227615461, 40395.990100247436, 3137.7332926701256, 3147.9527807082914, 3161.2571045804216, 3166.8258245796474, 3547.733919956014, 29331.413371732448, 29615.703842961724, 30211.848940755375, 30410.54384184239, 31039.0688279352, 3610.837512311952, 3630.16506203572, 3637.5453068366455, 3677.797721125337, 3730.7637133514913, 261543.0, 264532.0, 264620.0, 265177.0, 265877.0, 53532.46467535275, 53955.73022134864, 58692.11961820576, 59142.40857591369, 60733.392666073654, 59558.0, 59704.402955970756, 60084.0, 60085.39914600798, 60137.0, 14308.141511509342, 14451.92774036123, 14470.927645361917, 14478.927605361905, 14480.275986200648, 9204.309676774135, 9270.536473176315, 10884.0, 11046.171537134747, 11118.444077796077, 19357.90321048414, 19431.805681943282, 19490.415287541397, 19519.512012199808, 19536.609267814565, 7652.69389224436, 7903.209679032051, 7943.404244681672, 8002.399820013522, 8071.677132914618, 881.2509367038094, 949.2613809160621, 989.678354534779, 1013.7212266626589, 1033.2508931024947, 27761.722382775915, 28728.569071463946, 28967.454600892786, 29258.707412926025, 29342.706572933996, 1016.5019140621042, 1026.1688032693542, 1068.3963560588243, 1090.4820210399996, 1122.5229277557005, 14988.550343489713, 15106.169160696047, 15155.393784248507, 15287.541373758804, 15288.159151246566, 309894.0, 313184.0, 313624.0, 313752.0, 314351.0, 50423.0, 51186.0, 51328.743356283725, 51363.48636513587, 51367.0, 1301.7982212757038, 1305.2364366845502, 1316.967075823112, 1320.5444121778164, 1322.385090932721, 27491.17526474209, 28226.43547129087, 28403.0, 28679.42641147207, 28812.567811482426, 46005.07989840252, 46433.446160460146, 46440.767796160806, 46469.76765116288, 46479.30281045719, 285854.0, 365659.0, 369077.0, 369474.0, 385979.0, 32195.51706724354, 32234.516482252315, 32251.838740807085, 32486.83756581202, 32795.508067378534, 42062.36906446467, 42149.578504214565, 43128.56871431245, 43808.561914381724, 43968.78015609901, 35962.46056309105, 35987.280254395286, 36227.63772362243, 36251.81874090718, 37321.2535749278, 35698.46452303269, 36504.280604706204, 36714.4492832613, 37509.43735844019, 37776.433353500266, 35314.82342588373, 35697.1075723109, 36545.0, 36550.26899462049, 36556.63443365532, 30702.0, 30832.229194270323, 32932.0, 35481.64518354784, 35869.461958070126, 23690.170844020377, 24250.0, 24366.634500482152, 24780.752192477845, 24835.627465588394], "unit": "score", "name": "ext.html", "value": 18196.091711663285}, {"lowerIsBetter": false, "replicates": [355.253966669993, 356.8233724306468, 356.9714422846172, 358.3603268166322, 362.41108199176307, 13561.593152205425, 13627.252505560975, 16377.263023163956, 16996.0, 17939.55151121221, 13591.0, 13838.308084595781, 14136.929315353435, 14137.081089729161, 14309.212993285391, 5240.8689782755355, 5434.3207099112615, 5435.537979271747, 5436.293281873351, 5440.510354068133, 3981.5819338969427, 4141.151064031867, 5319.787208511655, 5408.810691625794, 5724.227229324029, 5720.084786434171, 5878.559108066891, 5922.466977971982, 5924.229850119478, 5928.0, 5900.940990590104, 5924.644521328691, 5944.643321400708, 5948.40515948406, 5951.107333899907, 4831.9275210871865, 5004.824831130893, 5006.424261209971, 5217.426083130853, 5225.764840582183, 19520.51198720029, 19656.50858728529, 20056.197752089898, 20308.593828123354, 20321.288754893507, 1987.8608497405187, 2183.3777373448493, 2194.2429861697847, 2196.681481185219, 2217.5897458970144, 8962.551872406353, 9100.408473449272, 9205.079492050809, 9215.585298661576, 9268.397554159026, 1742.9564260893453, 1746.7816522934634, 1792.829681180286, 1860.265195247883, 1924.6824273994773, 52807.207891881655, 55024.9999999996, 56136.71931640356, 56692.149617755764, 57068.429315707144, 9439.622415103457, 9574.569144388519, 9683.564239609235, 9703.0, 9816.950915245521, 12668.49326026967, 12700.237985720887, 12703.237805731686, 12727.80908286358, 12735.044871634664, 6661.933380666228, 6813.182418109858, 6832.965835170792, 6923.688434020381, 6983.8603227935155, 6640.900386494206, 6699.799006029827, 6742.258351581322, 6756.223034351015, 6767.221769496571, 4134.793260336971, 4232.957670423257, 4241.088166044316, 4265.594768496988, 4324.805383757675, 1692.7884014498188, 1752.6144248265362, 1760.260690509989, 1761.6036391811997, 1781.09164326192, 575.9884802303931, 837.7319257837555, 908.5366463103733, 930.8976012638605, 983.9458829764288, 15759.448419305269, 16560.75158872618, 16854.41009564659, 16986.405475808286, 17129.14354282281, 913.1051569461964, 919.7102912582515, 939.5537119868145, 983.955721992512, 1021.6015753856002, 9560.40623772773, 9672.468014259282, 9679.419234845931, 9687.41875487473, 9797.0, 488190.0, 494618.0, 517449.0, 524110.0, 528010.0, 66480.0, 69736.0, 71023.64488177525, 71827.28172718205, 72023.27976720271, 1091.579741799413, 1100.7083122972258, 1113.3987646670869, 1126.7352172239516, 1128.7403897103711, 14138.575842724735, 14684.486042988445, 14719.484818031318, 15122.319495622503, 15263.847361526243, 30912.845435772677, 31006.379872401976, 31393.8430307847, 31608.683913160574, 32068.67931320657, 38180.6181938177, 38334.23331533298, 38347.2330553393, 38655.0, 39040.80479597584, 6581.506387021088, 6680.6993685283305, 6732.932670673231, 6757.952517359817, 6884.070650462324, 7731.072271327476, 8214.46605970634, 9537.856932145885, 9897.604095836374, 10180.083792458714, 6868.896966545606, 8482.575871206538, 8665.0, 8912.197902188835, 8947.328950328621, 8424.0, 8548.615312310836, 8724.258438032839, 8733.91266087331, 9180.862287065833, 6867.416269616939, 8404.621792019252, 8847.69033083839, 8869.778255543662, 9065.592048357708, 6636.303188165173, 6791.93208067913, 6838.555493892881, 6840.623765692934, 6996.510244282851, 8738.737837864874, 8826.338024648048, 8827.16141966512, 8880.73357799267, 8944.552772361487], "unit": "score", "name": "jquery.html", "value": 7799.156005877002}, {"lowerIsBetter": false, "replicates": [1346.7373862096895, 1478.578605097547, 1494.8804095672344, 1640.7784949031884, 1814.292425953879, 6586.473082153429, 7260.673269702863, 7430.554166749998, 7430.814229644248, 7433.182349941502, 7226.6025368604705, 7430.851382972337, 7437.405007599393, 7438.107427108741, 7439.2188820173915, 1990.4426760507008, 2041.1121162294376, 2041.5814757974579, 2238.8992495337666, 2265.5808675395024, 2070.213318938801, 2200.064972386729, 2271.545690861826, 2278.54429114177, 2280.4184932842104, 2195.82433405328, 2225.8887055647233, 2238.675392068149, 2239.854409463388, 2248.7526372099055, 2237.4406398400483, 2237.530118675072, 2237.9104835806547, 2244.932652020442, 2247.820174386045, 2103.347962131744, 2136.6154092263387, 2139.9251026214165, 2142.4965133193687, 2150.5053837617434, 7545.471816972814, 7555.622218889033, 7574.242575742437, 7600.467967242295, 7614.847703045908, 4424.867253982386, 4550.954490455086, 4557.863264102082, 4562.726236425825, 4578.473475550321, 3139.670334614855, 3195.456772348683, 3211.1008917503136, 3256.4464041112833, 3276.410246155691, 1053.441675911768, 1063.31416236527, 1077.7359546911057, 1086.706589220906, 1097.412884107007, 10172.643957461454, 10288.331258468175, 10288.434136122585, 10294.948525257401, 10296.330738501973, 4187.7696726679715, 4193.643540299047, 4243.851465198703, 4256.233877902007, 4278.72188307759, 8829.072947340564, 8855.468671879707, 8873.645054197888, 8873.778155546033, 8906.465612063168, 4531.637469002472, 4544.295634176708, 4557.134144512532, 4559.065391594715, 4560.315952607136, 4129.587041295907, 4166.91666166675, 4170.103427763045, 4172.4993000840095, 4173.332266837291, 3299.9340013199603, 3592.3533763922223, 3595.5505561804775, 3606.855725770992, 3635.8000309983204, 1079.9676009719722, 1129.7514546799691, 1136.0343707848263, 1138.9487473063732, 1141.19545720267, 1204.2593804809978, 1204.740980689156, 1217.3730528777687, 1222.896053835434, 1230.2003697596633, 6689.665516724144, 6773.254941956381, 6797.388235058868, 6836.350546698056, 6974.6512674367095, 1074.908632766208, 1081.3079629037422, 1086.8695756509112, 1114.5597488991802, 1120.1654767198327, 5283.920741188886, 5336.8398948030845, 5371.462853714597, 5374.48942350476, 5377.435369286247, 8596.527191004554, 8723.127687231354, 8989.820203595891, 9007.279417646572, 9084.454932704059, 9017.549122543978, 9065.093490651014, 9092.772680683036, 9171.128742769426, 9188.035256297993, 7055.7177712891935, 7174.3184397482155, 7184.676689548983, 7186.059763863727, 7209.243029481829, 6749.392554670103, 6774.491913106438, 6789.558678685869, 6791.151106111736, 6792.490563207681, 7973.521588704696, 8085.272325490734, 8216.09622941488, 8270.793230169294, 8273.875891861506, 8185.79535511617, 8367.958160209404, 8381.413301068867, 8390.496570205807, 8494.74515764528, 6347.0, 6365.490760739222, 6465.967670161619, 6489.3510648934725, 6490.123833282447, 6319.778807741707, 6465.06256592782, 7259.419246460165, 7262.782116536512, 7317.963410182915, 5970.432808883149, 6407.381684690979, 6889.931100688929, 6890.069840571458, 6918.51570390088, 6610.768623098168, 6723.125993620798, 6724.596524208563, 6780.491463140185, 6864.622445765531, 6642.634655094016, 6687.063811066552, 6691.732330706717, 6761.763338283136, 6764.28974957642, 6201.410865967726, 6228.813135605939, 6288.182536270256, 6402.519811014286, 6403.103565500926, 6275.811725648238, 6290.654014029273, 6345.746170153142, 6347.523935704933, 6349.777757778455], "unit": "score", "name": "mootools.html", "value": 4353.929806821812}, {"lowerIsBetter": false, "replicates": [323.35006636660313, 331.58055060348653, 333.9465685490322, 336.9208236064526, 347.4024677554605, 5843.561732870031, 5926.9407305926925, 5953.821385358441, 5955.791547295846, 5990.4309090636425, 5687.573431992607, 5833.59164858459, 5839.445252700997, 5846.795362162326, 5851.678157701324, 4584.762114229156, 4589.5869371756535, 4591.908161836761, 4591.977040114794, 4595.012072404433, 4398.34024896265, 4490.910181796362, 4496.415465989433, 4605.125026245003, 4605.424321959755, 4568.132054909556, 4574.748388838612, 4581.221192397301, 4589.724616523003, 4600.769961501928, 4572.954270457302, 4581.083783243348, 4582.702124361906, 4583.977080114611, 4591.357209990604, 4064.309067458539, 4070.5115386153557, 4072.002359421931, 4074.3888416737727, 4074.9592504074876, 5527.53015993641, 5556.055470569972, 5604.299462567179, 5605.803796867131, 5607.299087614048, 5327.973360133214, 5332.066888294572, 5341.759620817073, 5346.97326513365, 5347.54545863602, 5955.583109182359, 6231.688415579249, 6252.499800016033, 6259.655718935457, 6261.968690156566, 4396.450443694538, 4414.205443020255, 4499.595036446703, 4504.617107545862, 4504.909901801946, 6538.640374779386, 6565.770198043046, 6571.80284591463, 6576.736930522773, 6580.177477815273, 4604.37840891482, 4604.930926036112, 4605.378273932976, 4609.838655647103, 4610.354550362885, 4409.559044095565, 4542.818287268538, 4547.590716835501, 4664.603508701798, 4667.463241727177, 5261.368635763656, 5274.5780337572905, 5275.472452754694, 5276.709780962084, 5276.841694749163, 6350.872982540416, 6367.968160159169, 6370.140031095742, 6371.55399122057, 6374.298827129012, 1593.179512551037, 1608.5335252776563, 1610.2109966116752, 1614.1767698473864, 1616.3534586165629, 1074.940878251688, 1082.9729256768487, 1088.8094583447864, 1104.7735214281054, 1111.1055600241882, 6052.364501727343, 6054.274531758428, 6058.4244496772735, 6058.485028772516, 6061.272647282266, 6504.284528701839, 6533.150690410216, 6540.705668244846, 6540.70566824494, 6551.115599394021, 5920.31916329619, 6035.577509574287, 6047.576669633084, 6048.939510604926, 6052.364501727343, 3431.879884204091, 3506.7545271830727, 3513.841877115536, 3514.4376899695926, 3514.947275790865, 6817.829554261084, 6823.93176068233, 6825.48808839339, 6833.794986150423, 6835.213950395669, 6672.733090676318, 6672.9656903180085, 6673.232578253466, 6681.599104053772, 6694.665266736643, 6623.569467984566, 6808.659567021728, 6816.011678306618, 6820.897686534706, 6824.0446337512785, 6324.557280990287, 6388.1376014237485, 6478.28738838718, 6508.08886755864, 6522.21733391996, 6490.415862572202, 6504.15445992018, 6523.739050437929, 6527.9020814688765, 6559.212894452697, 6890.069840571458, 6890.586564806128, 6899.413549848319, 6902.24075351721, 6906.8618627626165, 4370.191514569815, 4471.754053526957, 4483.574060464251, 4520.819167233274, 4541.613962813066, 6528.281888992112, 6530.967345163243, 6531.967340163269, 6535.117759102651, 6537.5096867736065, 6308.053791931247, 6358.205224346957, 6358.300586935341, 6363.0, 6373.681315934277, 6155.322914479493, 6344.587601805868, 6353.8729225416155, 6394.552381333262, 6396.648184349905, 6243.43809057187, 6295.370462953668, 6303.716332765129, 6314.210723659543, 6315.684215789101, 6451.709673064817, 6453.612783232833, 6455.870882582416, 6458.806235812933, 6461.579997300349, 6169.907451388322, 6292.716827742671, 6300.275468321019, 6301.96849015752, 6310.11658367838], "unit": "score", "name": "prototype.html", "value": 4789.149838785103}, {"lowerIsBetter": false, "replicates": [725.300085417572, 747.798094514481, 806.9031716194057, 819.3404309530825, 836.5984327522791, 13563.457461701533, 13755.862441375582, 13777.035607507465, 13791.172529648227, 13796.862031379684, 12937.676558086052, 13075.60773176804, 13096.01779866509, 13111.803322950163, 13124.540641077565, 656.9605823650572, 665.3845193196298, 803.8713805791075, 818.5579786915059, 819.5574389829485, 827.0, 828.0146625515647, 831.6714897615468, 832.0431503770652, 833.7873842170238, 694.4166899804163, 699.8635266123108, 858.4119877883638, 858.6865793985213, 860.9182127697859, 844.2359664503604, 855.6235256487188, 864.7492227254089, 865.5628907401784, 867.3538214030556, 628.2398298059354, 628.4155735166294, 629.05013429721, 633.8954072578019, 634.742929113705, 12491.812622810665, 12537.498500059986, 12538.93419059381, 12567.748645027048, 12575.993920486431, 11758.470868810924, 12195.634130975996, 12205.755884882341, 12274.631761047183, 12309.815352769716, 10435.478226088666, 10515.579376824919, 10595.099416549603, 10640.94679526605, 10721.410322432263, 3537.239493508908, 3545.804980726059, 3567.3935430976794, 3658.5975542690285, 3659.87190448333, 47192.29211561829, 47411.28883066757, 47436.288455673195, 47525.76237118827, 47807.80480487981, 10207.948960255151, 10352.792944141225, 10354.1198998086, 10408.271421000458, 10506.106980906556, 18622.720659190123, 18644.067796610114, 18674.813251867577, 18722.531936701693, 18757.7186342205, 7290.526115802456, 7300.6349682515665, 7404.444666650023, 7464.776056718307, 7607.619619019027, 4108.931677763743, 4188.790560471964, 4199.790010499462, 4221.6833737469815, 4257.723247988933, 3096.783225174216, 3128.9217769555944, 3137.576427182347, 3145.2923092304504, 3147.59081319427, 565.4345654345655, 568.7440651706748, 573.5554944917723, 579.4379451931619, 594.8096609085138, 518.3002946022914, 524.7743470307728, 551.8856921649096, 577.9739911703983, 693.5006795107514, 8033.839323213503, 8473.618687159093, 8555.486670799772, 8610.311175105977, 8689.087645797226, 490.825756856318, 512.3518748782793, 528.2235114381853, 648.3225029843825, 657.3163909534031, 3759.0, 3862.362710152793, 4006.659433948147, 4090.570490098556, 4130.297849365615, 55775.0, 56539.15191272134, 56643.43356566464, 56680.71659641758, 56827.71586142043, 47667.523324766305, 47984.0, 48366.75816620894, 48598.0, 49076.26385604219, 43889.78055109704, 44603.33095003577, 45646.0, 45682.0, 45725.54274457279, 8384.706535271236, 8521.105283945097, 8573.142685731376, 8680.131986801269, 8953.507557084424, 34257.31485370328, 34651.30697385988, 35700.28599427945, 35919.46120808242, 36005.27989440144, 39979.40030899597, 40215.3913843443, 40669.79665101656, 43352.13295734004, 44148.77925610352, 11027.0, 11120.388378639253, 11207.271527350696, 11293.619105205533, 11350.313069074564, 11050.668479945614, 11110.833337500106, 11267.211295209585, 11965.401729913643, 12203.084768642564, 10216.335938163995, 10751.13990880712, 10818.29681070728, 10986.121110311316, 11007.559697612005, 10889.237753357189, 11740.471678774305, 11762.882371176178, 11818.763624727286, 12207.145499814927, 11011.229213954946, 11099.445027748741, 11187.776244474902, 11392.47464979501, 11493.712657183638, 9432.528373581155, 9507.334486585873, 9621.56702948355, 9800.0, 10149.0, 9049.366544342096, 9172.495512746864, 9343.439393636403, 9385.533568624405, 9906.752331191778], "unit": "score", "name": "yui.html", "value": 6194.7392636353015}], "name": "dromaeo_css", "value": 6726.894905994966}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 106.0, 110.0, 110.0, 110.0, 111.0, 112.0, 104.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 152.0, 161.0, 127.0, 154.0, 149.0, 127.0, 183.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 159.0, 160.0, 159.0, 162.0, 161.0, 159.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 72.0, 140.0, 74.0, 73.0, 75.0, 73.0, 145.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 144.0, 96.0, 96.0, 96.0, 140.0, 96.0, 97.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 56.0, 56.0, 55.0, 56.0, 57.0, 58.0, 65.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 84.0, 82.0, 90.0, 82.0, 81.0, 82.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 118.0, 116.0, 114.0, 117.0, 114.0, 115.0, 117.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.1}, {"lowerIsBetter": true, "replicates": [151.0, 138.0, 150.0, 153.0, 155.0, 141.0, 150.0, 150.0, 151.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 70.0, 67.0, 67.0, 68.0, 65.0, 67.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1504.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.42005692281936], "unit": "score", "name": "Richards", "value": 210.8588460000001}, {"lowerIsBetter": false, "replicates": [188.11136192626034], "unit": "score", "name": "DeltaBlue", "value": 351.483288}, {"lowerIsBetter": false, "replicates": [282.88543140028287], "unit": "score", "name": "Encrypt", "value": 940.9498350000002}, {"lowerIsBetter": false, "replicates": [5329.787234042553], "unit": "score", "name": "Decrypt", "value": 49.942143712574826}, {"lowerIsBetter": false, "replicates": [1998.0039920159682], "unit": "score", "name": "RayTrace", "value": 370.36412487512496}, {"lowerIsBetter": false, "replicates": [774.5933384972889], "unit": "score", "name": "Earley", "value": 860.4037330000002}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [43041.666666666664], "unit": "score", "name": "RegExp", "value": 21.16518877057114}, {"lowerIsBetter": false, "replicates": [641.4368184733804], "unit": "score", "name": "Splay", "value": 127.04446899999995}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 18705.15839254463}]} 17:12:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18705.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1505.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6726.90"}}} 17:12:17 INFO - Return code: 0 17:12:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:12:18 INFO - # TBPL SUCCESS # 17:12:18 INFO - Running post-action listener: _resource_record_post_action 17:12:18 INFO - Running post-run listener: _resource_record_post_run 17:12:19 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547569664; Read time: 4; Write time: 721744 17:12:19 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 247668736; Read time: 0; Write time: 441948 17:12:19 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 299302912; Read time: 4; Write time: 279432 17:12:19 INFO - Running post-run listener: _upload_blobber_files 17:12:19 INFO - Blob upload gear active. 17:12:19 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:12:19 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:12:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:12:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:12:19 INFO - (blobuploader) - INFO - Open directory for files ... 17:12:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:12:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:12:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:20 INFO - (blobuploader) - INFO - Done attempting. 17:12:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:12:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:12:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:21 INFO - (blobuploader) - INFO - Done attempting. 17:12:21 INFO - (blobuploader) - INFO - Iteration through files over. 17:12:21 INFO - Return code: 0 17:12:21 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:12:21 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:12:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ebec906d99e8bdd5c0204336620b7439a2370ce725f14161d881e5e0aac66aafe2356386319601943f63101ae36e09b8a6cc563d974572bf786572593cd9cad8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/2c9332f629ffb70b0fbac9efd4f73f9527455b488b00b67ecad5b75971f94aa1f6ffd5ebd623654e58b83ce237cdd2f8c4b19de8c7fe787df4cdce358d513b3b"} 17:12:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:12:21 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:12:21 INFO - Contents: 17:12:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ebec906d99e8bdd5c0204336620b7439a2370ce725f14161d881e5e0aac66aafe2356386319601943f63101ae36e09b8a6cc563d974572bf786572593cd9cad8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/2c9332f629ffb70b0fbac9efd4f73f9527455b488b00b67ecad5b75971f94aa1f6ffd5ebd623654e58b83ce237cdd2f8c4b19de8c7fe787df4cdce358d513b3b"} 17:12:21 INFO - Running post-run listener: copy_logs_to_upload_dir 17:12:21 INFO - Copying logs to upload dir... 17:12:21 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:12:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.886068 ========= master_lag: 2997.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 1 hrs, 11 mins, 4 secs) (at 2016-01-20 18:02:18.347323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 mins, 12 secs) (at 2016-01-20 18:02:18.351322) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ebec906d99e8bdd5c0204336620b7439a2370ce725f14161d881e5e0aac66aafe2356386319601943f63101ae36e09b8a6cc563d974572bf786572593cd9cad8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/2c9332f629ffb70b0fbac9efd4f73f9527455b488b00b67ecad5b75971f94aa1f6ffd5ebd623654e58b83ce237cdd2f8c4b19de8c7fe787df4cdce358d513b3b"} build_url:https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011472 build_url: 'https://queue.taskcluster.net/v1/task/fIes688kRXStSApTm5Yx0w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ebec906d99e8bdd5c0204336620b7439a2370ce725f14161d881e5e0aac66aafe2356386319601943f63101ae36e09b8a6cc563d974572bf786572593cd9cad8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/2c9332f629ffb70b0fbac9efd4f73f9527455b488b00b67ecad5b75971f94aa1f6ffd5ebd623654e58b83ce237cdd2f8c4b19de8c7fe787df4cdce358d513b3b"}' ========= master_lag: 72.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 mins, 12 secs) (at 2016-01-20 18:03:30.816330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 8 mins, 48 secs) (at 2016-01-20 18:03:30.816915) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453336842.538694-1227186480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004757 ========= master_lag: 528.45 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 8 mins, 48 secs) (at 2016-01-20 18:12:19.275481) ========= ========= Started reboot skipped (results: 3, elapsed: 25 secs) (at 2016-01-20 18:12:19.275909) ========= ========= Finished reboot skipped (results: 3, elapsed: 25 secs) (at 2016-01-20 18:12:44.633622) ========= ========= Total master_lag: 3598.11 =========