builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1452582744.59 results: success (0) buildid: 20160111203233 builduid: 2db775017fa342b2953ca4904dd2abfc revision: 41a19217d481cde702d2eb0fc3461e568a0538e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.587605) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.587999) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.588291) ========= 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=6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006363 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.614849) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.615166) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.634613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.634879) ========= 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=6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.683691) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.683957) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.684299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.684579) ========= 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=6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 23:12:25-- 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% 30.9M=0s 2016-01-11 23:12:25 (30.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.879091) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.879373) ========= 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=6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013720 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:24.928917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-11 23:12:24.929234) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 41a19217d481cde702d2eb0fc3461e568a0538e3 --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 41a19217d481cde702d2eb0fc3461e568a0538e3 --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=6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 23:12:25,539 truncating revision to first 12 chars 2016-01-11 23:12:25,539 Setting DEBUG logging. 2016-01-11 23:12:25,539 attempt 1/10 2016-01-11 23:12:25,539 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/41a19217d481?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 23:12:26,662 unpacking tar archive at: b2g-inbound-41a19217d481/testing/mozharness/ program finished with exit code 0 elapsedTime=1.449330 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-11 23:12:26.391338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:26.391647) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:26.404879) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:26.405314) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 23:12:26.405745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-11 23:12:26.406054) ========= /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=6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:12:27 INFO - MultiFileLogger online at 20160111 23:12:27 in /builds/slave/test-pgo 23:12:27 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 23:12:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:12:27 INFO - {'append_to_log': False, 23:12:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:12:27 INFO - 'blob_upload_branch': 'B2G-Inbound', 23:12:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:12:27 INFO - 'branch': 'B2G-Inbound', 23:12:27 INFO - 'buildbot_json_path': 'buildprops.json', 23:12:27 INFO - 'config_files': ('talos/linux_config.py',), 23:12:27 INFO - 'default_actions': ('clobber', 23:12:27 INFO - 'read-buildbot-config', 23:12:27 INFO - 'download-and-extract', 23:12:27 INFO - 'populate-webroot', 23:12:27 INFO - 'create-virtualenv', 23:12:27 INFO - 'install', 23:12:27 INFO - 'run-tests'), 23:12:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:12:27 INFO - 'download_minidump_stackwalk': True, 23:12:27 INFO - 'download_symbols': 'ondemand', 23:12:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:12:27 INFO - 'tooltool.py': '/tools/tooltool.py', 23:12:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:12:27 INFO - '/tools/misc-python/virtualenv.py')}, 23:12:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:12:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:12:27 INFO - 'installer_path': 'installer.exe', 23:12:27 INFO - 'log_level': 'info', 23:12:27 INFO - 'log_name': 'talos', 23:12:27 INFO - 'log_to_console': True, 23:12:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:12:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:12:27 INFO - 'opt_config_files': (), 23:12:27 INFO - 'pip_index': False, 23:12:27 INFO - 'sps_profile': False, 23:12:27 INFO - 'sps_profile_interval': 0, 23:12:27 INFO - 'suite': 'dromaeojs', 23:12:27 INFO - 'system_bits': '32', 23:12:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:12:27 INFO - 'title': 'talos-linux64-ix-050', 23:12:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:12:27 INFO - 'use_talos_json': True, 23:12:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:12:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:12:27 INFO - 'work_dir': 'build'} 23:12:27 INFO - ##### 23:12:27 INFO - ##### Running clobber step. 23:12:27 INFO - ##### 23:12:27 INFO - Running pre-action listener: _resource_record_pre_action 23:12:27 INFO - Running main action method: clobber 23:12:27 INFO - rmtree: /builds/slave/test-pgo/build 23:12:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:12:28 INFO - Running post-action listener: _resource_record_post_action 23:12:28 INFO - ##### 23:12:28 INFO - ##### Running read-buildbot-config step. 23:12:28 INFO - ##### 23:12:28 INFO - Running pre-action listener: _resource_record_pre_action 23:12:28 INFO - Running main action method: read_buildbot_config 23:12:28 INFO - Using buildbot properties: 23:12:28 INFO - { 23:12:28 INFO - "project": "", 23:12:28 INFO - "product": "firefox", 23:12:28 INFO - "script_repo_revision": "production", 23:12:28 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 23:12:28 INFO - "repository": "", 23:12:28 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 23:12:28 INFO - "buildid": "20160111203233", 23:12:28 INFO - "pgo_build": "True", 23:12:28 INFO - "basedir": "/builds/slave/test-pgo", 23:12:28 INFO - "buildnumber": 1102, 23:12:28 INFO - "slavename": "talos-linux64-ix-050", 23:12:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:12:28 INFO - "platform": "ubuntu64_hw", 23:12:28 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 23:12:28 INFO - "branch": "b2g-inbound", 23:12:28 INFO - "repo_path": "integration/b2g-inbound", 23:12:28 INFO - "revision": "41a19217d481cde702d2eb0fc3461e568a0538e3", 23:12:28 INFO - "stage_platform": "linux64-pgo", 23:12:28 INFO - "builduid": "2db775017fa342b2953ca4904dd2abfc", 23:12:28 INFO - "slavebuilddir": "test" 23:12:28 INFO - } 23:12:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 23:12:28 INFO - Running post-action listener: _resource_record_post_action 23:12:28 INFO - ##### 23:12:28 INFO - ##### Running download-and-extract step. 23:12:28 INFO - ##### 23:12:28 INFO - Running pre-action listener: _resource_record_pre_action 23:12:28 INFO - Running main action method: download_and_extract 23:12:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:12: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')]} 23:12:28 INFO - https://queue.taskcluster.net/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:12:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/test_packages.json 23:12:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/test_packages.json 23:12:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:12:29 INFO - Downloaded 1302 bytes. 23:12:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:12:29 INFO - Using the following test package requirements: 23:12:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:12:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:12:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:12:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:12:29 INFO - u'jsshell-linux-x86_64.zip'], 23:12:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:12:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:12:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:12:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:12:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:12:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:12:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:12:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:12:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:12:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:12:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:12:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:12:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:29 INFO - https://queue.taskcluster.net/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:12:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:12:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:12:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/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 23:12:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/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 23:12:40 INFO - Downloaded 24028538 bytes. 23:12:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 23:12:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:12:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 23:12:41 INFO - Return code: 0 23:12:41 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 23:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:41 INFO - https://queue.taskcluster.net/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:12:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:12:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:12:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/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 23:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/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 23:12:44 INFO - Downloaded 24028538 bytes. 23:12:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 23:12:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:12:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 23:12:45 INFO - Return code: 0 23:12:45 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')]} 23:12:45 INFO - https://queue.taskcluster.net/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:12:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:12:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:12:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/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 23:12:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/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 23:12:47 INFO - Downloaded 11132285 bytes. 23:12:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 23:12:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:12:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 23:12:47 INFO - Return code: 0 23:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:47 INFO - https://queue.taskcluster.net/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:12:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:12:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:12:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/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 23:12:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CO7GXs1-TiiNqGeozEmcYw/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 23:12:52 INFO - Downloaded 55922025 bytes. 23:12:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:12:52 INFO - mkdir: /builds/slave/test-pgo/properties 23:12:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:12:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:12:52 INFO - Contents: 23:12:52 INFO - build_url:https://queue.taskcluster.net/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:12:52 INFO - Running post-action listener: _resource_record_post_action 23:12:52 INFO - Running post-action listener: set_extra_try_arguments 23:12:52 INFO - ##### 23:12:52 INFO - ##### Running populate-webroot step. 23:12:52 INFO - ##### 23:12:52 INFO - Running pre-action listener: _resource_record_pre_action 23:12:52 INFO - Running main action method: populate_webroot 23:12:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:12:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:12:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:12:52 INFO - '--tppagecycles', 23:12:52 INFO - '7'], 23:12:52 INFO - 'tests': ['tsvgm']}}, 23:12:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:12:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:12:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:12:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:12:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:12:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:12:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:12:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:52 INFO - 'talos_options': ['--e10s'], 23:12:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:12:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:52 INFO - 'tests': ['damp', 'tps']}, 23:12:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:52 INFO - 'talos_options': ['--e10s'], 23:12:52 INFO - 'tests': ['damp', 'tps']}, 23:12:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:12:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:12:52 INFO - 'other': {'tests': ['a11yr', 23:12:52 INFO - 'ts_paint', 23:12:52 INFO - 'tpaint', 23:12:52 INFO - 'sessionrestore', 23:12:52 INFO - 'sessionrestore_no_auto_restore']}, 23:12:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:12:52 INFO - 'tests': ['a11yr', 23:12:52 INFO - 'ts_paint', 23:12:52 INFO - 'tpaint', 23:12:52 INFO - 'sessionrestore', 23:12:52 INFO - 'sessionrestore_no_auto_restore']}, 23:12:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:12:52 INFO - 'tests': ['a11yr', 23:12:52 INFO - 'ts_paint', 23:12:52 INFO - 'tpaint', 23:12:52 INFO - 'sessionrestore', 23:12:52 INFO - 'sessionrestore_no_auto_restore']}, 23:12:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:12:52 INFO - 'tests': ['a11yr', 23:12:52 INFO - 'ts_paint', 23:12:52 INFO - 'tpaint', 23:12:52 INFO - 'sessionrestore', 23:12:52 INFO - 'sessionrestore_no_auto_restore']}, 23:12:52 INFO - 'other_l64': {'tests': ['a11yr', 23:12:52 INFO - 'ts_paint', 23:12:52 INFO - 'tpaint', 23:12:52 INFO - 'sessionrestore', 23:12:52 INFO - 'sessionrestore_no_auto_restore']}, 23:12:52 INFO - 'other_nol64': {'tests': ['a11yr', 23:12:52 INFO - 'ts_paint', 23:12:52 INFO - 'tpaint', 23:12:52 INFO - 'sessionrestore', 23:12:52 INFO - 'sessionrestore_no_auto_restore']}, 23:12:52 INFO - 'svgr': {'tests': ['tsvgx', 23:12:52 INFO - 'tsvgr_opacity', 23:12:52 INFO - 'tart', 23:12:52 INFO - 'tscrollx', 23:12:52 INFO - 'cart']}, 23:12:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:12:52 INFO - 'tests': ['tsvgx', 23:12:52 INFO - 'tsvgr_opacity', 23:12:52 INFO - 'tart', 23:12:52 INFO - 'tscrollx', 23:12:52 INFO - 'cart']}, 23:12:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:52 INFO - 'tests': ['tp5o']}, 23:12:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:52 INFO - 'talos_options': ['--e10s'], 23:12:52 INFO - 'tests': ['tp5o']}, 23:12:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:52 INFO - 'talos_options': ['--xperf_path', 23:12:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:12:52 INFO - 'tests': ['tp5n']}, 23:12:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:52 INFO - 'talos_options': ['--e10s', 23:12:52 INFO - '--xperf_path', 23:12:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:12:52 INFO - 'tests': ['tp5n']}}, 23:12:52 INFO - 'talos.zip': {'path': '', 23:12:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:12:52 INFO - Running post-action listener: _resource_record_post_action 23:12:52 INFO - ##### 23:12:52 INFO - ##### Running create-virtualenv step. 23:12:52 INFO - ##### 23:12:52 INFO - Running pre-action listener: _resource_record_pre_action 23:12:52 INFO - Running main action method: create_virtualenv 23:12:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:12:52 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 23:12:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:12:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:12:53 INFO - Using real prefix '/usr' 23:12:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:12:53 INFO - Installing distribute.............................................................................................................................................................................................done. 23:12:55 INFO - Installing pip.................done. 23:12:55 INFO - Return code: 0 23:12:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21d29e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1469480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8660>, '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 0x14f9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', '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 23:12:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 23:12:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:12:55 INFO - Using env: {'DISPLAY': ':0', 23:12:55 INFO - 'HOME': '/home/cltbld', 23:12:55 INFO - 'LANG': 'en_US.UTF-8', 23:12:55 INFO - 'LANGUAGE': 'en_US:en', 23:12:55 INFO - 'LOGNAME': 'cltbld', 23:12:55 INFO - 'MAIL': '/var/mail/cltbld', 23:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:55 INFO - 'MOZ_NO_REMOTE': '1', 23:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:55 INFO - 'NO_EM_RESTART': '1', 23:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:55 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:55 INFO - 'SHELL': '/bin/bash', 23:12:55 INFO - 'SHLVL': '1', 23:12:55 INFO - 'TERM': 'linux', 23:12:55 INFO - 'TMOUT': '86400', 23:12:55 INFO - 'USER': 'cltbld', 23:12:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', 23:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:55 INFO - '_': '/tools/buildbot/bin/python'} 23:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:55 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 23:12:55 INFO - Cleaning up... 23:12:55 INFO - Return code: 0 23:12:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f21d29e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1469480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8660>, '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 0x14f9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', '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 23:12:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 23:12:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:12:55 INFO - Using env: {'DISPLAY': ':0', 23:12:55 INFO - 'HOME': '/home/cltbld', 23:12:55 INFO - 'LANG': 'en_US.UTF-8', 23:12:55 INFO - 'LANGUAGE': 'en_US:en', 23:12:55 INFO - 'LOGNAME': 'cltbld', 23:12:55 INFO - 'MAIL': '/var/mail/cltbld', 23:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:55 INFO - 'MOZ_NO_REMOTE': '1', 23:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:55 INFO - 'NO_EM_RESTART': '1', 23:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:55 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:55 INFO - 'SHELL': '/bin/bash', 23:12:55 INFO - 'SHLVL': '1', 23:12:55 INFO - 'TERM': 'linux', 23:12:55 INFO - 'TMOUT': '86400', 23:12:55 INFO - 'USER': 'cltbld', 23:12:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', 23:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:55 INFO - '_': '/tools/buildbot/bin/python'} 23:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:55 INFO - Downloading/unpacking psutil>=0.7.1 23:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 23:12:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:12:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:12:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:12:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:12:57 INFO - Installing collected packages: psutil 23:12:57 INFO - Running setup.py install for psutil 23:12:57 INFO - building 'psutil._psutil_linux' extension 23:12:57 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 23:12:58 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 23:12:58 INFO - building 'psutil._psutil_posix' extension 23:12:58 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 23:12:58 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 23:12:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:12:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:12:58 INFO - Successfully installed psutil 23:12:58 INFO - Cleaning up... 23:12:58 INFO - Return code: 0 23:12:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f21d29e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1469480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8660>, '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 0x14f9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', '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 23:12:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 23:12:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:12:58 INFO - Using env: {'DISPLAY': ':0', 23:12:58 INFO - 'HOME': '/home/cltbld', 23:12:58 INFO - 'LANG': 'en_US.UTF-8', 23:12:58 INFO - 'LANGUAGE': 'en_US:en', 23:12:58 INFO - 'LOGNAME': 'cltbld', 23:12:58 INFO - 'MAIL': '/var/mail/cltbld', 23:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:58 INFO - 'MOZ_NO_REMOTE': '1', 23:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:58 INFO - 'NO_EM_RESTART': '1', 23:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:58 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:58 INFO - 'SHELL': '/bin/bash', 23:12:58 INFO - 'SHLVL': '1', 23:12:58 INFO - 'TERM': 'linux', 23:12:58 INFO - 'TMOUT': '86400', 23:12:58 INFO - 'USER': 'cltbld', 23:12:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', 23:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:58 INFO - '_': '/tools/buildbot/bin/python'} 23:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:12:58 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 23:12:58 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 23:12:58 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 23:12:58 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 23:12:58 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 23:12:58 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 23:13:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:13:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:13:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:13:00 INFO - Installing collected packages: mozsystemmonitor 23:13:00 INFO - Running setup.py install for mozsystemmonitor 23:13:00 INFO - Successfully installed mozsystemmonitor 23:13:00 INFO - Cleaning up... 23:13:00 INFO - Return code: 0 23:13:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:13:00 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')]} 23:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:00 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')]} 23:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21d29e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1469480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8660>, '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 0x14f9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', '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 23:13:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 23:13:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:13:00 INFO - Using env: {'DISPLAY': ':0', 23:13:00 INFO - 'HOME': '/home/cltbld', 23:13:00 INFO - 'LANG': 'en_US.UTF-8', 23:13:00 INFO - 'LANGUAGE': 'en_US:en', 23:13:00 INFO - 'LOGNAME': 'cltbld', 23:13:00 INFO - 'MAIL': '/var/mail/cltbld', 23:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:00 INFO - 'MOZ_NO_REMOTE': '1', 23:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:00 INFO - 'NO_EM_RESTART': '1', 23:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:13:00 INFO - 'PWD': '/builds/slave/test-pgo', 23:13:00 INFO - 'SHELL': '/bin/bash', 23:13:00 INFO - 'SHLVL': '1', 23:13:00 INFO - 'TERM': 'linux', 23:13:00 INFO - 'TMOUT': '86400', 23:13:00 INFO - 'USER': 'cltbld', 23:13:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', 23:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:00 INFO - '_': '/tools/buildbot/bin/python'} 23:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:00 INFO - Downloading/unpacking blobuploader==1.2.4 23:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:02 INFO - Downloading blobuploader-1.2.4.tar.gz 23:13:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:13:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:13:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:13:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:13:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:03 INFO - Downloading docopt-0.6.1.tar.gz 23:13:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:13:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:13:03 INFO - Installing collected packages: blobuploader, requests, docopt 23:13:03 INFO - Running setup.py install for blobuploader 23:13:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:13:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:13:03 INFO - Running setup.py install for requests 23:13:03 INFO - Running setup.py install for docopt 23:13:03 INFO - Successfully installed blobuploader requests docopt 23:13:03 INFO - Cleaning up... 23:13:03 INFO - Return code: 0 23:13:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:13:03 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')]} 23:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:03 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')]} 23:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21d29e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1469480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8660>, '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 0x14f9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', '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 23:13:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 23:13:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:13:03 INFO - Using env: {'DISPLAY': ':0', 23:13:03 INFO - 'HOME': '/home/cltbld', 23:13:03 INFO - 'LANG': 'en_US.UTF-8', 23:13:03 INFO - 'LANGUAGE': 'en_US:en', 23:13:03 INFO - 'LOGNAME': 'cltbld', 23:13:03 INFO - 'MAIL': '/var/mail/cltbld', 23:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:03 INFO - 'MOZ_NO_REMOTE': '1', 23:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:03 INFO - 'NO_EM_RESTART': '1', 23:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:13:03 INFO - 'PWD': '/builds/slave/test-pgo', 23:13:03 INFO - 'SHELL': '/bin/bash', 23:13:03 INFO - 'SHLVL': '1', 23:13:03 INFO - 'TERM': 'linux', 23:13:03 INFO - 'TMOUT': '86400', 23:13:03 INFO - 'USER': 'cltbld', 23:13:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', 23:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:03 INFO - '_': '/tools/buildbot/bin/python'} 23:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:13:03 INFO - Running setup.py (path:/tmp/pip-njZXKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:13:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:13:03 INFO - Running setup.py (path:/tmp/pip-NHEIZS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:13:04 INFO - Running setup.py (path:/tmp/pip-tqio0b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:13:04 INFO - Running setup.py (path:/tmp/pip-CUdrSV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:13:04 INFO - Running setup.py (path:/tmp/pip-SWBjQ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:13:04 INFO - Running setup.py (path:/tmp/pip-o6auul-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:13:04 INFO - Running setup.py (path:/tmp/pip-G8juCx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:13:04 INFO - Running setup.py (path:/tmp/pip-QPcls9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:13:04 INFO - Running setup.py (path:/tmp/pip-itv5s1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:13:04 INFO - Running setup.py (path:/tmp/pip-Y2QLL1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:13:04 INFO - Running setup.py (path:/tmp/pip-CdZh8Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:13:04 INFO - Running setup.py (path:/tmp/pip-WIgnv7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:13:04 INFO - Running setup.py (path:/tmp/pip-0wUBDn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:13:04 INFO - Running setup.py (path:/tmp/pip-28XN_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:13:04 INFO - Running setup.py (path:/tmp/pip-oK1V_v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:13:04 INFO - Running setup.py (path:/tmp/pip-fCS3lj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:13:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:13:05 INFO - Running setup.py (path:/tmp/pip-HjJNAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:13:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:13:05 INFO - Running setup.py install for manifestparser 23:13:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:13:05 INFO - Running setup.py install for mozcrash 23:13:05 INFO - Running setup.py install for mozdebug 23:13:05 INFO - Running setup.py install for mozdevice 23:13:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:13:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:13:05 INFO - Running setup.py install for mozfile 23:13:05 INFO - Running setup.py install for mozhttpd 23:13:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:13:05 INFO - Running setup.py install for mozinfo 23:13:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:13:05 INFO - Running setup.py install for mozInstall 23:13:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:13:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:13:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:13:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:13:05 INFO - Running setup.py install for mozleak 23:13:06 INFO - Running setup.py install for mozlog 23:13:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:13:06 INFO - Running setup.py install for moznetwork 23:13:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:13:06 INFO - Running setup.py install for mozprocess 23:13:06 INFO - Running setup.py install for mozprofile 23:13:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:13:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:13:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:13:06 INFO - Running setup.py install for mozrunner 23:13:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:13:06 INFO - Running setup.py install for mozscreenshot 23:13:06 INFO - Running setup.py install for moztest 23:13:06 INFO - Running setup.py install for mozversion 23:13:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:13:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:13:06 INFO - Cleaning up... 23:13:06 INFO - Return code: 0 23:13:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:13:06 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')]} 23:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:06 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')]} 23:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21d29e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1469480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8660>, '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 0x14f9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', '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 23:13:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 23:13:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:13:06 INFO - Using env: {'DISPLAY': ':0', 23:13:06 INFO - 'HOME': '/home/cltbld', 23:13:06 INFO - 'LANG': 'en_US.UTF-8', 23:13:06 INFO - 'LANGUAGE': 'en_US:en', 23:13:06 INFO - 'LOGNAME': 'cltbld', 23:13:06 INFO - 'MAIL': '/var/mail/cltbld', 23:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:06 INFO - 'MOZ_NO_REMOTE': '1', 23:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:06 INFO - 'NO_EM_RESTART': '1', 23:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:13:06 INFO - 'PWD': '/builds/slave/test-pgo', 23:13:06 INFO - 'SHELL': '/bin/bash', 23:13:06 INFO - 'SHLVL': '1', 23:13:06 INFO - 'TERM': 'linux', 23:13:06 INFO - 'TMOUT': '86400', 23:13:06 INFO - 'USER': 'cltbld', 23:13:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', 23:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:06 INFO - '_': '/tools/buildbot/bin/python'} 23:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:13:07 INFO - Running setup.py (path:/tmp/pip-qBDmGX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:13:07 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)) 23:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:13:07 INFO - Running setup.py (path:/tmp/pip-vmZr1P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:13:07 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)) 23:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:13:07 INFO - Running setup.py (path:/tmp/pip-LOdUuE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:13:07 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)) 23:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:13:07 INFO - Running setup.py (path:/tmp/pip-q20T9Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:13:07 INFO - Running setup.py (path:/tmp/pip-d6baer-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:13:07 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)) 23:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:13:07 INFO - Running setup.py (path:/tmp/pip-ycCOeX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:13:07 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)) 23:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:13:07 INFO - Running setup.py (path:/tmp/pip-uFscCO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:13:07 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)) 23:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:13:07 INFO - Running setup.py (path:/tmp/pip-bRK9tX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:13:07 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)) 23:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:13:07 INFO - Running setup.py (path:/tmp/pip-Z5_jjz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:13:07 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)) 23:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:13:07 INFO - Running setup.py (path:/tmp/pip-WLPYUW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:13:07 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)) 23:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:13:07 INFO - Running setup.py (path:/tmp/pip-ZQrI4x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:13:07 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)) 23:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:13:07 INFO - Running setup.py (path:/tmp/pip-QaVBBu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:13:08 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)) 23:13:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:13:08 INFO - Running setup.py (path:/tmp/pip-wx6ZAF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:13:08 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)) 23:13:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:13:08 INFO - Running setup.py (path:/tmp/pip-Y9g_xQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:13:08 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)) 23:13:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:13:08 INFO - Running setup.py (path:/tmp/pip-B_CtOJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:13:08 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)) 23:13:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:13:08 INFO - Running setup.py (path:/tmp/pip-OtMRA0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:13:08 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)) 23:13:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:13:08 INFO - Running setup.py (path:/tmp/pip-pM3IHE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:13:08 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)) 23:13:08 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)) 23:13:08 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)) 23:13:08 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)) 23:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:13:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:13:08 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 23:13:08 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 23:13:08 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 23:13:08 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 23:13:08 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 23:13:08 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 23:13:10 INFO - Downloading blessings-1.5.1.tar.gz 23:13:10 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 23:13:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:13:10 INFO - Installing collected packages: blessings 23:13:10 INFO - Running setup.py install for blessings 23:13:10 INFO - Successfully installed blessings 23:13:10 INFO - Cleaning up... 23:13:10 INFO - Return code: 0 23:13:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:13:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:13:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:13:10 INFO - Reading from file tmpfile_stdout 23:13:10 INFO - Current package versions: 23:13:10 INFO - argparse == 1.2.1 23:13:10 INFO - blessings == 1.5.1 23:13:10 INFO - blobuploader == 1.2.4 23:13:10 INFO - docopt == 0.6.1 23:13:10 INFO - manifestparser == 1.1 23:13:10 INFO - mozInstall == 1.12 23:13:10 INFO - mozcrash == 0.16 23:13:10 INFO - mozdebug == 0.1 23:13:10 INFO - mozdevice == 0.47 23:13:10 INFO - mozfile == 1.2 23:13:10 INFO - mozhttpd == 0.7 23:13:10 INFO - mozinfo == 0.9 23:13:10 INFO - mozleak == 0.1 23:13:10 INFO - mozlog == 3.1 23:13:10 INFO - moznetwork == 0.27 23:13:10 INFO - mozprocess == 0.22 23:13:10 INFO - mozprofile == 0.28 23:13:10 INFO - mozrunner == 6.11 23:13:10 INFO - mozscreenshot == 0.1 23:13:10 INFO - mozsystemmonitor == 0.0 23:13:10 INFO - moztest == 0.7 23:13:10 INFO - mozversion == 1.4 23:13:10 INFO - psutil == 3.1.1 23:13:10 INFO - requests == 1.2.3 23:13:10 INFO - wsgiref == 0.1.2 23:13:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21d29e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1469480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8660>, '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 0x14f9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', '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 23:13:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 23:13:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:13:10 INFO - Using env: {'DISPLAY': ':0', 23:13:10 INFO - 'HOME': '/home/cltbld', 23:13:10 INFO - 'LANG': 'en_US.UTF-8', 23:13:10 INFO - 'LANGUAGE': 'en_US:en', 23:13:10 INFO - 'LOGNAME': 'cltbld', 23:13:10 INFO - 'MAIL': '/var/mail/cltbld', 23:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:10 INFO - 'MOZ_NO_REMOTE': '1', 23:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:10 INFO - 'NO_EM_RESTART': '1', 23:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:13:10 INFO - 'PWD': '/builds/slave/test-pgo', 23:13:10 INFO - 'SHELL': '/bin/bash', 23:13:10 INFO - 'SHLVL': '1', 23:13:10 INFO - 'TERM': 'linux', 23:13:10 INFO - 'TMOUT': '86400', 23:13:10 INFO - 'USER': 'cltbld', 23:13:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', 23:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:10 INFO - '_': '/tools/buildbot/bin/python'} 23:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:10 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)) 23:13:10 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)) 23:13:10 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)) 23:13:10 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)) 23:13:10 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)) 23:13:10 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)) 23:13:10 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)) 23:13:10 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)) 23:13:10 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)) 23:13:10 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)) 23:13:10 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)) 23:13:10 INFO - Cleaning up... 23:13:10 INFO - Return code: 0 23:13:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21d29e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1469480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8660>, '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 0x14f9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', '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 23:13:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 23:13:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:13:10 INFO - Using env: {'DISPLAY': ':0', 23:13:10 INFO - 'HOME': '/home/cltbld', 23:13:10 INFO - 'LANG': 'en_US.UTF-8', 23:13:10 INFO - 'LANGUAGE': 'en_US:en', 23:13:10 INFO - 'LOGNAME': 'cltbld', 23:13:10 INFO - 'MAIL': '/var/mail/cltbld', 23:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:10 INFO - 'MOZ_NO_REMOTE': '1', 23:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:10 INFO - 'NO_EM_RESTART': '1', 23:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:13:10 INFO - 'PWD': '/builds/slave/test-pgo', 23:13:10 INFO - 'SHELL': '/bin/bash', 23:13:10 INFO - 'SHLVL': '1', 23:13:10 INFO - 'TERM': 'linux', 23:13:10 INFO - 'TMOUT': '86400', 23:13:10 INFO - 'USER': 'cltbld', 23:13:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', 23:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:10 INFO - '_': '/tools/buildbot/bin/python'} 23:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:11 INFO - Downloading/unpacking jsonschema 23:13:11 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 23:13:11 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 23:13:11 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 23:13:11 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 23:13:11 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 23:13:11 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 23:13:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:13:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 23:13:12 INFO - Downloading/unpacking functools32 (from jsonschema) 23:13:12 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 23:13:12 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 23:13:12 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 23:13:12 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 23:13:12 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 23:13:12 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 23:13:12 INFO - Downloading functools32-3.2.3-2.tar.gz 23:13:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 23:13:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:13:13 INFO - warning: no files found matching '*.txt' 23:13:13 INFO - no previously-included directories found matching 'build' 23:13:13 INFO - no previously-included directories found matching 'dist' 23:13:13 INFO - no previously-included directories found matching '.git*' 23:13:13 INFO - Installing collected packages: jsonschema, functools32 23:13:13 INFO - Running setup.py install for functools32 23:13:13 INFO - warning: no files found matching '*.txt' 23:13:13 INFO - no previously-included directories found matching 'build' 23:13:13 INFO - no previously-included directories found matching 'dist' 23:13:13 INFO - no previously-included directories found matching '.git*' 23:13:13 INFO - Successfully installed jsonschema functools32 23:13:13 INFO - Cleaning up... 23:13:13 INFO - Return code: 0 23:13:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21d29e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1469480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8660>, '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 0x14f9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', '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 23:13:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 23:13:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:13:13 INFO - Using env: {'DISPLAY': ':0', 23:13:13 INFO - 'HOME': '/home/cltbld', 23:13:13 INFO - 'LANG': 'en_US.UTF-8', 23:13:13 INFO - 'LANGUAGE': 'en_US:en', 23:13:13 INFO - 'LOGNAME': 'cltbld', 23:13:13 INFO - 'MAIL': '/var/mail/cltbld', 23:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:13 INFO - 'MOZ_NO_REMOTE': '1', 23:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:13 INFO - 'NO_EM_RESTART': '1', 23:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:13:13 INFO - 'PWD': '/builds/slave/test-pgo', 23:13:13 INFO - 'SHELL': '/bin/bash', 23:13:13 INFO - 'SHLVL': '1', 23:13:13 INFO - 'TERM': 'linux', 23:13:13 INFO - 'TMOUT': '86400', 23:13:13 INFO - 'USER': 'cltbld', 23:13:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', 23:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:13 INFO - '_': '/tools/buildbot/bin/python'} 23:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:13 INFO - Downloading/unpacking flake8 23:13:13 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 23:13:13 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 23:13:13 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 23:13:13 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 23:13:13 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 23:13:13 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 23:13:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:13:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 23:13:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:13:15 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 23:13:15 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 23:13:15 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 23:13:15 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 23:13:15 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 23:13:15 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 23:13:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:13:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 23:13:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:13:15 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 23:13:15 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 23:13:15 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 23:13:15 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 23:13:15 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 23:13:15 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 23:13:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 23:13:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:13:15 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 23:13:15 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 23:13:15 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 23:13:15 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 23:13:15 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 23:13:15 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 23:13:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 23:13:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:13:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:13:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:13:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:13:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:13:15 INFO - no previously-included directories found matching 'docs/_build' 23:13:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:13:15 INFO - Running setup.py install for pep8 23:13:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:13:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:13:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:13:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:13:15 INFO - no previously-included directories found matching 'docs/_build' 23:13:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:13:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:13:15 INFO - Cleaning up... 23:13:16 INFO - Return code: 0 23:13:16 INFO - Running post-action listener: _resource_record_post_action 23:13:16 INFO - Running post-action listener: _start_resource_monitoring 23:13:16 INFO - Starting resource monitoring. 23:13:16 INFO - ##### 23:13:16 INFO - ##### Running install step. 23:13:16 INFO - ##### 23:13:16 INFO - Running pre-action listener: _resource_record_pre_action 23:13:16 INFO - Running main action method: install 23:13:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:13:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:13:16 INFO - Reading from file tmpfile_stdout 23:13:16 INFO - Detecting whether we're running mozinstall >=1.0... 23:13:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:13:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:13:16 INFO - Reading from file tmpfile_stdout 23:13:16 INFO - Output received: 23:13:16 INFO - Usage: mozinstall [options] installer 23:13:16 INFO - Options: 23:13:16 INFO - -h, --help show this help message and exit 23:13:16 INFO - -d DEST, --destination=DEST 23:13:16 INFO - Directory to install application into. [default: 23:13:16 INFO - "/builds/slave/test-pgo"] 23:13:16 INFO - --app=APP Application being installed. [default: firefox] 23:13:16 INFO - mkdir: /builds/slave/test-pgo/build/application 23:13:16 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'] 23:13:16 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 23:13:32 INFO - Reading from file tmpfile_stdout 23:13:32 INFO - Output received: 23:13:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:13:32 INFO - Running post-action listener: _resource_record_post_action 23:13:32 INFO - ##### 23:13:32 INFO - ##### Running run-tests step. 23:13:32 INFO - ##### 23:13:32 INFO - Running pre-action listener: _resource_record_pre_action 23:13:32 INFO - Running main action method: run_tests 23:13:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:13:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:13:32 INFO - Python 2.7.3 23:13:32 INFO - Return code: 0 23:13:32 INFO - grabbing minidump binary from tooltool 23:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:13:32 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 0x14f8660>, '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 0x14f9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:13:32 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 23:13:32 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 23:13:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:13:32 INFO - Return code: 0 23:13:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:13:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:13:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:13:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:13:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:13:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:13:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:13:33 INFO - Return code: 0 23:13:33 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/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 23:13:33 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/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 23:13:33 INFO - Using env: {'DISPLAY': ':0', 23:13:33 INFO - 'HOME': '/home/cltbld', 23:13:33 INFO - 'LANG': 'en_US.UTF-8', 23:13:33 INFO - 'LANGUAGE': 'en_US:en', 23:13:33 INFO - 'LOGNAME': 'cltbld', 23:13:33 INFO - 'MAIL': '/var/mail/cltbld', 23:13:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:13:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:33 INFO - 'MOZ_NO_REMOTE': '1', 23:13:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:33 INFO - 'NO_EM_RESTART': '1', 23:13:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:13:33 INFO - 'PWD': '/builds/slave/test-pgo', 23:13:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:13:33 INFO - 'SHELL': '/bin/bash', 23:13:33 INFO - 'SHLVL': '1', 23:13:33 INFO - 'TERM': 'linux', 23:13:33 INFO - 'TMOUT': '86400', 23:13:33 INFO - 'USER': 'cltbld', 23:13:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485', 23:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:33 INFO - '_': '/tools/buildbot/bin/python'} 23:13:33 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/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 23:13:33 INFO - mozversion application_buildid: 20160111203233 23:13:33 INFO - mozversion application_changeset: 41a19217d481cde702d2eb0fc3461e568a0538e3 23:13:33 INFO - mozversion application_display_name: Nightly 23:13:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:13:33 INFO - mozversion application_name: Firefox 23:13:33 INFO - mozversion application_remotingname: firefox 23:13:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 23:13:33 INFO - mozversion application_vendor: Mozilla 23:13:33 INFO - mozversion application_version: 46.0a1 23:13:33 INFO - mozversion platform_buildid: 20160111203233 23:13:33 INFO - mozversion platform_changeset: 41a19217d481cde702d2eb0fc3461e568a0538e3 23:13:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 23:13:33 INFO - mozversion platform_version: 46.0a1 23:13:33 INFO - using testdate: 1452582813 23:13:33 INFO - actual date: 1452582813 23:13:33 INFO - starting webserver on 'localhost:39726' 23:13:33 INFO - SUITE-START | Running 3 tests 23:13:33 INFO - TEST-START | dromaeo_css 23:13:33 INFO - operating with platform_type : linux_ 23:13:33 INFO - Initialising browser for dromaeo_css test... 23:13:33 INFO - TEST-INFO | started process 7551 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb6Ohoi/profile http://localhost:39726/getInfo.html) 23:13:37 INFO - PROCESS | 7551 | __metrics Screen width/height:1600/1200 23:13:37 INFO - PROCESS | 7551 | colorDepth:24 23:13:37 INFO - PROCESS | 7551 | Browser inner width/height: 1024/697 23:13:37 INFO - PROCESS | 7551 | __metrics 23:13:37 INFO - PROCESS | 7551 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:13:37 INFO - PROCESS | 7551 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:13:38 INFO - TEST-INFO | 7551: exit 0 23:13:38 INFO - Browser initialized. 23:13:38 INFO - Running cycle 1/1 for dromaeo_css test... 23:13:38 INFO - TEST-INFO | started process 7641 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb6Ohoi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:50 INFO - PROCESS | 7641 | RSS: Main: 149045248 23:13:50 INFO - PROCESS | 7641 | 23:14:41 INFO - PROCESS | 7641 | 1452582881090 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] 23:16:49 INFO - PROCESS | 7641 | Cycle 1(1): loaded http://localhost:39726/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39726/tests/dromaeo/cssquery-ext.html) 23:16:50 INFO - PROCESS | 7641 | RSS: Main: 270626816 23:16:50 INFO - PROCESS | 7641 | 23:19:52 INFO - PROCESS | 7641 | Cycle 1(1): loaded http://localhost:39726/tests/dromaeo/cssquery-ext.html (next: http://localhost:39726/tests/dromaeo/cssquery-jquery.html) 23:19:53 INFO - PROCESS | 7641 | RSS: Main: 223571968 23:19:53 INFO - PROCESS | 7641 | 23:22:55 INFO - PROCESS | 7641 | Cycle 1(1): loaded http://localhost:39726/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39726/tests/dromaeo/cssquery-mootools.html) 23:22:55 INFO - PROCESS | 7641 | RSS: Main: 230379520 23:22:55 INFO - PROCESS | 7641 | 23:25:57 INFO - PROCESS | 7641 | Cycle 1(1): loaded http://localhost:39726/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39726/tests/dromaeo/cssquery-prototype.html) 23:25:58 INFO - PROCESS | 7641 | RSS: Main: 211611648 23:25:58 INFO - PROCESS | 7641 | 23:29:00 INFO - PROCESS | 7641 | Cycle 1(1): loaded http://localhost:39726/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39726/tests/dromaeo/cssquery-yui.html) 23:29:01 INFO - PROCESS | 7641 | RSS: Main: 217661440 23:29:01 INFO - PROCESS | 7641 | 23:32:04 INFO - PROCESS | 7641 | Cycle 1(1): loaded http://localhost:39726/tests/dromaeo/cssquery-yui.html (next: http://localhost:39726/tests/dromaeo/cssquery-dojo.html) 23:32:04 INFO - PROCESS | 7641 | RSS: Main: 250671104 23:32:04 INFO - PROCESS | 7641 | 23:32:04 INFO - PROCESS | 7641 | __start_tp_report 23:32:04 INFO - PROCESS | 7641 | _x_x_mozilla_page_load 23:32:04 INFO - PROCESS | 7641 | _x_x_mozilla_page_load_details 23:32:04 INFO - PROCESS | 7641 | |i|pagename|runs| 23:32:04 INFO - PROCESS | 7641 | |0;dojo.html;3045.9847700761493;3091.4435401627698;3142.0416772884278;3144.025352140835;3167.2240301126226;4904.828331008415;4995.775190116445;5005.19916813309;5019.673721208123;5063.670861394007;4932.802687892489;4951.0592987332475;4978.701277923327;4999.900001999967;5059.620528460362;4593.517680643526;4614.700044497114;4626.6298696104395;4647.581717645411;4716.410448693913;473.58524147430495;4471.88820279494;4556.544345565433;4590.5409459054;4653.325267836161;4570.680052396334;4604.907901841978;4606.792694328729;4609.516000819916;4612.123696497655;4545.2954792007295;4594.494605593415;4606.470255920545;4617.930731039037;4633.1660301145785;4535.501094879561;4546.29532422475;4547.613452856511;4554.4990051094355;4583.472900616439;4741.431028276629;4853.174960256765;4859.441164266119;4876.804927802884;4937.111319962405;5289.20661900718;5302.628815982883;5353.9196912046355;5412.783488660449;5452.863678408032;5371.597130215249;5399.406065332811;5407.5133238008375;5409;5410.3507579090765;4933;4979.6265280104135;4999.250112483121;5025.597952163855;5073.112205364084;5445.428230035868;5471.042567550663;5491.423400542965;5537.307836520435;5556.499915007668;5239.895202095937;5281.735913204325;5288.762005709752;5292.603054770908;5338;5338.572914166857;5350.91973620396;5353.491418315254;5357.142857142916;5359.544438722753;5175.81884634036;5252.684838909678;5284.128118860422;5382.542483888913;5396.784128634889;5261.868698229822;5267.367915850123;5268.81559145428;5270.077736396192;5278.577713782888;4140;4147.854825081107;4148.668106551469;4189.6229339359;4193.559676234013;3695.9630403696156;3775.018495191215;3781.6596506314563;3807.3527500325013;3839.9808000959815;5045.192769156991;5061.44324124346;5062.645614807002;5069.366329208849;5116.769745361467;5195.506426889439;5360.088784906575;5368.570514358842;5368.624196306221;5415.620906536505;4962.280469331999;4971.65198436106;5007.974960125176;5058.519440653132;5089.592832573385;4553.066621342617;4577.427821522309;4579.084183163381;4580.312953057068;4630.305454181899;5421.403645598902;5547.029269877755;5576.052071147915;5576.9163462548095;5586.190002449622;5300;5310.920336194883;5344.652597581145;5368.1679339702405;5422.213779001943;5546.833594992157;5565.777368905198;5567.805126820542;5571.66570005801;5608.158776183605;5195.92206116901;5296.655717378358;5296.682199068068;5327.121025030981;5383.057964856056;5323.680579165262;5381.13901775714;5401.86495337604;5434.864128396664;5438.918416223839;5244.632875698664;5247.8163264287095;5253.789848406173;5256.053910296183;5278.498542638443;5244.5279924806955;5254.054270231395;5256.868578285574;5266.657667251617;5318.521333080042;4983.127952608352;5130.076586214368;5141.7686204120155;5150.639455238097;5261.894762104813;5231.3199284092825;5258.158694608997;5260.368755749335;5261.3686357637325;5264.210368444611;5110.744462776772;5154.871128221675;5171.431142574239;5179.870503237449;5219.973900130475 23:32:04 INFO - PROCESS | 7641 | |1;ext.html;520.4119345139989;539.1616037062366;539.1858293976096;560.2884336892146;576.1731914702402;28081.578776318347;28630.28424289391;35464.99999999997;35807;35877.820610896975;38603.42094868572;39166.60833391665;39173.41239881404;39196.60803391965;39251.214975700466;7083.256258092903;8307.584620768952;8497.787555311104;8551.700690475835;8564.957175214146;7525.849483010336;7687.500312479699;7692.4999875008225;10003.149732272766;10217;9912.553935072903;9979.550920208572;9996.750081247954;9999.650012249573;10013.799724005552;9825.017498250189;9907.157891579225;9911.603535858558;9918.107370336667;9922.107010369029;9722.9513852431;9759.512024398822;9885.555150018266;9896.90103098967;9906.306558540906;39129.41305880385;39663;39664.20671586552;39665.80167099146;39735;3198.9040328789943;3208.246062175387;3255.0560337502097;3262.13553408347;3604.116991337113;30030.549541756674;30134.071713701953;30235;30523.084307470588;31160;3930.5479869815053;3939.606039396066;3952.8536724349906;3997.200559888034;4016.196760647882;270027.6498617514;270926;271021;273153;273510;51098;52345.21482177771;58490;58856.41143588595;58946.11580826291;60565.69717151386;62246.688766555875;62446.37553624406;62482.37517624856;62536;13555.796663050061;13727.588172354845;13741.656458588615;13762.793558096637;13806.93096534531;10064.144547713526;10159.390436573829;10163;10575.841362379571;10887.510062047228;18679.104738765513;18897.14962826676;18920.24319027251;19026.143823527975;19041.904790475957;7677.808054798675;7931;8006.9599652002535;8057.395695322874;8058.597070146587;880.1682410122501;963.9807203856024;1003.7841863999275;1020.9132223760915;1102.4102105373586;24323.39191520226;24698.382540436272;27940.30149246285;28774.424511509653;29050.351943688907;1006.7030226083323;1024.7643042100358;1071.0842229893485;1102.2229328323513;1108.174410064491;12949;12997.09020368584;13037.934810326078;13095.214287142802;13110.606681799562;265378;267407;267965;268578;269199;47814.76092619584;48724.75637621789;48736.75631621819;48810.755946220044;48813.75593122012;1232.8890399864056;1233.444949772606;1306.9215847049209;1326.4163767942075;1365.6790654196257;24327.148549800673;25507;25757.484850302513;25814.354641134123;25937.351566210997;37170.8141459291;37310.25379492341;37386;37470;37471.62528374681;304420;305327;305743;306501;306581;26899;30684.84657576698;31036.844815775778;31211;31470.37059258848;36374.45438318374;37348;37686.2462750749;37730.43404348992;37733;31258.68741312649;31642.841785790923;31820.840895795372;32282.83858580786;32553.186170345933;27752.444951101268;31774.20564485814;32233.838830805696;35868.461973069905;36312.273754524234;31484.842575786974;31880.202994925312;32230.677693222766;32253.677463225067;32340.83829580837;28848.2787930295;30764.230894227825;30915;31244.375112498077;31248.843755781985;23206.883965580066;23881.761182387952;25951.61072583875;26318.21045368642;26337 23:32:04 INFO - PROCESS | 7641 | |2;jquery.html;366.9798161101139;369.8095480827374;371.591249625412;372.6180664818561;380.67642503871696;13699.315034248297;14252;16203.108829014414;16761.580960475992;17439.38962136324;10085.798284034334;10457;16050;16432;16456.424025159093;3748.5126933498746;4812;4969.031038947407;4972.03045406146;4979.651424400294;3842.2507611015862;3876.786776727293;3878.4570160177454;5322.76047577858;5536.640118392312;5405.405405405388;5550.389457159709;5553.6390134641115;5960.821175364725;5966.910496342558;5671.51792097668;5920.5855590108495;5960.821175364746;5965.343812180657;5970.134330522072;5280.762365693515;5284.682919024871;5288.2596436498925;5298.814541491068;5310.7610157543;12189.817152742717;12580.937095314557;12628.68428289291;12632.68418289541;12634.305113218768;1876.6238586593342;1917.2810196176433;1946.1728765274702;1966.2135145941595;1980.742503474539;12186.57346992851;12286.078544109138;12335.5065797368;12494.312812795293;12864.421101050475;1597.9840201597951;1762.5769815244378;1810.3754204799322;1838.512794109562;1855.4062699936026;51944.48055519434;53266.20100698493;53401.73299133479;53451.46548534543;53950.73024634891;9627.663031793854;9798.26513011527;9950.850737238947;9984.550695218588;10010.04904534068;12996.350182490838;13098.934505327603;13102.148360356547;13107.868921310856;13109.60671179866;7206.387457066208;7221.602811845294;7237.167725711611;7275.236100209508;7309.634518274172;6821.4542836572955;6827.829304267334;6873.20958089826;6906.37842594169;6918.757843475555;3894;4109.0549173690215;4288.292431748789;4296.505901821268;4413.073254616566;1716.0818961855348;1716.1419290354822;1731.8874273172203;1754.921028553718;1758.5867321179512;820.885076089348;941.8304705153138;951.9809603807885;957.2963871554402;996.5814357969671;15687.764683529756;16192.433264835674;16313.12399074098;16663.25015374311;16764;849.8809369613533;853.5646820121783;877.2674816528142;899.2131884600974;911.9863202051974;8669.739907802776;8834.911650883538;8962.507062111516;9127.722118903359;9286.814263714688;472108;475648;476984;504298;536482;42426.78786606047;43202.13595728131;64321.67839160774;65261.67369163124;68341.65829170922;1133.2973556395089;1134.920555561103;1139.1513322574735;1172.9589464368705;1176.8411264479357;15136.243187840344;15172.241387930339;15229.162396068323;15354.462593809163;15433.768493472831;31453.68546314599;32635.836820815744;32778.18054548655;32873.342533149684;33052;41852.790736046125;41862;42067.789661052724;42482;42773.572264278206;6902.896456553256;7211.639418029183;7230.783076507713;7323.890141647773;7339.348646554483;7978.122406535161;8907.465552066897;9459.432434053979;11193.552257909918;11411.942940285246;9387.812243755223;9519.381240219363;9742.512874356396;9973.800523989625;10102.494875256354;9099.954500227457;9611.231101512001;9690.418574885529;9773.706788796348;10005.54975026111;7861.960690196513;10007.149392301735;10185.490725463846;10197.694069177936;10325.63860264887;7049.400800931979;7262.600556969417;7314.81712957159;7360.227176146427;7458.403327733877;9198.080191980749;9404.858927116236;9968;10134.138598219233;10169.135623472088 23:32:04 INFO - PROCESS | 7641 | |3;mootools.html;1346.0443085409358;1468.933897974591;1476.4168153579333;1625.4879712890447;1790.3912669692302;6952.513324067318;7136.1793393759735;7396.889046664291;7498.362639175663;7542.5097368670995;7677;7690.115636701781;7752.883706744389;7758.185390533998;7762.49543779654;2293.0713061210195;2304.7349554801162;2308.6075367187536;2310.595645761993;2313.3406979010983;2249.730032396115;2263.7962583367494;2274.1358283852114;2284.9314520564326;2286.737025242102;2290.3129061281634;2309.8960546775434;2317.7450480447137;2339.894704738282;2343.6953196084487;2242.394553470554;2293.0827668932393;2297.24191016964;2300.5858945389823;2302.1251924268754;2228.8774117423536;2233.452804062999;2235.6422972324513;2236.3626366485637;2239.115549358011;7826.960865195694;7871.724489642892;7872.291493765589;7881.763547093597;7890.447668663196;4665.276882083249;4785.234362501983;4786.162421576245;4789.904201915977;4791.065742180276;3022.2142243016756;3025.7730670199603;3124.062781165664;3136;3152.921176970594;985.069109691342;992.1665800727424;1883.1808163448943;1891.1111777464569;1894.7821000584972;10159.949200254025;10254.333468324536;10263.332883362633;10265.230107741874;10270.794584108351;4027.0939038716056;4122.237386083584;4181.038361176947;4181.247375472383;4187.91624167515;8441.198086181803;8453.66185352579;8460.069392366835;8465.915340846514;8470.618822153017;4765.428148622187;4809.278608208797;4810.206315957827;4814.374131362971;4815.3499277597775;3863.9806800965816;3930.194310166409;3931.1941052084253;4433.135538570013;4445.555444455593;3349.0790032741193;3394.9830250848586;3491.94762078569;3550.609432962372;3561.3233485637647;1076.7361996310954;1134.4384529657873;1144.547903578082;1144.605111236622;1147.5696613769837;1042.9791404171874;1168.2231316174648;1181.0846593889805;1181.757739663367;1225.0689475998126;7369.8157546061775;7381.926180738124;7405.370543503863;7405.8889116663295;7408.185099639036;1188.4651906642046;1198.1313547677864;1202.7594481103815;1229.7294595189044;1255.1590434408968;5464.836054918359;5514.696691681996;5551.444855514497;5558.44415558449;5563.860903477364;8859.158379953895;9155.22180614642;9171.77070573241;9172.633094676272;9194.12655797698;8958.507282099417;8973.551322433852;9018.909810901938;9022.14289642483;9029.232515236146;7066.611336376549;7318.890216646648;7327.303906128909;7370.74202402924;7385.593792341473;7304.4156467483535;7335.7432489862595;7361.1166659999;7372.815679608053;7381.741639042608;8361.95819020901;8474.1949514796;8685.869711954452;8690.478571285743;8694.478331300143;8672;8734.56327183651;8933.865992009994;8938.910610894069;8955.641774328953;7092.148942126978;7115.466340024415;7177.533460325062;7182.604956727221;7209.0628218331285;6663.433608143362;6853.109095817711;7031.43748500129;7230;7242.710291588488;6942.305769423017;6967.651617419007;7030.086088808423;7057.858842823012;7202.027726256888;6648.867022659617;6682.3317668232785;6753.966230168818;6788.4569234462115;6899.724011039502;7010;7058.188308344606;7061.470389720895;7064.894026589503;7065.682044307916;6152.323244443018;6395.136656551306;6451.41937225652;6470.38531339522;6482.481401487964;6339;6591.967040164768;6600.207975043026;6613.338666133348;6614.107095542233 23:32:04 INFO - PROCESS | 7641 | |4;prototype.html;334.963154053054;340.80744379425624;341.67882190740704;343.1062083273075;346.029387567872;5729.427057294269;5840.269966254218;5894.793682221123;5899.498542623882;5905.616134951225;5613.298337707786;5801.332846722628;5833.795817146401;5840.707964601774;5846.88306233875;4507.278835386339;4512.255477846152;4513.0973805239;4517.390152329443;4527.954720452803;4352.238358287287;4442.400275962736;4465;4467.7319360838455;4513.638908887281;4419.867403977886;4437.267850804614;4494.325851122341;4499.977500112494;4500.774961251941;4478.753668548228;4481.081378317437;4484.910301793946;4488.035072459405;4501.167284052461;3979.522457305142;3982.7012974027066;3984.163325701606;3986.043349596105;3998.2203470323298;5447.1829225616075;5471.835844924659;5494.313210848644;5528.944710552883;5541.362743284533;5238.842834714965;5239.113918989161;5242.659227150223;5244.108501554707;5244.318238628954;5937.554683398763;6180.103884936704;6182.196314479134;6192.752289908398;6203.503719702413;4283.91432171358;4341.131773645284;4423.933640995388;4426.889327766799;4436.423264975565;6500.317466666026;6502.382273683992;6511.67441627912;6518.120053792724;6519.250286217051;4546.29532422475;4552;4553.089382123589;4555.9772201138785;4562.08758248345;4490.910181796411;4536.818527258939;4544.045750392388;4599.701019433726;4605.470370907322;5208.7916483341;5210.811459187151;5213.244079608436;5216.139337009351;5218.739063046833;6281.120643109968;6281.59169653971;6284.905726414107;6286.339934306832;6295.622262664255;1620.1899050474763;1642.4314779385659;1644.1368281652228;1644.399794075154;1646.9341226350812;1114.331401159298;1117.536222467683;1128.198978725098;1128.8476055732372;1157.0512180012477;5991.730372133265;5998.700064996733;6001.279846418371;6002.459778619946;6006.279246490449;6412.61524308543;6419.101325814389;6422.4862011039;6424.839379015562;6437;5866.442687944638;5990.460858522754;5991.310999235144;5992.910106348409;5999.220101386792;3435.7766745161985;3466.272082862627;3467.1505481156773;3468.757186996886;3469.3928562501965;6721.764738234138;6724.159480064992;6736.966315168393;6739.663016849138;6746;6577.473802095821;6582.17722784652;6582.63795491243;6588.637624930675;6595.769148079794;6546.443552298013;6706.5640733352175;6708.865822683519;6713.832154196087;6714.630695311805;6227.9377206227355;6380.979043353042;6398.168238129014;6399.328070552711;6411.4870810336;6291;6434.64609446485;6454.386833250834;6471.870562588816;6473.320301368289;6780.084688567177;6783.559068660521;6785.389314961677;6787.287334829772;6797.456203503807;4474.26174681174;4502.414686090788;4502.887427814331;4503.076869241863;4510.684252102321;6408.775692850728;6416.262129855127;6460.580062295936;6468.353164683494;6473.255575608865;6235.438810507076;6305.369463053841;6312.715927783169;6315.084312774714;6320.810375688737;6203.710639997894;6266.561340706106;6277.15258440123;6310.242770867341;6326.398992095744;6171.1668924694595;6171.382861713792;6182.103594978793;6182.845428864314;6189.535784816067;6323.715432805443;6324.209473815773;6325.841853953688;6327.715252813542;6331.9366806331345;6042.577019608585;6128.601640893327;6146.815595531963;6152.969235153795;6161.260648722003 23:32:04 INFO - PROCESS | 7641 | |5;yui.html;786.5162924801247;794.9801254968627;810.6919370639156;835.3233880556745;843.3548335523321;12687.873121268785;12841.678958026054;12842.22946623202;12857;12890.226586404799;11836.644900652995;11839.526418943253;11856.881431185686;11865.228760130585;11895.464704088316;652.6671397587218;656.940875321221;772.8029352515101;776.0532150776044;779.672537534237;783.1189911349732;784.8155683414393;787.208855100623;787.3268355556003;788.5662885413028;831.1729828820332;831.6714897615439;831.8585840407115;833.0128797375099;836.0719601242616;667.4093427316835;679.8300424893802;819.8237378963491;830.2195935820309;835.6949713354643;613.3774219167549;616.8396216983616;621.7202258983431;622.0078974036404;622.1507642068544;11701.3564253966;11723.589674361441;11746.765064698744;11795.115366347558;11883.762324753456;11947.402629868559;12650.746985060247;12702.936485317607;12927.159734617313;13064.86935130646;10098.545565449573;10126.949365253127;10141.847872281922;10194.59221631134;10455.94772026135;3541.8229088545468;3564.590072141711;3626.673599376069;3629.1834337274167;3737.5514938207316;43246.78376608128;43361;43811.342829857575;43857.34213986793;44416.55583444156;9595.28035397348;9893.862205846275;9918.851217231748;9952.651657191964;9964.252681048805;16398.426055088014;16549.50351489457;16555.834441655672;16557.751633725504;16563.08903010346;7671.846563068819;7711.305982461606;7775.066991961001;7833.686652533949;7964.123946365895;4287.807048682755;4332.956670433318;4432.689711720213;4481.551844815493;4498.415206023196;3078.338157296192;3121.3913286909287;3134.326119884236;3138.0115263691864;3142.245860993345;574.6236215278915;583.5914859598298;594.0524862843757;607.1227076873963;611.0742225528328;620.9689515524205;631.6797892404895;639.9264084630234;661.4311691944923;675.3246753246754;7649.541027538366;7666.769996900102;8103.0681471631515;9069.59186836594;9100;494.37461611062037;523.4791382574363;562.8789810190829;641.1408712325506;691.2914262880588;3523.365794157025;3689.5203623529305;3747.775133491999;3783.9243215135543;3900.297946369624;52161;52241;52435;53161.468385316424;53274.20088698673;49190.262146067835;49525.50474495281;49721;49724.254136187985;50380;20982.37052888416;21072.473188170112;21127.154913803584;38755.61244387576;43207.35188972231;7402.222766609644;7578.242175782378;7641.617919103911;7743.0090223841535;7745.302922736981;31940.84029579837;32531.83734081409;32533.511997320533;32618.51072233871;32619.510707339883;39258.803705981285;39334.40998385084;40969.59030409658;42638.36042459303;43111.56888431201;9933.503324833873;9939.701808945743;10033.598656053968;10035.24735644844;10063.899361006297;10915.781684366428;10970.561177553127;11150.944245278723;11280.548778048786;11340.175457770141;9984.650537231162;10130.8480372793;10279.074883260542;10296.433696146783;10758.892411075789;10011.749706257402;10085.798284034132;10452.843207352047;10481.528331225265;10820.513076911715;10247.38515689061;10308.501514498117;10348.430836304076;10470.738231543968;10486.842697359698;8659.567021649018;8713.390062695804;8834.204921557091;8940.73177804667;8943.776405589912;8771.122887711177;8866.290696744374;10065.892188209053;10081.312189831764;10241.231907607109 23:32:04 INFO - PROCESS | 7641 | __end_tp_report 23:32:04 INFO - PROCESS | 7641 | __start_cc_report 23:32:04 INFO - PROCESS | 7641 | _x_x_mozilla_cycle_collect,800 23:32:04 INFO - PROCESS | 7641 | __end_cc_report 23:32:04 INFO - PROCESS | 7641 | __startTimestamp1452583924427__endTimestamp 23:32:04 INFO - PROCESS | 7641 | 23:32:04 INFO - PROCESS | 7641 | ------- Summary: start ------- 23:32:04 INFO - PROCESS | 7641 | Number of tests: 6 23:32:04 INFO - PROCESS | 7641 | 23:32:04 INFO - PROCESS | 7641 | [#0] dojo.html Cycles:165 Average:4962.62 Median:5175.82 stddev:632.21 (12.2%) stddev-sans-first:616.01 23:32:04 INFO - PROCESS | 7641 | Values: 3046.0 3091.4 3142.0 3144.0 3167.2 4904.8 4995.8 5005.2 5019.7 5063.7 4932.8 4951.1 4978.7 4999.9 5059.6 4593.5 4614.7 4626.6 4647.6 4716.4 473.6 4471.9 4556.5 4590.5 4653.3 4570.7 4604.9 4606.8 4609.5 4612.1 4545.3 4594.5 4606.5 4617.9 4633.2 4535.5 4546.3 4547.6 4554.5 4583.5 4741.4 4853.2 4859.4 4876.8 4937.1 5289.2 5302.6 5353.9 5412.8 5452.9 5371.6 5399.4 5407.5 5409.0 5410.4 4933.0 4979.6 4999.3 5025.6 5073.1 5445.4 5471.0 5491.4 5537.3 5556.5 5239.9 5281.7 5288.8 5292.6 5338.0 5338.6 5350.9 5353.5 5357.1 5359.5 5175.8 5252.7 5284.1 5382.5 5396.8 5261.9 5267.4 5268.8 5270.1 5278.6 4140.0 4147.9 4148.7 4189.6 4193.6 3696.0 3775.0 3781.7 3807.4 3840.0 5045.2 5061.4 5062.6 5069.4 5116.8 5195.5 5360.1 5368.6 5368.6 5415.6 4962.3 4971.7 5008.0 5058.5 5089.6 4553.1 4577.4 4579.1 4580.3 4630.3 5421.4 5547.0 5576.1 5576.9 5586.2 5300.0 5310.9 5344.7 5368.2 5422.2 5546.8 5565.8 5567.8 5571.7 5608.2 5195.9 5296.7 5296.7 5327.1 5383.1 5323.7 5381.1 5401.9 5434.9 5438.9 5244.6 5247.8 5253.8 5256.1 5278.5 5244.5 5254.1 5256.9 5266.7 5318.5 4983.1 5130.1 5141.8 5150.6 5261.9 5231.3 5258.2 5260.4 5261.4 5264.2 5110.7 5154.9 5171.4 5179.9 5220.0 23:32:04 INFO - PROCESS | 7641 | 23:32:04 INFO - PROCESS | 7641 | [#1] ext.html Cycles:180 Average:44032.40 Median:3203.58 stddev:73760.88 (2302.5%) stddev-sans-first:73895.45 23:32:04 INFO - PROCESS | 7641 | Values: 520.4 539.2 539.2 560.3 576.2 28081.6 28630.3 35465.0 35807.0 35877.8 38603.4 39166.6 39173.4 39196.6 39251.2 7083.3 8307.6 8497.8 8551.7 8565.0 7525.8 7687.5 7692.5 10003.1 10217.0 9912.6 9979.6 9996.8 9999.7 10013.8 9825.0 9907.2 9911.6 9918.1 9922.1 9723.0 9759.5 9885.6 9896.9 9906.3 39129.4 39663.0 39664.2 39665.8 39735.0 3198.9 3208.2 3255.1 3262.1 3604.1 30030.5 30134.1 30235.0 30523.1 31160.0 3930.5 3939.6 3952.9 3997.2 4016.2 270027.6 270926.0 271021.0 273153.0 273510.0 51098.0 52345.2 58490.0 58856.4 58946.1 60565.7 62246.7 62446.4 62482.4 62536.0 13555.8 13727.6 13741.7 13762.8 13806.9 10064.1 10159.4 10163.0 10575.8 10887.5 18679.1 18897.1 18920.2 19026.1 19041.9 7677.8 7931.0 8007.0 8057.4 8058.6 880.2 964.0 1003.8 1020.9 1102.4 24323.4 24698.4 27940.3 28774.4 29050.4 1006.7 1024.8 1071.1 1102.2 1108.2 12949.0 12997.1 13037.9 13095.2 13110.6 265378.0 267407.0 267965.0 268578.0 269199.0 47814.8 48724.8 48736.8 48810.8 48813.8 1232.9 1233.4 1306.9 1326.4 1365.7 24327.1 25507.0 25757.5 25814.4 25937.4 37170.8 37310.3 37386.0 37470.0 37471.6 304420.0 305327.0 305743.0 306501.0 306581.0 26899.0 30684.8 31036.8 31211.0 31470.4 36374.5 37348.0 37686.2 37730.4 37733.0 31258.7 31642.8 31820.8 32282.8 32553.2 27752.4 31774.2 32233.8 35868.5 36312.3 31484.8 31880.2 32230.7 32253.7 32340.8 28848.3 30764.2 30915.0 31244.4 31248.8 23206.9 23881.8 25951.6 26318.2 26337.0 23:32:04 INFO - PROCESS | 7641 | 23:32:04 INFO - PROCESS | 7641 | [#2] jquery.html Cycles:180 Average:25337.79 Median:23807.60 stddev:80522.42 (338.2%) stddev-sans-first:80726.48 23:32:04 INFO - PROCESS | 7641 | Values: 367.0 369.8 371.6 372.6 380.7 13699.3 14252.0 16203.1 16761.6 17439.4 10085.8 10457.0 16050.0 16432.0 16456.4 3748.5 4812.0 4969.0 4972.0 4979.7 3842.3 3876.8 3878.5 5322.8 5536.6 5405.4 5550.4 5553.6 5960.8 5966.9 5671.5 5920.6 5960.8 5965.3 5970.1 5280.8 5284.7 5288.3 5298.8 5310.8 12189.8 12580.9 12628.7 12632.7 12634.3 1876.6 1917.3 1946.2 1966.2 1980.7 12186.6 12286.1 12335.5 12494.3 12864.4 1598.0 1762.6 1810.4 1838.5 1855.4 51944.5 53266.2 53401.7 53451.5 53950.7 9627.7 9798.3 9950.9 9984.6 10010.0 12996.4 13098.9 13102.1 13107.9 13109.6 7206.4 7221.6 7237.2 7275.2 7309.6 6821.5 6827.8 6873.2 6906.4 6918.8 3894.0 4109.1 4288.3 4296.5 4413.1 1716.1 1716.1 1731.9 1754.9 1758.6 820.9 941.8 952.0 957.3 996.6 15687.8 16192.4 16313.1 16663.3 16764.0 849.9 853.6 877.3 899.2 912.0 8669.7 8834.9 8962.5 9127.7 9286.8 472108.0 475648.0 476984.0 504298.0 536482.0 42426.8 43202.1 64321.7 65261.7 68341.7 1133.3 1134.9 1139.2 1173.0 1176.8 15136.2 15172.2 15229.2 15354.5 15433.8 31453.7 32635.8 32778.2 32873.3 33052.0 41852.8 41862.0 42067.8 42482.0 42773.6 6902.9 7211.6 7230.8 7323.9 7339.3 7978.1 8907.5 9459.4 11193.6 11411.9 9387.8 9519.4 9742.5 9973.8 10102.5 9100.0 9611.2 9690.4 9773.7 10005.5 7862.0 10007.1 10185.5 10197.7 10325.6 7049.4 7262.6 7314.8 7360.2 7458.4 9198.1 9404.9 9968.0 10134.1 10169.1 23:32:04 INFO - PROCESS | 7641 | 23:32:04 INFO - PROCESS | 7641 | [#3] mootools.html Cycles:180 Average:5417.91 Median:6423.28 stddev:2741.13 (42.7%) stddev-sans-first:2731.72 23:32:04 INFO - PROCESS | 7641 | Values: 1346.0 1468.9 1476.4 1625.5 1790.4 6952.5 7136.2 7396.9 7498.4 7542.5 7677.0 7690.1 7752.9 7758.2 7762.5 2293.1 2304.7 2308.6 2310.6 2313.3 2249.7 2263.8 2274.1 2284.9 2286.7 2290.3 2309.9 2317.7 2339.9 2343.7 2242.4 2293.1 2297.2 2300.6 2302.1 2228.9 2233.5 2235.6 2236.4 2239.1 7827.0 7871.7 7872.3 7881.8 7890.4 4665.3 4785.2 4786.2 4789.9 4791.1 3022.2 3025.8 3124.1 3136.0 3152.9 985.1 992.2 1883.2 1891.1 1894.8 10159.9 10254.3 10263.3 10265.2 10270.8 4027.1 4122.2 4181.0 4181.2 4187.9 8441.2 8453.7 8460.1 8465.9 8470.6 4765.4 4809.3 4810.2 4814.4 4815.3 3864.0 3930.2 3931.2 4433.1 4445.6 3349.1 3395.0 3491.9 3550.6 3561.3 1076.7 1134.4 1144.5 1144.6 1147.6 1043.0 1168.2 1181.1 1181.8 1225.1 7369.8 7381.9 7405.4 7405.9 7408.2 1188.5 1198.1 1202.8 1229.7 1255.2 5464.8 5514.7 5551.4 5558.4 5563.9 8859.2 9155.2 9171.8 9172.6 9194.1 8958.5 8973.6 9018.9 9022.1 9029.2 7066.6 7318.9 7327.3 7370.7 7385.6 7304.4 7335.7 7361.1 7372.8 7381.7 8362.0 8474.2 8685.9 8690.5 8694.5 8672.0 8734.6 8933.9 8938.9 8955.6 7092.1 7115.5 7177.5 7182.6 7209.1 6663.4 6853.1 7031.4 7230.0 7242.7 6942.3 6967.7 7030.1 7057.9 7202.0 6648.9 6682.3 6754.0 6788.5 6899.7 7010.0 7058.2 7061.5 7064.9 7065.7 6152.3 6395.1 6451.4 6470.4 6482.5 6339.0 6592.0 6600.2 6613.3 6614.1 23:32:04 INFO - PROCESS | 7641 | 23:32:04 INFO - PROCESS | 7641 | [#4] prototype.html Cycles:180 Average:5239.29 Median:5921.59 stddev:1564.42 (26.4%) stddev-sans-first:1524.89 23:32:04 INFO - PROCESS | 7641 | Values: 335.0 340.8 341.7 343.1 346.0 5729.4 5840.3 5894.8 5899.5 5905.6 5613.3 5801.3 5833.8 5840.7 5846.9 4507.3 4512.3 4513.1 4517.4 4528.0 4352.2 4442.4 4465.0 4467.7 4513.6 4419.9 4437.3 4494.3 4500.0 4500.8 4478.8 4481.1 4484.9 4488.0 4501.2 3979.5 3982.7 3984.2 3986.0 3998.2 5447.2 5471.8 5494.3 5528.9 5541.4 5238.8 5239.1 5242.7 5244.1 5244.3 5937.6 6180.1 6182.2 6192.8 6203.5 4283.9 4341.1 4423.9 4426.9 4436.4 6500.3 6502.4 6511.7 6518.1 6519.3 4546.3 4552.0 4553.1 4556.0 4562.1 4490.9 4536.8 4544.0 4599.7 4605.5 5208.8 5210.8 5213.2 5216.1 5218.7 6281.1 6281.6 6284.9 6286.3 6295.6 1620.2 1642.4 1644.1 1644.4 1646.9 1114.3 1117.5 1128.2 1128.8 1157.1 5991.7 5998.7 6001.3 6002.5 6006.3 6412.6 6419.1 6422.5 6424.8 6437.0 5866.4 5990.5 5991.3 5992.9 5999.2 3435.8 3466.3 3467.2 3468.8 3469.4 6721.8 6724.2 6737.0 6739.7 6746.0 6577.5 6582.2 6582.6 6588.6 6595.8 6546.4 6706.6 6708.9 6713.8 6714.6 6227.9 6381.0 6398.2 6399.3 6411.5 6291.0 6434.6 6454.4 6471.9 6473.3 6780.1 6783.6 6785.4 6787.3 6797.5 4474.3 4502.4 4502.9 4503.1 4510.7 6408.8 6416.3 6460.6 6468.4 6473.3 6235.4 6305.4 6312.7 6315.1 6320.8 6203.7 6266.6 6277.2 6310.2 6326.4 6171.2 6171.4 6182.1 6182.8 6189.5 6323.7 6324.2 6325.8 6327.7 6331.9 6042.6 6128.6 6146.8 6153.0 6161.3 23:32:04 INFO - PROCESS | 7641 | 23:32:04 INFO - PROCESS | 7641 | [#5] yui.html Cycles:180 Average:12497.62 Median:24145.02 stddev:14239.74 (59.0%) stddev-sans-first:14252.53 23:32:04 INFO - PROCESS | 7641 | Values: 786.5 795.0 810.7 835.3 843.4 12687.9 12841.7 12842.2 12857.0 12890.2 11836.6 11839.5 11856.9 11865.2 11895.5 652.7 656.9 772.8 776.1 779.7 783.1 784.8 787.2 787.3 788.6 831.2 831.7 831.9 833.0 836.1 667.4 679.8 819.8 830.2 835.7 613.4 616.8 621.7 622.0 622.2 11701.4 11723.6 11746.8 11795.1 11883.8 11947.4 12650.7 12702.9 12927.2 13064.9 10098.5 10126.9 10141.8 10194.6 10455.9 3541.8 3564.6 3626.7 3629.2 3737.6 43246.8 43361.0 43811.3 43857.3 44416.6 9595.3 9893.9 9918.9 9952.7 9964.3 16398.4 16549.5 16555.8 16557.8 16563.1 7671.8 7711.3 7775.1 7833.7 7964.1 4287.8 4333.0 4432.7 4481.6 4498.4 3078.3 3121.4 3134.3 3138.0 3142.2 574.6 583.6 594.1 607.1 611.1 621.0 631.7 639.9 661.4 675.3 7649.5 7666.8 8103.1 9069.6 9100.0 494.4 523.5 562.9 641.1 691.3 3523.4 3689.5 3747.8 3783.9 3900.3 52161.0 52241.0 52435.0 53161.5 53274.2 49190.3 49525.5 49721.0 49724.3 50380.0 20982.4 21072.5 21127.2 38755.6 43207.4 7402.2 7578.2 7641.6 7743.0 7745.3 31940.8 32531.8 32533.5 32618.5 32619.5 39258.8 39334.4 40969.6 42638.4 43111.6 9933.5 9939.7 10033.6 10035.2 10063.9 10915.8 10970.6 11150.9 11280.5 11340.2 9984.7 10130.8 10279.1 10296.4 10758.9 10011.7 10085.8 10452.8 10481.5 10820.5 10247.4 10308.5 10348.4 10470.7 10486.8 8659.6 8713.4 8834.2 8940.7 8943.8 8771.1 8866.3 10065.9 10081.3 10241.2 23:32:04 INFO - PROCESS | 7641 | -------- Summary: end -------- 23:32:04 INFO - PROCESS | 7641 | 23:32:05 INFO - TEST-INFO | 7641: exit 0 23:32:05 INFO - TEST-OK | dromaeo_css | took 1111266ms 23:32:05 INFO - TEST-START | kraken 23:32:05 INFO - operating with platform_type : linux_ 23:32:05 INFO - Initialising browser for kraken test... 23:32:05 INFO - TEST-INFO | started process 7830 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpay9w_K/profile http://localhost:39726/getInfo.html) 23:32:09 INFO - PROCESS | 7830 | __metrics Screen width/height:1600/1200 23:32:09 INFO - PROCESS | 7830 | colorDepth:24 23:32:09 INFO - PROCESS | 7830 | Browser inner width/height: 1024/697 23:32:09 INFO - PROCESS | 7830 | __metrics 23:32:09 INFO - PROCESS | 7830 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:32:09 INFO - PROCESS | 7830 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:32:10 INFO - TEST-INFO | 7830: exit 0 23:32:10 INFO - Browser initialized. 23:32:10 INFO - Running cycle 1/1 for kraken test... 23:32:10 INFO - TEST-INFO | started process 7911 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpay9w_K/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:32:21 INFO - PROCESS | 7911 | RSS: Main: 149078016 23:32:21 INFO - PROCESS | 7911 | 23:32:24 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39726/tests/kraken/driver.html?testName=audio-beat-detection) 23:32:24 INFO - PROCESS | 7911 | RSS: Main: 186167296 23:32:24 INFO - PROCESS | 7911 | 23:32:27 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39726/tests/kraken/driver.html?testName=audio-dft) 23:32:28 INFO - PROCESS | 7911 | RSS: Main: 176058368 23:32:28 INFO - PROCESS | 7911 | 23:32:31 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39726/tests/kraken/driver.html?testName=audio-fft) 23:32:31 INFO - PROCESS | 7911 | RSS: Main: 161275904 23:32:31 INFO - PROCESS | 7911 | 23:32:33 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39726/tests/kraken/driver.html?testName=audio-oscillator) 23:32:34 INFO - PROCESS | 7911 | RSS: Main: 161808384 23:32:34 INFO - PROCESS | 7911 | 23:32:36 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39726/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:32:36 INFO - PROCESS | 7911 | RSS: Main: 163405824 23:32:36 INFO - PROCESS | 7911 | 23:32:39 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39726/tests/kraken/driver.html?testName=imaging-darkroom) 23:32:40 INFO - PROCESS | 7911 | RSS: Main: 165335040 23:32:40 INFO - PROCESS | 7911 | 23:32:43 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39726/tests/kraken/driver.html?testName=imaging-desaturate) 23:32:44 INFO - PROCESS | 7911 | RSS: Main: 165195776 23:32:44 INFO - PROCESS | 7911 | 23:32:47 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39726/tests/kraken/driver.html?testName=json-parse-financial) 23:32:47 INFO - PROCESS | 7911 | RSS: Main: 164732928 23:32:47 INFO - PROCESS | 7911 | 23:32:49 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39726/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:32:49 INFO - PROCESS | 7911 | RSS: Main: 175689728 23:32:49 INFO - PROCESS | 7911 | 23:32:51 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39726/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:32:52 INFO - PROCESS | 7911 | RSS: Main: 175931392 23:32:52 INFO - PROCESS | 7911 | 23:32:54 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39726/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:32:54 INFO - PROCESS | 7911 | RSS: Main: 189100032 23:32:54 INFO - PROCESS | 7911 | 23:32:57 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:32:57 INFO - PROCESS | 7911 | RSS: Main: 193146880 23:32:57 INFO - PROCESS | 7911 | 23:33:00 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:33:00 INFO - PROCESS | 7911 | RSS: Main: 191655936 23:33:00 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | Cycle 1(1): loaded http://localhost:39726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39726/tests/kraken/driver.html?testName=ai-astar) 23:33:02 INFO - PROCESS | 7911 | RSS: Main: 249479168 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | __start_tp_report 23:33:02 INFO - PROCESS | 7911 | _x_x_mozilla_page_load 23:33:02 INFO - PROCESS | 7911 | _x_x_mozilla_page_load_details 23:33:02 INFO - PROCESS | 7911 | |i|pagename|runs| 23:33:02 INFO - PROCESS | 7911 | |0;ai-astar;110;112;105;110;110;111;99;110;110;111 23:33:02 INFO - PROCESS | 7911 | |1;audio-beat-detection;156;126;148;169;129;152;150;127;169;126 23:33:02 INFO - PROCESS | 7911 | |2;audio-dft;162;161;162;160;163;163;160;161;161;163 23:33:02 INFO - PROCESS | 7911 | |3;audio-fft;72;74;89;93;72;72;73;100;94;71 23:33:02 INFO - PROCESS | 7911 | |4;audio-oscillator;97;96;140;95;96;98;150;95;97;136 23:33:02 INFO - PROCESS | 7911 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 23:33:02 INFO - PROCESS | 7911 | |6;imaging-darkroom;147;145;145;146;146;146;145;146;145;146 23:33:02 INFO - PROCESS | 7911 | |7;imaging-desaturate;95;96;96;96;96;96;95;96;96;96 23:33:02 INFO - PROCESS | 7911 | |8;json-parse-financial;55;55;60;56;55;56;55;65;55;54 23:33:02 INFO - PROCESS | 7911 | |9;json-stringify-tinderbox;66;67;68;67;68;68;68;68;67;67 23:33:02 INFO - PROCESS | 7911 | |10;stanford-crypto-aes;85;87;86;87;86;85;93;94;89;85 23:33:02 INFO - PROCESS | 7911 | |11;stanford-crypto-ccm;119;117;127;113;128;116;114;127;118;114 23:33:02 INFO - PROCESS | 7911 | |12;stanford-crypto-pbkdf2;142;142;157;155;150;142;150;150;151;141 23:33:02 INFO - PROCESS | 7911 | |13;stanford-crypto-sha256-iterative;67;69;66;66;66;68;67;68;68;69 23:33:02 INFO - PROCESS | 7911 | __end_tp_report 23:33:02 INFO - PROCESS | 7911 | __start_cc_report 23:33:02 INFO - PROCESS | 7911 | _x_x_mozilla_cycle_collect,924 23:33:02 INFO - PROCESS | 7911 | __end_cc_report 23:33:02 INFO - PROCESS | 7911 | __startTimestamp1452583982883__endTimestamp 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | ------- Summary: start ------- 23:33:02 INFO - PROCESS | 7911 | Number of tests: 14 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.91 (3.5%) stddev-sans-first:4.12 23:33:02 INFO - PROCESS | 7911 | Values: 110.0 112.0 105.0 110.0 110.0 111.0 99.0 110.0 110.0 111.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:151.00 stddev:17.18 (11.4%) stddev-sans-first:17.78 23:33:02 INFO - PROCESS | 7911 | Values: 156.0 126.0 148.0 169.0 129.0 152.0 150.0 127.0 169.0 126.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 23:33:02 INFO - PROCESS | 7911 | Values: 162.0 161.0 162.0 160.0 163.0 163.0 160.0 161.0 161.0 163.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#3] audio-fft Cycles:10 Average:81.00 Median:73.50 stddev:11.52 (15.7%) stddev-sans-first:11.75 23:33:02 INFO - PROCESS | 7911 | Values: 72.0 74.0 89.0 93.0 72.0 72.0 73.0 100.0 94.0 71.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:22.36 (23.3%) stddev-sans-first:23.22 23:33:02 INFO - PROCESS | 7911 | Values: 97.0 96.0 140.0 95.0 96.0 98.0 150.0 95.0 97.0 136.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 23:33:02 INFO - PROCESS | 7911 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 23:33:02 INFO - PROCESS | 7911 | Values: 147.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 23:33:02 INFO - PROCESS | 7911 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:55.50 stddev:3.37 (6.1%) stddev-sans-first:3.53 23:33:02 INFO - PROCESS | 7911 | Values: 55.0 55.0 60.0 56.0 55.0 56.0 55.0 65.0 55.0 54.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 23:33:02 INFO - PROCESS | 7911 | Values: 66.0 67.0 68.0 67.0 68.0 68.0 68.0 68.0 67.0 67.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.00 stddev:3.30 (3.8%) stddev-sans-first:3.35 23:33:02 INFO - PROCESS | 7911 | Values: 85.0 87.0 86.0 87.0 86.0 85.0 93.0 94.0 89.0 85.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:118.50 stddev:5.85 (4.9%) stddev-sans-first:6.20 23:33:02 INFO - PROCESS | 7911 | Values: 119.0 117.0 127.0 113.0 128.0 116.0 114.0 127.0 118.0 114.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:150.00 stddev:5.85 (3.9%) stddev-sans-first:5.79 23:33:02 INFO - PROCESS | 7911 | Values: 142.0 142.0 157.0 155.0 150.0 142.0 150.0 150.0 151.0 141.0 23:33:02 INFO - PROCESS | 7911 | 23:33:02 INFO - PROCESS | 7911 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.17 (1.7%) stddev-sans-first:1.24 23:33:02 INFO - PROCESS | 7911 | Values: 67.0 69.0 66.0 66.0 66.0 68.0 67.0 68.0 68.0 69.0 23:33:02 INFO - PROCESS | 7911 | -------- Summary: end -------- 23:33:02 INFO - PROCESS | 7911 | 23:33:03 INFO - TEST-INFO | 7911: exit 0 23:33:03 INFO - TEST-OK | kraken | took 58642ms 23:33:03 INFO - TEST-START | v8_7 23:33:03 INFO - operating with platform_type : linux_ 23:33:03 INFO - Initialising browser for v8_7 test... 23:33:03 INFO - TEST-INFO | started process 8158 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGiEjeX/profile http://localhost:39726/getInfo.html) 23:33:07 INFO - PROCESS | 8158 | __metrics Screen width/height:1600/1200 23:33:07 INFO - PROCESS | 8158 | colorDepth:24 23:33:07 INFO - PROCESS | 8158 | Browser inner width/height: 1024/697 23:33:07 INFO - PROCESS | 8158 | __metrics 23:33:07 INFO - PROCESS | 8158 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:33:07 INFO - PROCESS | 8158 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:33:08 INFO - TEST-INFO | 8158: exit 0 23:33:08 INFO - Browser initialized. 23:33:08 INFO - Running cycle 1/1 for v8_7 test... 23:33:08 INFO - TEST-INFO | started process 8243 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGiEjeX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:33:20 INFO - PROCESS | 8243 | RSS: Main: 149180416 23:33:20 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | Cycle 1(1): loaded http://localhost:39726/tests/v8_7/run.html (next: http://localhost:39726/tests/v8_7/run.html) 23:33:42 INFO - PROCESS | 8243 | RSS: Main: 575184896 23:33:42 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | __start_tp_report 23:33:42 INFO - PROCESS | 8243 | _x_x_mozilla_page_load 23:33:42 INFO - PROCESS | 8243 | _x_x_mozilla_page_load_details 23:33:42 INFO - PROCESS | 8243 | |i|pagename|runs| 23:33:42 INFO - PROCESS | 8243 | |0;Richards;166.9727834362999 23:33:42 INFO - PROCESS | 8243 | |1;DeltaBlue;191.05846388995033 23:33:42 INFO - PROCESS | 8243 | |2;Encrypt;280.0336040324839 23:33:42 INFO - PROCESS | 8243 | |3;Decrypt;5159.79381443299 23:33:42 INFO - PROCESS | 8243 | |4;RayTrace;2049.1803278688526 23:33:42 INFO - PROCESS | 8243 | |5;Earley;798.7220447284345 23:33:42 INFO - PROCESS | 8243 | |6;Boyer;12358.024691358025 23:33:42 INFO - PROCESS | 8243 | |7;RegExp;42208.333333333336 23:33:42 INFO - PROCESS | 8243 | |8;Splay;617.283950617284 23:33:42 INFO - PROCESS | 8243 | |9;NavierStokes;4822.115384615385 23:33:42 INFO - PROCESS | 8243 | __end_tp_report 23:33:42 INFO - PROCESS | 8243 | __startTimestamp1452584022732__endTimestamp 23:33:42 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | ------- Summary: start ------- 23:33:42 INFO - PROCESS | 8243 | Number of tests: 10 23:33:42 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | [#0] Richards Cycles:1 Average:166.97 Median:166.97 stddev:0.00 (0.0%) 23:33:42 INFO - PROCESS | 8243 | Values: 167.0 23:33:42 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | [#1] DeltaBlue Cycles:1 Average:191.06 Median:191.06 stddev:0.00 (0.0%) 23:33:42 INFO - PROCESS | 8243 | Values: 191.1 23:33:42 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 23:33:42 INFO - PROCESS | 8243 | Values: 280.0 23:33:42 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 23:33:42 INFO - PROCESS | 8243 | Values: 5159.8 23:33:42 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | [#4] RayTrace Cycles:1 Average:2049.18 Median:2049.18 stddev:0.00 (0.0%) 23:33:42 INFO - PROCESS | 8243 | Values: 2049.2 23:33:42 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | [#5] Earley Cycles:1 Average:798.72 Median:798.72 stddev:0.00 (0.0%) 23:33:42 INFO - PROCESS | 8243 | Values: 798.7 23:33:42 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 23:33:42 INFO - PROCESS | 8243 | Values: 12358.0 23:33:42 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | [#7] RegExp Cycles:1 Average:42208.33 Median:42208.33 stddev:0.00 (0.0%) 23:33:42 INFO - PROCESS | 8243 | Values: 42208.3 23:33:42 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | [#8] Splay Cycles:1 Average:617.28 Median:617.28 stddev:0.00 (0.0%) 23:33:42 INFO - PROCESS | 8243 | Values: 617.3 23:33:42 INFO - PROCESS | 8243 | 23:33:42 INFO - PROCESS | 8243 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 23:33:42 INFO - PROCESS | 8243 | Values: 4822.1 23:33:42 INFO - PROCESS | 8243 | -------- Summary: end -------- 23:33:42 INFO - PROCESS | 8243 | 23:33:43 INFO - TEST-INFO | 8243: exit 0 23:33:43 INFO - TEST-OK | v8_7 | took 39838ms 23:33:43 INFO - SUITE-END | took 1209s 23:33:43 INFO - Completed test suite (00:20:10) 23:33:43 INFO - Working with test: dromaeo_css 23:33:43 INFO - Generating results file: dromaeo_css 23:33:43 INFO - Working with test: kraken 23:33:43 INFO - Generating results file: kraken 23:33:43 INFO - javascript benchmark 23:33:43 INFO - Working with test: v8_7 23:33:43 INFO - Generating results file: v8_7 23:33:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:33:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:33:43 INFO - process_Request line: dromaeo_css 6650.15 graph.html#tests=[[72,201,35]] 23:33:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:33:43 INFO - process_Request line: kraken 1503.50 graph.html#tests=[[232,201,35]] 23:33:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:33:44 INFO - process_Request line: v8_7 18757.14 graph.html#tests=[[230,201,35]] 23:33:44 INFO - RETURN: dromaeo_css: 6650.15 23:33:44 INFO - RETURN: kraken: 1503.50 23:33:44 INFO - RETURN: v8_7: 18757.14 23:33:44 INFO - javascript benchmark 23:33:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3045.9847700761493, 3091.4435401627698, 3142.0416772884278, 3144.025352140835, 3167.2240301126226, 4904.828331008415, 4995.775190116445, 5005.19916813309, 5019.673721208123, 5063.670861394007, 4932.802687892489, 4951.0592987332475, 4978.701277923327, 4999.900001999967, 5059.620528460362, 4593.517680643526, 4614.700044497114, 4626.6298696104395, 4647.581717645411, 4716.410448693913, 473.58524147430495, 4471.88820279494, 4556.544345565433, 4590.5409459054, 4653.325267836161, 4570.680052396334, 4604.907901841978, 4606.792694328729, 4609.516000819916, 4612.123696497655, 4545.2954792007295, 4594.494605593415, 4606.470255920545, 4617.930731039037, 4633.1660301145785, 4535.501094879561, 4546.29532422475, 4547.613452856511, 4554.4990051094355, 4583.472900616439, 4741.431028276629, 4853.174960256765, 4859.441164266119, 4876.804927802884, 4937.111319962405, 5289.20661900718, 5302.628815982883, 5353.9196912046355, 5412.783488660449, 5452.863678408032, 5371.597130215249, 5399.406065332811, 5407.5133238008375, 5409.0, 5410.3507579090765, 4933.0, 4979.6265280104135, 4999.250112483121, 5025.597952163855, 5073.112205364084, 5445.428230035868, 5471.042567550663, 5491.423400542965, 5537.307836520435, 5556.499915007668, 5239.895202095937, 5281.735913204325, 5288.762005709752, 5292.603054770908, 5338.0, 5338.572914166857, 5350.91973620396, 5353.491418315254, 5357.142857142916, 5359.544438722753, 5175.81884634036, 5252.684838909678, 5284.128118860422, 5382.542483888913, 5396.784128634889, 5261.868698229822, 5267.367915850123, 5268.81559145428, 5270.077736396192, 5278.577713782888, 4140.0, 4147.854825081107, 4148.668106551469, 4189.6229339359, 4193.559676234013, 3695.9630403696156, 3775.018495191215, 3781.6596506314563, 3807.3527500325013, 3839.9808000959815, 5045.192769156991, 5061.44324124346, 5062.645614807002, 5069.366329208849, 5116.769745361467, 5195.506426889439, 5360.088784906575, 5368.570514358842, 5368.624196306221, 5415.620906536505, 4962.280469331999, 4971.65198436106, 5007.974960125176, 5058.519440653132, 5089.592832573385, 4553.066621342617, 4577.427821522309, 4579.084183163381, 4580.312953057068, 4630.305454181899, 5421.403645598902, 5547.029269877755, 5576.052071147915, 5576.9163462548095, 5586.190002449622, 5300.0, 5310.920336194883, 5344.652597581145, 5368.1679339702405, 5422.213779001943, 5546.833594992157, 5565.777368905198, 5567.805126820542, 5571.66570005801, 5608.158776183605, 5195.92206116901, 5296.655717378358, 5296.682199068068, 5327.121025030981, 5383.057964856056, 5323.680579165262, 5381.13901775714, 5401.86495337604, 5434.864128396664, 5438.918416223839, 5244.632875698664, 5247.8163264287095, 5253.789848406173, 5256.053910296183, 5278.498542638443, 5244.5279924806955, 5254.054270231395, 5256.868578285574, 5266.657667251617, 5318.521333080042, 4983.127952608352, 5130.076586214368, 5141.7686204120155, 5150.639455238097, 5261.894762104813, 5231.3199284092825, 5258.158694608997, 5260.368755749335, 5261.3686357637325, 5264.210368444611, 5110.744462776772, 5154.871128221675, 5171.431142574239, 5179.870503237449, 5219.973900130475], "unit": "score", "name": "dojo.html", "value": 4925.92224648021}, {"lowerIsBetter": false, "replicates": [520.4119345139989, 539.1616037062366, 539.1858293976096, 560.2884336892146, 576.1731914702402, 28081.578776318347, 28630.28424289391, 35464.99999999997, 35807.0, 35877.820610896975, 38603.42094868572, 39166.60833391665, 39173.41239881404, 39196.60803391965, 39251.214975700466, 7083.256258092903, 8307.584620768952, 8497.787555311104, 8551.700690475835, 8564.957175214146, 7525.849483010336, 7687.500312479699, 7692.4999875008225, 10003.149732272766, 10217.0, 9912.553935072903, 9979.550920208572, 9996.750081247954, 9999.650012249573, 10013.799724005552, 9825.017498250189, 9907.157891579225, 9911.603535858558, 9918.107370336667, 9922.107010369029, 9722.9513852431, 9759.512024398822, 9885.555150018266, 9896.90103098967, 9906.306558540906, 39129.41305880385, 39663.0, 39664.20671586552, 39665.80167099146, 39735.0, 3198.9040328789943, 3208.246062175387, 3255.0560337502097, 3262.13553408347, 3604.116991337113, 30030.549541756674, 30134.071713701953, 30235.0, 30523.084307470588, 31160.0, 3930.5479869815053, 3939.606039396066, 3952.8536724349906, 3997.200559888034, 4016.196760647882, 270027.6498617514, 270926.0, 271021.0, 273153.0, 273510.0, 51098.0, 52345.21482177771, 58490.0, 58856.41143588595, 58946.11580826291, 60565.69717151386, 62246.688766555875, 62446.37553624406, 62482.37517624856, 62536.0, 13555.796663050061, 13727.588172354845, 13741.656458588615, 13762.793558096637, 13806.93096534531, 10064.144547713526, 10159.390436573829, 10163.0, 10575.841362379571, 10887.510062047228, 18679.104738765513, 18897.14962826676, 18920.24319027251, 19026.143823527975, 19041.904790475957, 7677.808054798675, 7931.0, 8006.9599652002535, 8057.395695322874, 8058.597070146587, 880.1682410122501, 963.9807203856024, 1003.7841863999275, 1020.9132223760915, 1102.4102105373586, 24323.39191520226, 24698.382540436272, 27940.30149246285, 28774.424511509653, 29050.351943688907, 1006.7030226083323, 1024.7643042100358, 1071.0842229893485, 1102.2229328323513, 1108.174410064491, 12949.0, 12997.09020368584, 13037.934810326078, 13095.214287142802, 13110.606681799562, 265378.0, 267407.0, 267965.0, 268578.0, 269199.0, 47814.76092619584, 48724.75637621789, 48736.75631621819, 48810.755946220044, 48813.75593122012, 1232.8890399864056, 1233.444949772606, 1306.9215847049209, 1326.4163767942075, 1365.6790654196257, 24327.148549800673, 25507.0, 25757.484850302513, 25814.354641134123, 25937.351566210997, 37170.8141459291, 37310.25379492341, 37386.0, 37470.0, 37471.62528374681, 304420.0, 305327.0, 305743.0, 306501.0, 306581.0, 26899.0, 30684.84657576698, 31036.844815775778, 31211.0, 31470.37059258848, 36374.45438318374, 37348.0, 37686.2462750749, 37730.43404348992, 37733.0, 31258.68741312649, 31642.841785790923, 31820.840895795372, 32282.83858580786, 32553.186170345933, 27752.444951101268, 31774.20564485814, 32233.838830805696, 35868.461973069905, 36312.273754524234, 31484.842575786974, 31880.202994925312, 32230.677693222766, 32253.677463225067, 32340.83829580837, 28848.2787930295, 30764.230894227825, 30915.0, 31244.375112498077, 31248.843755781985, 23206.883965580066, 23881.761182387952, 25951.61072583875, 26318.21045368642, 26337.0], "unit": "score", "name": "ext.html", "value": 17682.502765142446}, {"lowerIsBetter": false, "replicates": [366.9798161101139, 369.8095480827374, 371.591249625412, 372.6180664818561, 380.67642503871696, 13699.315034248297, 14252.0, 16203.108829014414, 16761.580960475992, 17439.38962136324, 10085.798284034334, 10457.0, 16050.0, 16432.0, 16456.424025159093, 3748.5126933498746, 4812.0, 4969.031038947407, 4972.03045406146, 4979.651424400294, 3842.2507611015862, 3876.786776727293, 3878.4570160177454, 5322.76047577858, 5536.640118392312, 5405.405405405388, 5550.389457159709, 5553.6390134641115, 5960.821175364725, 5966.910496342558, 5671.51792097668, 5920.5855590108495, 5960.821175364746, 5965.343812180657, 5970.134330522072, 5280.762365693515, 5284.682919024871, 5288.2596436498925, 5298.814541491068, 5310.7610157543, 12189.817152742717, 12580.937095314557, 12628.68428289291, 12632.68418289541, 12634.305113218768, 1876.6238586593342, 1917.2810196176433, 1946.1728765274702, 1966.2135145941595, 1980.742503474539, 12186.57346992851, 12286.078544109138, 12335.5065797368, 12494.312812795293, 12864.421101050475, 1597.9840201597951, 1762.5769815244378, 1810.3754204799322, 1838.512794109562, 1855.4062699936026, 51944.48055519434, 53266.20100698493, 53401.73299133479, 53451.46548534543, 53950.73024634891, 9627.663031793854, 9798.26513011527, 9950.850737238947, 9984.550695218588, 10010.04904534068, 12996.350182490838, 13098.934505327603, 13102.148360356547, 13107.868921310856, 13109.60671179866, 7206.387457066208, 7221.602811845294, 7237.167725711611, 7275.236100209508, 7309.634518274172, 6821.4542836572955, 6827.829304267334, 6873.20958089826, 6906.37842594169, 6918.757843475555, 3894.0, 4109.0549173690215, 4288.292431748789, 4296.505901821268, 4413.073254616566, 1716.0818961855348, 1716.1419290354822, 1731.8874273172203, 1754.921028553718, 1758.5867321179512, 820.885076089348, 941.8304705153138, 951.9809603807885, 957.2963871554402, 996.5814357969671, 15687.764683529756, 16192.433264835674, 16313.12399074098, 16663.25015374311, 16764.0, 849.8809369613533, 853.5646820121783, 877.2674816528142, 899.2131884600974, 911.9863202051974, 8669.739907802776, 8834.911650883538, 8962.507062111516, 9127.722118903359, 9286.814263714688, 472108.0, 475648.0, 476984.0, 504298.0, 536482.0, 42426.78786606047, 43202.13595728131, 64321.67839160774, 65261.67369163124, 68341.65829170922, 1133.2973556395089, 1134.920555561103, 1139.1513322574735, 1172.9589464368705, 1176.8411264479357, 15136.243187840344, 15172.241387930339, 15229.162396068323, 15354.462593809163, 15433.768493472831, 31453.68546314599, 32635.836820815744, 32778.18054548655, 32873.342533149684, 33052.0, 41852.790736046125, 41862.0, 42067.789661052724, 42482.0, 42773.572264278206, 6902.896456553256, 7211.639418029183, 7230.783076507713, 7323.890141647773, 7339.348646554483, 7978.122406535161, 8907.465552066897, 9459.432434053979, 11193.552257909918, 11411.942940285246, 9387.812243755223, 9519.381240219363, 9742.512874356396, 9973.800523989625, 10102.494875256354, 9099.954500227457, 9611.231101512001, 9690.418574885529, 9773.706788796348, 10005.54975026111, 7861.960690196513, 10007.149392301735, 10185.490725463846, 10197.694069177936, 10325.63860264887, 7049.400800931979, 7262.600556969417, 7314.81712957159, 7360.227176146427, 7458.403327733877, 9198.080191980749, 9404.858927116236, 9968.0, 10134.138598219233, 10169.135623472088], "unit": "score", "name": "jquery.html", "value": 7832.885216840593}, {"lowerIsBetter": false, "replicates": [1346.0443085409358, 1468.933897974591, 1476.4168153579333, 1625.4879712890447, 1790.3912669692302, 6952.513324067318, 7136.1793393759735, 7396.889046664291, 7498.362639175663, 7542.5097368670995, 7677.0, 7690.115636701781, 7752.883706744389, 7758.185390533998, 7762.49543779654, 2293.0713061210195, 2304.7349554801162, 2308.6075367187536, 2310.595645761993, 2313.3406979010983, 2249.730032396115, 2263.7962583367494, 2274.1358283852114, 2284.9314520564326, 2286.737025242102, 2290.3129061281634, 2309.8960546775434, 2317.7450480447137, 2339.894704738282, 2343.6953196084487, 2242.394553470554, 2293.0827668932393, 2297.24191016964, 2300.5858945389823, 2302.1251924268754, 2228.8774117423536, 2233.452804062999, 2235.6422972324513, 2236.3626366485637, 2239.115549358011, 7826.960865195694, 7871.724489642892, 7872.291493765589, 7881.763547093597, 7890.447668663196, 4665.276882083249, 4785.234362501983, 4786.162421576245, 4789.904201915977, 4791.065742180276, 3022.2142243016756, 3025.7730670199603, 3124.062781165664, 3136.0, 3152.921176970594, 985.069109691342, 992.1665800727424, 1883.1808163448943, 1891.1111777464569, 1894.7821000584972, 10159.949200254025, 10254.333468324536, 10263.332883362633, 10265.230107741874, 10270.794584108351, 4027.0939038716056, 4122.237386083584, 4181.038361176947, 4181.247375472383, 4187.91624167515, 8441.198086181803, 8453.66185352579, 8460.069392366835, 8465.915340846514, 8470.618822153017, 4765.428148622187, 4809.278608208797, 4810.206315957827, 4814.374131362971, 4815.3499277597775, 3863.9806800965816, 3930.194310166409, 3931.1941052084253, 4433.135538570013, 4445.555444455593, 3349.0790032741193, 3394.9830250848586, 3491.94762078569, 3550.609432962372, 3561.3233485637647, 1076.7361996310954, 1134.4384529657873, 1144.547903578082, 1144.605111236622, 1147.5696613769837, 1042.9791404171874, 1168.2231316174648, 1181.0846593889805, 1181.757739663367, 1225.0689475998126, 7369.8157546061775, 7381.926180738124, 7405.370543503863, 7405.8889116663295, 7408.185099639036, 1188.4651906642046, 1198.1313547677864, 1202.7594481103815, 1229.7294595189044, 1255.1590434408968, 5464.836054918359, 5514.696691681996, 5551.444855514497, 5558.44415558449, 5563.860903477364, 8859.158379953895, 9155.22180614642, 9171.77070573241, 9172.633094676272, 9194.12655797698, 8958.507282099417, 8973.551322433852, 9018.909810901938, 9022.14289642483, 9029.232515236146, 7066.611336376549, 7318.890216646648, 7327.303906128909, 7370.74202402924, 7385.593792341473, 7304.4156467483535, 7335.7432489862595, 7361.1166659999, 7372.815679608053, 7381.741639042608, 8361.95819020901, 8474.1949514796, 8685.869711954452, 8690.478571285743, 8694.478331300143, 8672.0, 8734.56327183651, 8933.865992009994, 8938.910610894069, 8955.641774328953, 7092.148942126978, 7115.466340024415, 7177.533460325062, 7182.604956727221, 7209.0628218331285, 6663.433608143362, 6853.109095817711, 7031.43748500129, 7230.0, 7242.710291588488, 6942.305769423017, 6967.651617419007, 7030.086088808423, 7057.858842823012, 7202.027726256888, 6648.867022659617, 6682.3317668232785, 6753.966230168818, 6788.4569234462115, 6899.724011039502, 7010.0, 7058.188308344606, 7061.470389720895, 7064.894026589503, 7065.682044307916, 6152.323244443018, 6395.136656551306, 6451.41937225652, 6470.38531339522, 6482.481401487964, 6339.0, 6591.967040164768, 6600.207975043026, 6613.338666133348, 6614.107095542233], "unit": "score", "name": "mootools.html", "value": 4512.291533180566}, {"lowerIsBetter": false, "replicates": [334.963154053054, 340.80744379425624, 341.67882190740704, 343.1062083273075, 346.029387567872, 5729.427057294269, 5840.269966254218, 5894.793682221123, 5899.498542623882, 5905.616134951225, 5613.298337707786, 5801.332846722628, 5833.795817146401, 5840.707964601774, 5846.88306233875, 4507.278835386339, 4512.255477846152, 4513.0973805239, 4517.390152329443, 4527.954720452803, 4352.238358287287, 4442.400275962736, 4465.0, 4467.7319360838455, 4513.638908887281, 4419.867403977886, 4437.267850804614, 4494.325851122341, 4499.977500112494, 4500.774961251941, 4478.753668548228, 4481.081378317437, 4484.910301793946, 4488.035072459405, 4501.167284052461, 3979.522457305142, 3982.7012974027066, 3984.163325701606, 3986.043349596105, 3998.2203470323298, 5447.1829225616075, 5471.835844924659, 5494.313210848644, 5528.944710552883, 5541.362743284533, 5238.842834714965, 5239.113918989161, 5242.659227150223, 5244.108501554707, 5244.318238628954, 5937.554683398763, 6180.103884936704, 6182.196314479134, 6192.752289908398, 6203.503719702413, 4283.91432171358, 4341.131773645284, 4423.933640995388, 4426.889327766799, 4436.423264975565, 6500.317466666026, 6502.382273683992, 6511.67441627912, 6518.120053792724, 6519.250286217051, 4546.29532422475, 4552.0, 4553.089382123589, 4555.9772201138785, 4562.08758248345, 4490.910181796411, 4536.818527258939, 4544.045750392388, 4599.701019433726, 4605.470370907322, 5208.7916483341, 5210.811459187151, 5213.244079608436, 5216.139337009351, 5218.739063046833, 6281.120643109968, 6281.59169653971, 6284.905726414107, 6286.339934306832, 6295.622262664255, 1620.1899050474763, 1642.4314779385659, 1644.1368281652228, 1644.399794075154, 1646.9341226350812, 1114.331401159298, 1117.536222467683, 1128.198978725098, 1128.8476055732372, 1157.0512180012477, 5991.730372133265, 5998.700064996733, 6001.279846418371, 6002.459778619946, 6006.279246490449, 6412.61524308543, 6419.101325814389, 6422.4862011039, 6424.839379015562, 6437.0, 5866.442687944638, 5990.460858522754, 5991.310999235144, 5992.910106348409, 5999.220101386792, 3435.7766745161985, 3466.272082862627, 3467.1505481156773, 3468.757186996886, 3469.3928562501965, 6721.764738234138, 6724.159480064992, 6736.966315168393, 6739.663016849138, 6746.0, 6577.473802095821, 6582.17722784652, 6582.63795491243, 6588.637624930675, 6595.769148079794, 6546.443552298013, 6706.5640733352175, 6708.865822683519, 6713.832154196087, 6714.630695311805, 6227.9377206227355, 6380.979043353042, 6398.168238129014, 6399.328070552711, 6411.4870810336, 6291.0, 6434.64609446485, 6454.386833250834, 6471.870562588816, 6473.320301368289, 6780.084688567177, 6783.559068660521, 6785.389314961677, 6787.287334829772, 6797.456203503807, 4474.26174681174, 4502.414686090788, 4502.887427814331, 4503.076869241863, 4510.684252102321, 6408.775692850728, 6416.262129855127, 6460.580062295936, 6468.353164683494, 6473.255575608865, 6235.438810507076, 6305.369463053841, 6312.715927783169, 6315.084312774714, 6320.810375688737, 6203.710639997894, 6266.561340706106, 6277.15258440123, 6310.242770867341, 6326.398992095744, 6171.1668924694595, 6171.382861713792, 6182.103594978793, 6182.845428864314, 6189.535784816067, 6323.715432805443, 6324.209473815773, 6325.841853953688, 6327.715252813542, 6331.9366806331345, 6042.577019608585, 6128.601640893327, 6146.815595531963, 6152.969235153795, 6161.260648722003], "unit": "score", "name": "prototype.html", "value": 4739.7924644276745}, {"lowerIsBetter": false, "replicates": [786.5162924801247, 794.9801254968627, 810.6919370639156, 835.3233880556745, 843.3548335523321, 12687.873121268785, 12841.678958026054, 12842.22946623202, 12857.0, 12890.226586404799, 11836.644900652995, 11839.526418943253, 11856.881431185686, 11865.228760130585, 11895.464704088316, 652.6671397587218, 656.940875321221, 772.8029352515101, 776.0532150776044, 779.672537534237, 783.1189911349732, 784.8155683414393, 787.208855100623, 787.3268355556003, 788.5662885413028, 831.1729828820332, 831.6714897615439, 831.8585840407115, 833.0128797375099, 836.0719601242616, 667.4093427316835, 679.8300424893802, 819.8237378963491, 830.2195935820309, 835.6949713354643, 613.3774219167549, 616.8396216983616, 621.7202258983431, 622.0078974036404, 622.1507642068544, 11701.3564253966, 11723.589674361441, 11746.765064698744, 11795.115366347558, 11883.762324753456, 11947.402629868559, 12650.746985060247, 12702.936485317607, 12927.159734617313, 13064.86935130646, 10098.545565449573, 10126.949365253127, 10141.847872281922, 10194.59221631134, 10455.94772026135, 3541.8229088545468, 3564.590072141711, 3626.673599376069, 3629.1834337274167, 3737.5514938207316, 43246.78376608128, 43361.0, 43811.342829857575, 43857.34213986793, 44416.55583444156, 9595.28035397348, 9893.862205846275, 9918.851217231748, 9952.651657191964, 9964.252681048805, 16398.426055088014, 16549.50351489457, 16555.834441655672, 16557.751633725504, 16563.08903010346, 7671.846563068819, 7711.305982461606, 7775.066991961001, 7833.686652533949, 7964.123946365895, 4287.807048682755, 4332.956670433318, 4432.689711720213, 4481.551844815493, 4498.415206023196, 3078.338157296192, 3121.3913286909287, 3134.326119884236, 3138.0115263691864, 3142.245860993345, 574.6236215278915, 583.5914859598298, 594.0524862843757, 607.1227076873963, 611.0742225528328, 620.9689515524205, 631.6797892404895, 639.9264084630234, 661.4311691944923, 675.3246753246754, 7649.541027538366, 7666.769996900102, 8103.0681471631515, 9069.59186836594, 9100.0, 494.37461611062037, 523.4791382574363, 562.8789810190829, 641.1408712325506, 691.2914262880588, 3523.365794157025, 3689.5203623529305, 3747.775133491999, 3783.9243215135543, 3900.297946369624, 52161.0, 52241.0, 52435.0, 53161.468385316424, 53274.20088698673, 49190.262146067835, 49525.50474495281, 49721.0, 49724.254136187985, 50380.0, 20982.37052888416, 21072.473188170112, 21127.154913803584, 38755.61244387576, 43207.35188972231, 7402.222766609644, 7578.242175782378, 7641.617919103911, 7743.0090223841535, 7745.302922736981, 31940.84029579837, 32531.83734081409, 32533.511997320533, 32618.51072233871, 32619.510707339883, 39258.803705981285, 39334.40998385084, 40969.59030409658, 42638.36042459303, 43111.56888431201, 9933.503324833873, 9939.701808945743, 10033.598656053968, 10035.24735644844, 10063.899361006297, 10915.781684366428, 10970.561177553127, 11150.944245278723, 11280.548778048786, 11340.175457770141, 9984.650537231162, 10130.8480372793, 10279.074883260542, 10296.433696146783, 10758.892411075789, 10011.749706257402, 10085.798284034132, 10452.843207352047, 10481.528331225265, 10820.513076911715, 10247.38515689061, 10308.501514498117, 10348.430836304076, 10470.738231543968, 10486.842697359698, 8659.567021649018, 8713.390062695804, 8834.204921557091, 8940.73177804667, 8943.776405589912, 8771.122887711177, 8866.290696744374, 10065.892188209053, 10081.312189831764, 10241.231907607109], "unit": "score", "name": "yui.html", "value": 5927.122484369782}], "name": "dromaeo_css", "value": 6650.155749304684}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 110.0, 110.0, 111.0, 99.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [156.0, 126.0, 148.0, 169.0, 129.0, 152.0, 150.0, 127.0, 169.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 160.0, 163.0, 163.0, 160.0, 161.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 89.0, 93.0, 72.0, 72.0, 73.0, 100.0, 94.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 140.0, 95.0, 96.0, 98.0, 150.0, 95.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 60.0, 56.0, 55.0, 56.0, 55.0, 65.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 86.0, 87.0, 86.0, 85.0, 93.0, 94.0, 89.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 127.0, 113.0, 128.0, 116.0, 114.0, 127.0, 118.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [142.0, 142.0, 157.0, 155.0, 150.0, 142.0, 150.0, 150.0, 151.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 66.0, 66.0, 66.0, 68.0, 67.0, 68.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1503.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9727834362999], "unit": "score", "name": "Richards", "value": 211.42367800000002}, {"lowerIsBetter": false, "replicates": [191.05846388995033], "unit": "score", "name": "DeltaBlue", "value": 346.061612}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [2049.1803278688526], "unit": "score", "name": "RayTrace", "value": 361.1146319999999}, {"lowerIsBetter": false, "replicates": [798.7220447284345], "unit": "score", "name": "Earley", "value": 834.4116759999996}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [42208.333333333336], "unit": "score", "name": "RegExp", "value": 21.583060217176715}, {"lowerIsBetter": false, "replicates": [617.283950617284], "unit": "score", "name": "Splay", "value": 132.01541999999998}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 18757.14168798605}]} 23:33:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18757.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1503.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6650.15"}}} 23:33:44 INFO - Return code: 0 23:33:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:33:44 INFO - # TBPL SUCCESS # 23:33:44 INFO - Running post-action listener: _resource_record_post_action 23:33:44 INFO - Running post-run listener: _resource_record_post_run 23:33:45 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 424960000; Read time: 0; Write time: 262700 23:33:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 112476160; Read time: 0; Write time: 69892 23:33:45 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 312483840; Read time: 0; Write time: 192808 23:33:45 INFO - Running post-run listener: _upload_blobber_files 23:33:45 INFO - Blob upload gear active. 23:33:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:33:45 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 23:33:45 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'] 23:33:45 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 23:33:45 INFO - (blobuploader) - INFO - Open directory for files ... 23:33:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:33:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:33:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:33:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:33:46 INFO - (blobuploader) - INFO - Done attempting. 23:33:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:33:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:33:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:33:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:33:47 INFO - (blobuploader) - INFO - Done attempting. 23:33:47 INFO - (blobuploader) - INFO - Iteration through files over. 23:33:47 INFO - Return code: 0 23:33:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:33:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:33:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4caab16b4cbd572750149bb4dd3b964a1bf3872c5eeebd8df1ed7dccb411b518d83e31e7cdd18e86d6b48ae933115983d4e366b7cb61c0a62a7f4f16237688a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/52b6281934f01e1c772e2b721f1f758d7930b83187af94a334eefe71e694833f8606d0c3e7d8eb54a2bcc12599c81ebf1ede8f65307b7181648673529fc7b68c"} 23:33:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:33:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:33:47 INFO - Contents: 23:33:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4caab16b4cbd572750149bb4dd3b964a1bf3872c5eeebd8df1ed7dccb411b518d83e31e7cdd18e86d6b48ae933115983d4e366b7cb61c0a62a7f4f16237688a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/52b6281934f01e1c772e2b721f1f758d7930b83187af94a334eefe71e694833f8606d0c3e7d8eb54a2bcc12599c81ebf1ede8f65307b7181648673529fc7b68c"} 23:33:47 INFO - Copying logs to upload dir... 23:33:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1280.874789 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-11 23:33:47.287742) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 23:33:47.291609) ========= 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=6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485 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/4caab16b4cbd572750149bb4dd3b964a1bf3872c5eeebd8df1ed7dccb411b518d83e31e7cdd18e86d6b48ae933115983d4e366b7cb61c0a62a7f4f16237688a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/52b6281934f01e1c772e2b721f1f758d7930b83187af94a334eefe71e694833f8606d0c3e7d8eb54a2bcc12599c81ebf1ede8f65307b7181648673529fc7b68c"} build_url:https://queue.taskcluster.net/v1/task/CO7GXs1-TiiNqGeozEmcYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011525 build_url: 'https://queue.taskcluster.net/v1/task/CO7GXs1-TiiNqGeozEmcYw/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/4caab16b4cbd572750149bb4dd3b964a1bf3872c5eeebd8df1ed7dccb411b518d83e31e7cdd18e86d6b48ae933115983d4e366b7cb61c0a62a7f4f16237688a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/52b6281934f01e1c772e2b721f1f758d7930b83187af94a334eefe71e694833f8606d0c3e7d8eb54a2bcc12599c81ebf1ede8f65307b7181648673529fc7b68c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 23:33:47.317058) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 23:33:47.317414) ========= 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=6dbc10da6d83fee962c624be000001a8-1452582444.785365-741429485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004654 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 23:33:47.402825) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 23:33:47.403155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 23:33:47.403450) ========= ========= Total master_lag: 0.23 =========